SVI/netbird
1
0
Fork 0
mirror of https://github.com/netbirdio/netbird.git synced 2026-05-18 06:02:14 -04:00
Code Issues 3.0k Packages Projects Releases 10 Wiki Activity

Enable QUIC Protocol on Relay Server #1846

New Issue
Closed
opened 2025-11-20 06:07:52 -05:00 by saavagebueno · 4 comments
saavagebueno commented 2025-11-20 06:07:52 -05:00
Owner
Copy Link

Originally created by @joepa37 on GitHub (Apr 27, 2025).

QUIC Protocol is not working, All peers are being connected using the WS.

relay_1       | 2025-04-27T18:25:00Z INFO relay/server/listener/quic/listener.go:37: QUIC server listening on address: 0.0.0.0:8012
relay_1       | 2025-04-27T18:25:00Z INFO relay/server/listener/ws/listener.go:39: WS server listening address: 0.0.0.0:8012
relay_1       | 2025-04-27T18:25:05Z INFO relay/server/listener/ws/listener.go:91: WS client connected from: 10.10.0.2:33622
relay_1       | 2025-04-27T18:25:05Z INFO [peer_id: sha-REDACTED] relay/server/relay.go:129: peer connected from: 10.10.0.2:33622

2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:170: connecting to relay server
2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:64: dialing Relay server via quic
2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:64: dialing Relay server via WS
2025-04-27T13:10:48-06:00 DEBG util/net/dialer_dial.go:52: Dialing tcp net.anon-hJs8j.domain:8012
2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:89: successfully dialed via: WS
2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:75: connection attempt aborted via: quic

Self Hosted Server Details:

docker-compose.yml 
# Relay
...
  relay:
    image: netbirdio/relay:latest
    restart: unless-stopped
    environment:
    - NB_LOG_LEVEL=trace
    - NB_LISTEN_ADDRESS=0.0.0.0:8012
    - NB_QUIC_LISTEN_ADDRESS=0.0.0.0:8012
    - NB_EXPOSED_ADDRESS=rels://net.mydomain.com:8012
    # todo: change to a secure secret
    - NB_AUTH_SECRET=REDACTED
    - NB_TLS_CERT_FILE=/etc/netbird/certs/fullchain.pem
    - NB_TLS_KEY_FILE=/etc/netbird/certs/privkey.pem
    ports:
      - "8012:8012/tcp"
      - "8012:8012/udp"
    volumes:
      # - ./data/relay:/var/lib/netbird
      - /etc/letsencrypt/live/net.mydomain.com/fullchain.pem:/etc/netbird/certs/fullchain.pem:ro
      - /etc/letsencrypt/live/net.mydomain.com/privkey.pem:/etc/netbird/certs/privkey.pem:ro
    logging:
      driver: "json-file"
      options:
        max-size: "500m"
        max-file: "2"
...
management.json 
...
"Relay": {
      "Addresses": [
          "rels://net.mydomain.com:8012"
      ],
      "CredentialsTTL": "24h0m0s",
      "Secret": "REDACTED"
  },
...
docker-compose logs -f relay 
relay_1       | 2025-04-27T18:25:00Z DEBG relay/cmd/root.go:199: using file based TLS config
relay_1       | 2025-04-27T18:25:00Z INFO relay/cmd/root.go:124: running metrics server: :9090/metrics
relay_1       | 2025-04-27T18:25:00Z INFO relay/cmd/root.go:149: server will be available on: rels://net.mydomain.com:8012
relay_1       | 2025-04-27T18:25:00Z INFO relay/server/listener/quic/listener.go:37: QUIC server listening on address: 0.0.0.0:8012
relay_1       | 2025-04-27T18:25:00Z INFO relay/server/listener/ws/listener.go:39: WS server listening address: 0.0.0.0:8012
relay_1       | 2025-04-27T18:25:05Z INFO relay/server/listener/ws/listener.go:91: WS client connected from: 10.10.0.2:33622
relay_1       | 2025-04-27T18:25:05Z INFO [peer_id: sha-REDACTED] relay/server/relay.go:129: peer connected from: 10.10.0.2:33622
relay_1       | 2025-04-27T18:32:29Z INFO relay/server/listener/ws/listener.go:91: WS client connected from: 186.2.x.x:21470
relay_1       | 2025-04-27T18:32:29Z INFO [peer_id: sha-REDACTED] relay/server/relay.go:129: peer connected from: 186.2.x.x:21470
relay_1       | 2025-04-27T18:32:29Z INFO relay/server/listener/ws/listener.go:91: WS client connected from: 129.153.71.250:56782
relay_1       | 2025-04-27T18:32:29Z INFO [peer_id: sha-REDACTED] relay/server/relay.go:129: peer connected from: 129.153.x.x:56782

Peer Client Details:

netbird status -dA 
Peers detail:
 desktop-ntsjcrh.anon-qLFLS.domain:
  NetBird IP: 100.71.94.24
  Public key: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=
  Status: Connected
  -- detail --
  Connection type: P2P
  ICE candidate (Local/Remote): host/prflx
  ICE candidate endpoints (Local/Remote): 172.23.27.32:38669/172.23.16.1:60766
  Relay server address: rels://net.anon-Opeoe.domain:8012
  Last connection update: 3 seconds ago
  Last WireGuard handshake: 4 seconds ago
  Transfer status (received/sent) 92 B/180 B
  Quantum resistance: false
  Networks: -
  Latency: 2.087757ms

 edge.anon-qLFLS.domain:
  NetBird IP: 100.71.211.147
  Public key: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=
  Status: Connected
  -- detail --
  Connection type: Relayed
  ICE candidate (Local/Remote): -/-
  ICE candidate endpoints (Local/Remote): -/-
  Relay server address: rels://net.anon-Opeoe.domain:8012
  Last connection update: 4 seconds ago
  Last WireGuard handshake: 4 seconds ago
  Transfer status (received/sent) 92 B/180 B
  Quantum resistance: false
  Networks: -
  Latency: 0s

 build-phx1-ad1.anon-qLFLS.domain:
  NetBird IP: 100.71.249.36
  Public key: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=
  Status: Connected
  -- detail --
  Connection type: Relayed
  ICE candidate (Local/Remote): -/-
  ICE candidate endpoints (Local/Remote): -/-
  Relay server address: rels://net.anon-Opeoe.domain:8012
  Last connection update: 4 seconds ago
  Last WireGuard handshake: 4 seconds ago
  Transfer status (received/sent) 92 B/180 B
  Quantum resistance: false
  Networks: -
  Latency: 0s

Events:
  [WARNING] DNS (3ec4975b-ce98-43d8-8302-147bdf5367bb)
    Message: The host dns manager does not support match domains
    Time: 1 hour, 11 minutes ago
    Metadata: manager: file
  [INFO] SYSTEM (c4f790b9-a7e5-4cb6-985f-33aee9fd71dc)
    Message: Network map updated
    Time: 1 hour, 11 minutes ago
  [WARNING] DNS (e2236fff-8432-4a80-bc64-5099c471b923)
    Message: The host dns manager does not support match domains
    Time: 47 minutes, 47 seconds ago
    Metadata: manager: file
  [INFO] SYSTEM (8424406a-53e3-48a8-8b70-c44ab1363b02)
    Message: Network map updated
    Time: 47 minutes, 47 seconds ago
  [WARNING] DNS (394a9561-bd59-43b6-9915-515da8f7dff0)
    Message: The host dns manager does not support match domains
    Time: 28 minutes, 38 seconds ago
    Metadata: manager: file
  [INFO] SYSTEM (28aee056-a9eb-41f9-acce-52f6e4dee920)
    Message: Network map updated
    Time: 28 minutes, 38 seconds ago
  [WARNING] DNS (55f401f8-9d00-405d-a206-d8e7afe97c27)
    Message: The host dns manager does not support match domains
    Time: 20 minutes, 31 seconds ago
    Metadata: manager: file
  [INFO] SYSTEM (09dec02f-efb1-4b2d-ba6e-de5cd59f23a8)
    Message: Network map updated
    Time: 20 minutes, 31 seconds ago
  [WARNING] DNS (8c669d4e-5772-4edc-9dda-8a0011c107f9)
    Message: The host dns manager does not support match domains
    Time: 4 seconds ago
    Metadata: manager: file
  [INFO] SYSTEM (43b51c21-5c67-4242-8d21-ec65ead69a8a)
    Message: Network map updated
    Time: 4 seconds ago
OS: linux/amd64
Daemon version: 0.43.0
CLI version: 0.43.0
Management: Connected to https://net.anon-Opeoe.domain:443
Signal: Connected to https://net.anon-Opeoe.domain:443
Relays:
  [stun:relay.anon-Opeoe.domain:3478] is Available
  [turn:relay.anon-Opeoe.domain:3478?transport=udp] is Available
  [rels://net.anon-Opeoe.domain:8012] is Available
Nameservers:
FQDN: desktop-ntsjcrh-1.anon-qLFLS.domain
NetBird IP: 100.71.200.176/16
Interface type: Kernel
Quantum resistance: false
Networks: -
Forwarding rules: 0
Peers count: 3/3 Connected
client.log 
2025-04-27T13:10:46-06:00 DEBG client/internal/engine.go:1403: removing Netbird interface wt0
2025-04-27T13:10:46-06:00 DEBG client/iface/wgproxy/ebpf/proxy.go:113: free up ebpf wg proxy
2025-04-27T13:10:46-06:00 DEBG client/internal/ebpf/ebpf/wg_proxy_linux.go:39: free ebpf WG proxy
2025-04-27T13:10:46-06:00 DEBG client/internal/ebpf/ebpf/manager_linux.go:107: detach ebpf program
2025-04-27T13:10:46-06:00 ERRO client/iface/bind/udp_mux_universal.go:97: error while reading packet: shared socked stopped
2025-04-27T13:10:46-06:00 DEBG client/iface/bind/udp_mux_universal.go:92: stopped reading from the UDPConn due to finished context
2025-04-27T13:10:46-06:00 INFO client/iface/iface.go:229: interface wt0 has been removed
2025-04-27T13:10:46-06:00 INFO client/internal/engine.go:320: stopped Netbird Engine
2025-04-27T13:10:46-06:00 DEBG client/internal/statemanager/manager.go:286: persisted states: [nftables_state], took 894.81µs
2025-04-27T13:10:46-06:00 INFO client/server/server.go:666: service is down
2025-04-27T13:10:46-06:00 INFO client/internal/connect.go:305: stopped NetBird client
2025-04-27T13:10:46-06:00 WARN client/internal/connect.go:189: failed to close the Management service client rpc error: code = Canceled desc = grpc: the client connection is closing
2025-04-27T13:10:46-06:00 TRAC client/server/server.go:208: client connection exited
2025-04-27T13:10:46-06:00 TRAC client/server/server.go:216: retry canceled
2025-04-27T13:10:47-06:00 DEBG client/internal/engine.go:1709: Network map persistence is set to true
2025-04-27T13:10:47-06:00 TRAC client/server/server.go:190: running client connection
2025-04-27T13:10:47-06:00 INFO client/internal/connect.go:122: starting NetBird client version 0.43.0 on linux/amd64
2025-04-27T13:10:47-06:00 DEBG util/net/dialer_dial.go:52: Dialing udp 127.0.0.1:9
2025-04-27T13:10:47-06:00 INFO util/net/env_linux.go:70: system supports advanced routing
2025-04-27T13:10:47-06:00 DEBG client/internal/connect.go:178: connecting to the Management service net.anon-hJs8j.domain:443
2025-04-27T13:10:47-06:00 DEBG util/net/dialer_dial.go:52: Dialing tcp net.anon-hJs8j.domain:443
2025-04-27T13:10:48-06:00 DEBG client/internal/connect.go:186: connected to the Management service net.anon-hJs8j.domain:443
2025-04-27T13:10:48-06:00 DEBG util/net/dialer_dial.go:52: Dialing tcp net.anon-hJs8j.domain:443
2025-04-27T13:10:48-06:00 DEBG signal/client/grpc.go:83: connected to Signal Service: net.anon-hJs8j.domain:443
2025-04-27T13:10:48-06:00 INFO client/internal/connect.go:255: connecting to the Relay service(s): rels://net.anon-hJs8j.domain:8012
2025-04-27T13:10:48-06:00 DEBG relay/client/manager.go:109: starting relay client manager with [rels://net.anon-hJs8j.domain:8012] relay servers
2025-04-27T13:10:48-06:00 DEBG relay/client/picker.go:45: pick server from list: [rels://net.anon-hJs8j.domain:8012]
2025-04-27T13:10:48-06:00 INFO relay/client/picker.go:72: try to connecting to relay server: rels://net.anon-hJs8j.domain:8012
2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:164: create new relay connection: local peerID: ZLysIiXkFMUpuD/jYt+gd6GkqJk+WKjWxOUtNj9dOG4=, local peer hashedID: sha-xcPvkBPb4ISTktKXM2epswPQjdKEQ4XBerxdRi38crw=
2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:170: connecting to relay server
2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:64: dialing Relay server via quic
2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:64: dialing Relay server via WS
2025-04-27T13:10:48-06:00 DEBG util/net/dialer_dial.go:52: Dialing tcp net.anon-hJs8j.domain:8012
2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:89: successfully dialed via: WS
2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:75: connection attempt aborted via: quic
2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:186: relay connection established
2025-04-27T13:10:49-06:00 INFO relay/client/picker.go:90: connected to Relay server: rels://net.anon-hJs8j.domain:8012
2025-04-27T13:10:49-06:00 INFO relay/client/picker.go:64: chosen home Relay server: rels://net.anon-hJs8j.domain:8012
2025-04-27T13:10:49-06:00 INFO client/internal/connect.go:459: using 60026 as wireguard port: 51820 is in use
2025-04-27T13:10:49-06:00 DEBG client/internal/engine.go:1709: Network map persistence is set to true
2025-04-27T13:10:49-06:00 DEBG client/iface/wgproxy/ebpf/proxy.go:47: instantiate ebpf proxy
2025-04-27T13:10:49-06:00 DEBG client/internal/ebpf/ebpf/wg_proxy_linux.go:11: load ebpf WG proxy
2025-04-27T13:10:49-06:00 INFO client/iface/wgproxy/ebpf/proxy.go:91: local wg proxy listening on: 3128
2025-04-27T13:10:49-06:00 INFO client/iface/wgproxy/factory_kernel.go:29: WireGuard Proxy Factory will produce eBPF proxy
2025-04-27T13:10:49-06:00 DEBG client/internal/dns/service_listener.go:108: registering dns handler for pattern: .
2025-04-27T13:10:49-06:00 DEBG client/internal/statemanager/manager.go:378: loaded state: routeselector_state
2025-04-27T13:10:49-06:00 DEBG client/internal/routemanager/sysctl/sysctl_linux.go:87: Set sysctl net.ipv4.conf.all.src_valid_mark from 0 to 1
2025-04-27T13:10:49-06:00 INFO client/internal/routemanager/manager.go:193: Routing setup complete
2025-04-27T13:10:49-06:00 DEBG client/iface/device/wg_link_linux.go:65: adding device: wt0
2025-04-27T13:10:49-06:00 DEBG client/iface/device/wg_link_linux.go:115: adding address 100.71.200.176/16 to interface: wt0
2025-04-27T13:10:49-06:00 DEBG client/iface/device/device_kernel_unix.go:66: setting MTU: 1280 interface: wt0
2025-04-27T13:10:49-06:00 DEBG client/iface/configurer/kernel_unix.go:26: adding Wireguard private key
2025-04-27T13:10:49-06:00 INFO client/firewall/create_linux.go:73: creating an nftables firewall manager
2025-04-27T13:10:49-06:00 WARN client/firewall/nftables/router_linux.go:87: table 'filter' not found for forward rules
2025-04-27T13:10:49-06:00 DEBG client/firewall/nftables/router_linux.go:849: table 'filter' not found for forward rules, skipping accept rules
2025-04-27T13:10:49-06:00 DEBG client/iface/device/device_kernel_unix.go:90: bringing up interface: wt0
2025-04-27T13:10:49-06:00 DEBG client/internal/statemanager/manager.go:286: persisted states: [nftables_state], took 638.979µs
2025-04-27T13:10:49-06:00 DEBG client/iface/device/device_kernel_unix.go:113: device is ready to use: wt0
2025-04-27T13:10:49-06:00 INFO client/internal/dns/host_unix.go:54: System DNS manager discovered: file
2025-04-27T13:10:49-06:00 DEBG signal/client/grpc.go:128: signal connection state READY
2025-04-27T13:10:49-06:00 INFO client/internal/peer/guard/sr_watcher.go:106: reconnected to Signal or Relay server
2025-04-27T13:10:49-06:00 INFO signal/client/grpc.go:149: connected to the Signal Service stream
2025-04-27T13:10:49-06:00 DEBG client/internal/engine.go:899: connecting to Management Service updates stream
2025-04-27T13:10:49-06:00 INFO client/internal/engine.go:1650: Network monitor is disabled, not starting
2025-04-27T13:10:49-06:00 INFO client/internal/connect.go:281: Netbird engine started, the IP is: 100.71.200.176/16
2025-04-27T13:10:49-06:00 DEBG management/client/grpc.go:115: management connection state READY
2025-04-27T13:10:49-06:00 INFO management/client/grpc.go:162: connected to the Management Service stream
2025-04-27T13:10:50-06:00 DEBG management/client/grpc.go:259: got an update message from Management Service
2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:925: got TURNs update from Management Service, updating
2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:907: got STUNs update from Management Service, updating
2025-04-27T13:10:50-06:00 INFO relay/client/manager.go:223: update relay server URLs: [rels://net.anon-hJs8j.domain:8012]
2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:684: network map persisted with serial 4
2025-04-27T13:10:50-06:00 WARN client/internal/engine.go:785: running SSH server is not permitted
2025-04-27T13:10:50-06:00 DEBG client/firewall/nftables/acl_linux.go:647: failed to flush nftables: conn.Receive: netlink receive: no such file or directory
2025-04-27T13:10:50-06:00 ERRO client/internal/acl/manager.go:91: failed to flush firewall rules: conn.Receive: netlink receive: no such file or directory
2025-04-27T13:10:50-06:00 INFO client/internal/acl/manager.go:67: ACL rules processed in: 248.710779ms, total rules count: 1
2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:983: got peers update from Management Service, total peers to connect to = 3
2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:1219: creating peer connection UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:185: open connection to peer
2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:1219: creating peer connection 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=
2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:185: open connection to peer
2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:1219: creating peer connection NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=
2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:185: open connection to peer
2025-04-27T13:10:50-06:00 DEBG client/internal/dns.go:110: added reverse DNS zone: 71.100.anon-4AoHQ.domain. with 4 records
2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:50-06:00 DEBG client/internal/dns/service_listener.go:69: starting dns on 100.71.200.176:53
2025-04-27T13:10:50-06:00 DEBG client/internal/dns/server.go:213: registering handler local resolver [0 records] with priority 50
2025-04-27T13:10:50-06:00 DEBG client/internal/dns/handler_chain.go:86: adding handler pattern: domain=anon-Lu0W9.domain. original: domain=anon-Lu0W9.domain. wildcard=false match_subdomain=true priority=50
2025-04-27T13:10:50-06:00 DEBG client/internal/dns/server.go:213: registering handler local resolver [0 records] with priority 50
2025-04-27T13:10:50-06:00 DEBG client/internal/dns/handler_chain.go:86: adding handler pattern: domain=71.100.anon-4AoHQ.domain. original: domain=71.100.anon-4AoHQ.domain. wildcard=false match_subdomain=true priority=50
2025-04-27T13:10:50-06:00 DEBG client/internal/dns/server.go:494: extra match domains: map[]
2025-04-27T13:10:50-06:00 ERRO client/internal/dns/server.go:497: failed to apply DNS host manager update: unable to configure DNS for this peer using file manager without a nameserver group with all domains configured
2025-04-27T13:10:50-06:00 DEBG client/internal/peer/status.go:979: event published: id:"249d8b8a-a84c-4f3f-818a-d91a0ec7d2cc"  severity:WARNING  category:DNS  message:"The host dns manager does not support match domains"  userMessage:"The host dns manager does not support match domains without a catch-all nameserver group."  timestamp:{seconds:1745781050  nanos:334060468}  metadata:{key:"manager"  value:"file"}
2025-04-27T13:10:50-06:00 DEBG client/internal/peer/status.go:979: event published: id:"82bf33ad-5bfb-4b9d-aad8-e477bf3bc61b"  category:SYSTEM  message:"Network map updated"  timestamp:{seconds:1745781050  nanos:334393309}
2025-04-27T13:10:50-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:301: OnRemoteOffer, on status ICE: Disconnected, status Relay: Disconnected
2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:170: sending answer
2025-04-27T13:10:50-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: None, status ICE: Disconnected, status relay: Disconnected
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:125: OnRemoteAnswer skipping message because is not ready
2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 60766
2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:97: recreate ICE agent
2025-04-27T13:10:50-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=
2025-04-27T13:10:50-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:214: open connection to peer: sha-cEF9wzAkwN0Tt69OazEvlS3cirJaswq4XaYAuggZ1Jw=
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_relay.go:86: peer conn opened via Relay: rels://net.anon-hJs8j.domain:8012
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:465: Relay connection has been established, setup the WireGuard
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:736: setup proxied WireGuard connection
2025-04-27T13:10:50-06:00 INFO client/iface/wgproxy/ebpf/proxy.go:102: turn conn added to wg proxy store: rels://net.anon-hJs8j.domain:8012, endpoint port: :1
2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:474: created new wgProxy for relay connection: 127.0.0.1:1
2025-04-27T13:10:50-06:00 DEBG client/iface/iface.go:120: updating interface wt0 peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=, endpoint 127.0.0.1:1
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:108: gather candidates
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:118: turn agent dial
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/wg_watcher.go:48: enable WireGuard watcher
2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/wg_watcher.go:87: WireGuard watcher started
2025-04-27T13:10:50-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=]
2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: None, status ICE: Disconnected, status relay: Disconnected
2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437
2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:97: recreate ICE agent
2025-04-27T13:10:50-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=
2025-04-27T13:10:50-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:214: open connection to peer: sha-EZtla+PO+m2Qtigeaz3fKeC5Cjnj8L2voN4XE7s64RQ=
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:86: peer conn opened via Relay: rels://net.anon-hJs8j.domain:8012
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:465: Relay connection has been established, setup the WireGuard
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:736: setup proxied WireGuard connection
2025-04-27T13:10:50-06:00 INFO client/iface/wgproxy/ebpf/proxy.go:102: turn conn added to wg proxy store: rels://net.anon-hJs8j.domain:8012, endpoint port: :2
2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:474: created new wgProxy for relay connection: 127.0.0.1:2
2025-04-27T13:10:50-06:00 DEBG client/iface/iface.go:120: updating interface wt0 peer 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=, endpoint 127.0.0.1:2
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:108: gather candidates
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:118: turn agent dial
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/wg_watcher.go:48: enable WireGuard watcher
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026
2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/wg_watcher.go:87: WireGuard watcher started
2025-04-27T13:10:50-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: None, status ICE: Disconnected, status relay: Disconnected
2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930
2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:97: recreate ICE agent
2025-04-27T13:10:50-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=
2025-04-27T13:10:50-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:214: open connection to peer: sha-2QMPzEP0DRcWkA7Mmiy5HEXzo3ZrsTTskGV2hqPUL9A=
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:86: peer conn opened via Relay: rels://net.anon-hJs8j.domain:8012
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:465: Relay connection has been established, setup the WireGuard
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:736: setup proxied WireGuard connection
2025-04-27T13:10:50-06:00 INFO client/iface/wgproxy/ebpf/proxy.go:102: turn conn added to wg proxy store: rels://net.anon-hJs8j.domain:8012, endpoint port: :3
2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:474: created new wgProxy for relay connection: 127.0.0.1:3
2025-04-27T13:10:50-06:00 DEBG client/iface/iface.go:120: updating interface wt0 peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=, endpoint 127.0.0.1:3
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:108: gather candidates
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:118: turn agent dial
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/wg_watcher.go:48: enable WireGuard watcher
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026
2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/wg_watcher.go:87: WireGuard watcher started
2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:509: start to communicate with peer via relay
2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:509: start to communicate with peer via relay
2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026
2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026
2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026
2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:509: start to communicate with peer via relay
2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 192.168.71.1:60766
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.71.1:60766 for dPTuKleRLBbZVbtZ
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.71.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 172.23.16.1:60766 for dPTuKleRLBbZVbtZ
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 172.23.16.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478
2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 srflx 198.51.100.2:60766 related 0.0.0.0:60766
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 srflx 198.51.100.2:21501 related 0.0.0.0:60766
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 192.168.91.1:60766
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.91.1:60766 for dPTuKleRLBbZVbtZ
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.91.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.2:21501 for dPTuKleRLBbZVbtZ
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.2:21501 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.2:60766 for dPTuKleRLBbZVbtZ
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.2:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478
2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 192.168.233.235:60766
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.233.235:60766 for dPTuKleRLBbZVbtZ
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.233.235:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478
2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 172.28.176.1:60766
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 127.0.0.1:60766
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 172.28.176.1:60766 for dPTuKleRLBbZVbtZ
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 172.28.176.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 127.0.0.1:60766 for dPTuKleRLBbZVbtZ
2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 127.0.0.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478
2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=]
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 172.23.16.1:60766
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:124: agent dial succeeded
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:153: on ICE conn is ready to use
2025-04-27T13:10:51-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:344: set ICE to active connection
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/wg_watcher.go:79: disable WireGuard watcher
2025-04-27T13:10:51-06:00 TRAC client/iface/wgproxy/ebpf/wrapper.go:66: pause proxy reading from: rels://net.anon-hJs8j.domain:8012
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Connected
2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:329: selected candidate pair [local <-> remote] -> [udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026 <-> udp4 prflx 172.23.16.1:60766 related :0], peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=
2025-04-27T13:10:51-06:00 DEBG client/iface/iface.go:120: updating interface wt0 peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=, endpoint 172.23.16.1:60766
2025-04-27T13:10:51-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/wg_watcher.go:111: WireGuard watcher stopped
2025-04-27T13:10:52-06:00 DEBG client/internal/engine.go:1582: signal health check: healthy=true
2025-04-27T13:10:52-06:00 DEBG client/internal/engine.go:1585: management health check: healthy=true
2025-04-27T13:10:52-06:00 DEBG util/net/dialer_dial.go:52: Dialing udp relay.anon-hJs8j.domain:3478
2025-04-27T13:10:53-06:00 DEBG client/internal/relay/relay.go:66: stun probe received address from stun:relay.anon-hJs8j.domain:3478: 198.51.100.2:21460
2025-04-27T13:10:53-06:00 DEBG util/net/listener_listen.go:119: Listener resolved IP for 198.51.anon-EUaGV.domain:3478: 198.51.anon-EUaGV.domain
2025-04-27T13:10:53-06:00 DEBG client/internal/relay/relay.go:158: turn probe relay address from turn:relay.anon-hJs8j.domain:3478?transport=udp: 10.10.0.6:52521
2025-04-27T13:10:53-06:00 DEBG client/internal/engine.go:1597: relay health check: healthy=true
2025-04-27T13:10:53-06:00 DEBG client/internal/engine.go:1612: all health checks completed: healthy=true
2025-04-27T13:10:53-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/guard/guard.go:84: start reconnect loop...
2025-04-27T13:10:53-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/guard/guard.go:84: start reconnect loop...
2025-04-27T13:10:53-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/guard/guard.go:84: start reconnect loop...
2025-04-27T13:10:54-06:00 TRAC [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected
2025-04-27T13:10:54-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:557: send offer to peer
2025-04-27T13:10:54-06:00 TRAC [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected
2025-04-27T13:10:54-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:557: send offer to peer
2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=]
2025-04-27T13:10:54-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected
2025-04-27T13:10:54-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437
2025-04-27T13:10:54-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:54-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:10:54-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer
2025-04-27T13:10:54-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=
2025-04-27T13:10:54-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection
2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:54-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected
2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:54-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930
2025-04-27T13:10:54-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:54-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=
2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection
2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 10.10.0.6:58930
2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer
2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 198.51.100.1:58930
2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 srflx 10.10.0.2:58930 related 0.0.0.0:58930
2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 10.116.0.3:58930
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.10.0.6:58930 for oUgwHAPDudNDkqwH
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.10.0.6:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.10.0.2:58930 for oUgwHAPDudNDkqwH
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.10.0.2:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.1:58930 for oUgwHAPDudNDkqwH
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.1:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.116.0.3:58930 for oUgwHAPDudNDkqwH
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.116.0.3:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp
2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 10.40.0.1:58930
2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 10.42.12.0:58930
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.40.0.1:58930 for oUgwHAPDudNDkqwH
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.40.0.1:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.42.12.0:58930 for oUgwHAPDudNDkqwH
2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.42.12.0:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp
2025-04-27T13:10:56-06:00 TRAC [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected
2025-04-27T13:10:56-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:557: send offer to peer
2025-04-27T13:10:56-06:00 TRAC [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected
2025-04-27T13:10:56-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:557: send offer to peer
2025-04-27T13:10:56-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=]
2025-04-27T13:10:56-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected
2025-04-27T13:10:56-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437
2025-04-27T13:10:56-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:56-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:10:56-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer
2025-04-27T13:10:56-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=
2025-04-27T13:10:56-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection
2025-04-27T13:10:56-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:56-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected
2025-04-27T13:10:56-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930
2025-04-27T13:10:56-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:56-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:10:56-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer
2025-04-27T13:10:56-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=
2025-04-27T13:10:56-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection
2025-04-27T13:10:59-06:00 TRAC [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected
2025-04-27T13:10:59-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:557: send offer to peer
2025-04-27T13:10:59-06:00 TRAC [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected
2025-04-27T13:10:59-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:557: send offer to peer
2025-04-27T13:10:59-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:10:59-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected
2025-04-27T13:10:59-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930
2025-04-27T13:10:59-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:59-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:10:59-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer
2025-04-27T13:10:59-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=
2025-04-27T13:10:59-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection
2025-04-27T13:10:59-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=]
2025-04-27T13:10:59-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected
2025-04-27T13:10:59-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437
2025-04-27T13:10:59-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:10:59-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=
2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection
2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer
2025-04-27T13:10:59-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=]
2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= -> udp4 host 10.0.0.58:35437
2025-04-27T13:10:59-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.0.0.58:35437 for udfEnYczCYANHmMF
2025-04-27T13:10:59-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.0.0.58:35437 for udfEnYczCYANHmMFturn:relay.anon-hJs8j.domain:3478?transport=udp
2025-04-27T13:10:59-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=]
2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= -> udp4 srflx 198.51.100.3:35437 related 0.0.0.0:35437
2025-04-27T13:10:59-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.3:35437 for udfEnYczCYANHmMF
2025-04-27T13:10:59-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.3:35437 for udfEnYczCYANHmMFturn:relay.anon-hJs8j.domain:3478?transport=udp
2025-04-27T13:11:02-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Failed
2025-04-27T13:11:02-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:121: failed to dial the remote peer: connecting canceled by caller
2025-04-27T13:11:02-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Closed
2025-04-27T13:11:02-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Failed
2025-04-27T13:11:02-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:121: failed to dial the remote peer: connecting canceled by caller
2025-04-27T13:11:02-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Closed
2025-04-27T13:11:03-06:00 DEBG client/internal/engine.go:1582: signal health check: healthy=true
2025-04-27T13:11:03-06:00 DEBG client/internal/engine.go:1585: management health check: healthy=true
2025-04-27T13:11:03-06:00 DEBG util/net/dialer_dial.go:52: Dialing udp relay.anon-hJs8j.domain:3478
2025-04-27T13:11:03-06:00 DEBG client/internal/relay/relay.go:66: stun probe received address from stun:relay.anon-hJs8j.domain:3478: 198.51.100.2:53912
2025-04-27T13:11:03-06:00 DEBG util/net/listener_listen.go:119: Listener resolved IP for 198.51.anon-EUaGV.domain:3478: 198.51.anon-EUaGV.domain
2025-04-27T13:11:04-06:00 DEBG client/internal/relay/relay.go:158: turn probe relay address from turn:relay.anon-hJs8j.domain:3478?transport=udp: 10.10.0.6:64103
2025-04-27T13:11:04-06:00 DEBG client/internal/engine.go:1597: relay health check: healthy=true
2025-04-27T13:11:04-06:00 DEBG client/internal/engine.go:1612: all health checks completed: healthy=true
2025-04-27T13:11:04-06:00 DEBG client/internal/engine.go:1730: Retrieving latest network map with size 911 bytes
2025-04-27T13:11:04-06:00 INFO client/internal/debug/debug_linux.go:20: Collecting firewall rules
2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:55: Failed to collect iptables rules using iptables-save: execute iptables-save: exec: "iptables-save": executable file not found in $PATH (stderr: )
2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:65: Failed to collect ipset information: ipset command not found: exec: "ipset": executable file not found in $PATH
2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table filter: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: )
2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table nat: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: )
2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table mangle: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: )
2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table raw: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: )
2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table security: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: )
2025-04-27T13:11:05-06:00 TRAC [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected
2025-04-27T13:11:05-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:557: send offer to peer
2025-04-27T13:11:05-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=]
2025-04-27T13:11:05-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected
2025-04-27T13:11:05-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930
2025-04-27T13:11:05-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:97: recreate ICE agent
2025-04-27T13:11:05-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=
2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection
2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:108: gather candidates
2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:118: turn agent dial
2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking
2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026
2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026
2025-04-27T13:11:06-06:00 TRAC [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected
2025-04-27T13:11:06-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:557: send offer to peer
2025-04-27T13:11:06-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=]
2025-04-27T13:11:06-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected
2025-04-27T13:11:06-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437
2025-04-27T13:11:06-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation
2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE
2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:97: recreate ICE agent
2025-04-27T13:11:06-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=
2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection
2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:108: gather candidates
2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:118: turn agent dial
2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking
2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026
2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026
Originally created by @joepa37 on GitHub (Apr 27, 2025). **QUIC Protocol is not working, All peers are being connected using the WS.** ```bash relay_1 | 2025-04-27T18:25:00Z INFO relay/server/listener/quic/listener.go:37: QUIC server listening on address: 0.0.0.0:8012 relay_1 | 2025-04-27T18:25:00Z INFO relay/server/listener/ws/listener.go:39: WS server listening address: 0.0.0.0:8012 relay_1 | 2025-04-27T18:25:05Z INFO relay/server/listener/ws/listener.go:91: WS client connected from: 10.10.0.2:33622 relay_1 | 2025-04-27T18:25:05Z INFO [peer_id: sha-REDACTED] relay/server/relay.go:129: peer connected from: 10.10.0.2:33622 ``` ```bash 2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:170: connecting to relay server 2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:64: dialing Relay server via quic 2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:64: dialing Relay server via WS 2025-04-27T13:10:48-06:00 DEBG util/net/dialer_dial.go:52: Dialing tcp net.anon-hJs8j.domain:8012 2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:89: successfully dialed via: WS 2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:75: connection attempt aborted via: quic ``` **Self Hosted Server Details:** <details> <summary>docker-compose.yml</summary> ```bash # Relay ... relay: image: netbirdio/relay:latest restart: unless-stopped environment: - NB_LOG_LEVEL=trace - NB_LISTEN_ADDRESS=0.0.0.0:8012 - NB_QUIC_LISTEN_ADDRESS=0.0.0.0:8012 - NB_EXPOSED_ADDRESS=rels://net.mydomain.com:8012 # todo: change to a secure secret - NB_AUTH_SECRET=REDACTED - NB_TLS_CERT_FILE=/etc/netbird/certs/fullchain.pem - NB_TLS_KEY_FILE=/etc/netbird/certs/privkey.pem ports: - "8012:8012/tcp" - "8012:8012/udp" volumes: # - ./data/relay:/var/lib/netbird - /etc/letsencrypt/live/net.mydomain.com/fullchain.pem:/etc/netbird/certs/fullchain.pem:ro - /etc/letsencrypt/live/net.mydomain.com/privkey.pem:/etc/netbird/certs/privkey.pem:ro logging: driver: "json-file" options: max-size: "500m" max-file: "2" ... ``` </details> <details> <summary>management.json</summary> ```bash ... "Relay": { "Addresses": [ "rels://net.mydomain.com:8012" ], "CredentialsTTL": "24h0m0s", "Secret": "REDACTED" }, ... ``` </details> <details> <summary>docker-compose logs -f relay</summary> ```bash relay_1 | 2025-04-27T18:25:00Z DEBG relay/cmd/root.go:199: using file based TLS config relay_1 | 2025-04-27T18:25:00Z INFO relay/cmd/root.go:124: running metrics server: :9090/metrics relay_1 | 2025-04-27T18:25:00Z INFO relay/cmd/root.go:149: server will be available on: rels://net.mydomain.com:8012 relay_1 | 2025-04-27T18:25:00Z INFO relay/server/listener/quic/listener.go:37: QUIC server listening on address: 0.0.0.0:8012 relay_1 | 2025-04-27T18:25:00Z INFO relay/server/listener/ws/listener.go:39: WS server listening address: 0.0.0.0:8012 relay_1 | 2025-04-27T18:25:05Z INFO relay/server/listener/ws/listener.go:91: WS client connected from: 10.10.0.2:33622 relay_1 | 2025-04-27T18:25:05Z INFO [peer_id: sha-REDACTED] relay/server/relay.go:129: peer connected from: 10.10.0.2:33622 relay_1 | 2025-04-27T18:32:29Z INFO relay/server/listener/ws/listener.go:91: WS client connected from: 186.2.x.x:21470 relay_1 | 2025-04-27T18:32:29Z INFO [peer_id: sha-REDACTED] relay/server/relay.go:129: peer connected from: 186.2.x.x:21470 relay_1 | 2025-04-27T18:32:29Z INFO relay/server/listener/ws/listener.go:91: WS client connected from: 129.153.71.250:56782 relay_1 | 2025-04-27T18:32:29Z INFO [peer_id: sha-REDACTED] relay/server/relay.go:129: peer connected from: 129.153.x.x:56782 ``` </details> **Peer Client Details:** <details> <summary>netbird status -dA</summary> ```bash Peers detail: desktop-ntsjcrh.anon-qLFLS.domain: NetBird IP: 100.71.94.24 Public key: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= Status: Connected -- detail -- Connection type: P2P ICE candidate (Local/Remote): host/prflx ICE candidate endpoints (Local/Remote): 172.23.27.32:38669/172.23.16.1:60766 Relay server address: rels://net.anon-Opeoe.domain:8012 Last connection update: 3 seconds ago Last WireGuard handshake: 4 seconds ago Transfer status (received/sent) 92 B/180 B Quantum resistance: false Networks: - Latency: 2.087757ms edge.anon-qLFLS.domain: NetBird IP: 100.71.211.147 Public key: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= Status: Connected -- detail -- Connection type: Relayed ICE candidate (Local/Remote): -/- ICE candidate endpoints (Local/Remote): -/- Relay server address: rels://net.anon-Opeoe.domain:8012 Last connection update: 4 seconds ago Last WireGuard handshake: 4 seconds ago Transfer status (received/sent) 92 B/180 B Quantum resistance: false Networks: - Latency: 0s build-phx1-ad1.anon-qLFLS.domain: NetBird IP: 100.71.249.36 Public key: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= Status: Connected -- detail -- Connection type: Relayed ICE candidate (Local/Remote): -/- ICE candidate endpoints (Local/Remote): -/- Relay server address: rels://net.anon-Opeoe.domain:8012 Last connection update: 4 seconds ago Last WireGuard handshake: 4 seconds ago Transfer status (received/sent) 92 B/180 B Quantum resistance: false Networks: - Latency: 0s Events: [WARNING] DNS (3ec4975b-ce98-43d8-8302-147bdf5367bb) Message: The host dns manager does not support match domains Time: 1 hour, 11 minutes ago Metadata: manager: file [INFO] SYSTEM (c4f790b9-a7e5-4cb6-985f-33aee9fd71dc) Message: Network map updated Time: 1 hour, 11 minutes ago [WARNING] DNS (e2236fff-8432-4a80-bc64-5099c471b923) Message: The host dns manager does not support match domains Time: 47 minutes, 47 seconds ago Metadata: manager: file [INFO] SYSTEM (8424406a-53e3-48a8-8b70-c44ab1363b02) Message: Network map updated Time: 47 minutes, 47 seconds ago [WARNING] DNS (394a9561-bd59-43b6-9915-515da8f7dff0) Message: The host dns manager does not support match domains Time: 28 minutes, 38 seconds ago Metadata: manager: file [INFO] SYSTEM (28aee056-a9eb-41f9-acce-52f6e4dee920) Message: Network map updated Time: 28 minutes, 38 seconds ago [WARNING] DNS (55f401f8-9d00-405d-a206-d8e7afe97c27) Message: The host dns manager does not support match domains Time: 20 minutes, 31 seconds ago Metadata: manager: file [INFO] SYSTEM (09dec02f-efb1-4b2d-ba6e-de5cd59f23a8) Message: Network map updated Time: 20 minutes, 31 seconds ago [WARNING] DNS (8c669d4e-5772-4edc-9dda-8a0011c107f9) Message: The host dns manager does not support match domains Time: 4 seconds ago Metadata: manager: file [INFO] SYSTEM (43b51c21-5c67-4242-8d21-ec65ead69a8a) Message: Network map updated Time: 4 seconds ago OS: linux/amd64 Daemon version: 0.43.0 CLI version: 0.43.0 Management: Connected to https://net.anon-Opeoe.domain:443 Signal: Connected to https://net.anon-Opeoe.domain:443 Relays: [stun:relay.anon-Opeoe.domain:3478] is Available [turn:relay.anon-Opeoe.domain:3478?transport=udp] is Available [rels://net.anon-Opeoe.domain:8012] is Available Nameservers: FQDN: desktop-ntsjcrh-1.anon-qLFLS.domain NetBird IP: 100.71.200.176/16 Interface type: Kernel Quantum resistance: false Networks: - Forwarding rules: 0 Peers count: 3/3 Connected ``` </details> <details> <summary>client.log</summary> ```bash 2025-04-27T13:10:46-06:00 DEBG client/internal/engine.go:1403: removing Netbird interface wt0 2025-04-27T13:10:46-06:00 DEBG client/iface/wgproxy/ebpf/proxy.go:113: free up ebpf wg proxy 2025-04-27T13:10:46-06:00 DEBG client/internal/ebpf/ebpf/wg_proxy_linux.go:39: free ebpf WG proxy 2025-04-27T13:10:46-06:00 DEBG client/internal/ebpf/ebpf/manager_linux.go:107: detach ebpf program 2025-04-27T13:10:46-06:00 ERRO client/iface/bind/udp_mux_universal.go:97: error while reading packet: shared socked stopped 2025-04-27T13:10:46-06:00 DEBG client/iface/bind/udp_mux_universal.go:92: stopped reading from the UDPConn due to finished context 2025-04-27T13:10:46-06:00 INFO client/iface/iface.go:229: interface wt0 has been removed 2025-04-27T13:10:46-06:00 INFO client/internal/engine.go:320: stopped Netbird Engine 2025-04-27T13:10:46-06:00 DEBG client/internal/statemanager/manager.go:286: persisted states: [nftables_state], took 894.81µs 2025-04-27T13:10:46-06:00 INFO client/server/server.go:666: service is down 2025-04-27T13:10:46-06:00 INFO client/internal/connect.go:305: stopped NetBird client 2025-04-27T13:10:46-06:00 WARN client/internal/connect.go:189: failed to close the Management service client rpc error: code = Canceled desc = grpc: the client connection is closing 2025-04-27T13:10:46-06:00 TRAC client/server/server.go:208: client connection exited 2025-04-27T13:10:46-06:00 TRAC client/server/server.go:216: retry canceled 2025-04-27T13:10:47-06:00 DEBG client/internal/engine.go:1709: Network map persistence is set to true 2025-04-27T13:10:47-06:00 TRAC client/server/server.go:190: running client connection 2025-04-27T13:10:47-06:00 INFO client/internal/connect.go:122: starting NetBird client version 0.43.0 on linux/amd64 2025-04-27T13:10:47-06:00 DEBG util/net/dialer_dial.go:52: Dialing udp 127.0.0.1:9 2025-04-27T13:10:47-06:00 INFO util/net/env_linux.go:70: system supports advanced routing 2025-04-27T13:10:47-06:00 DEBG client/internal/connect.go:178: connecting to the Management service net.anon-hJs8j.domain:443 2025-04-27T13:10:47-06:00 DEBG util/net/dialer_dial.go:52: Dialing tcp net.anon-hJs8j.domain:443 2025-04-27T13:10:48-06:00 DEBG client/internal/connect.go:186: connected to the Management service net.anon-hJs8j.domain:443 2025-04-27T13:10:48-06:00 DEBG util/net/dialer_dial.go:52: Dialing tcp net.anon-hJs8j.domain:443 2025-04-27T13:10:48-06:00 DEBG signal/client/grpc.go:83: connected to Signal Service: net.anon-hJs8j.domain:443 2025-04-27T13:10:48-06:00 INFO client/internal/connect.go:255: connecting to the Relay service(s): rels://net.anon-hJs8j.domain:8012 2025-04-27T13:10:48-06:00 DEBG relay/client/manager.go:109: starting relay client manager with [rels://net.anon-hJs8j.domain:8012] relay servers 2025-04-27T13:10:48-06:00 DEBG relay/client/picker.go:45: pick server from list: [rels://net.anon-hJs8j.domain:8012] 2025-04-27T13:10:48-06:00 INFO relay/client/picker.go:72: try to connecting to relay server: rels://net.anon-hJs8j.domain:8012 2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:164: create new relay connection: local peerID: ZLysIiXkFMUpuD/jYt+gd6GkqJk+WKjWxOUtNj9dOG4=, local peer hashedID: sha-xcPvkBPb4ISTktKXM2epswPQjdKEQ4XBerxdRi38crw= 2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:170: connecting to relay server 2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:64: dialing Relay server via quic 2025-04-27T13:10:48-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:64: dialing Relay server via WS 2025-04-27T13:10:48-06:00 DEBG util/net/dialer_dial.go:52: Dialing tcp net.anon-hJs8j.domain:8012 2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:89: successfully dialed via: WS 2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/dialer/race_dialer.go:75: connection attempt aborted via: quic 2025-04-27T13:10:49-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:186: relay connection established 2025-04-27T13:10:49-06:00 INFO relay/client/picker.go:90: connected to Relay server: rels://net.anon-hJs8j.domain:8012 2025-04-27T13:10:49-06:00 INFO relay/client/picker.go:64: chosen home Relay server: rels://net.anon-hJs8j.domain:8012 2025-04-27T13:10:49-06:00 INFO client/internal/connect.go:459: using 60026 as wireguard port: 51820 is in use 2025-04-27T13:10:49-06:00 DEBG client/internal/engine.go:1709: Network map persistence is set to true 2025-04-27T13:10:49-06:00 DEBG client/iface/wgproxy/ebpf/proxy.go:47: instantiate ebpf proxy 2025-04-27T13:10:49-06:00 DEBG client/internal/ebpf/ebpf/wg_proxy_linux.go:11: load ebpf WG proxy 2025-04-27T13:10:49-06:00 INFO client/iface/wgproxy/ebpf/proxy.go:91: local wg proxy listening on: 3128 2025-04-27T13:10:49-06:00 INFO client/iface/wgproxy/factory_kernel.go:29: WireGuard Proxy Factory will produce eBPF proxy 2025-04-27T13:10:49-06:00 DEBG client/internal/dns/service_listener.go:108: registering dns handler for pattern: . 2025-04-27T13:10:49-06:00 DEBG client/internal/statemanager/manager.go:378: loaded state: routeselector_state 2025-04-27T13:10:49-06:00 DEBG client/internal/routemanager/sysctl/sysctl_linux.go:87: Set sysctl net.ipv4.conf.all.src_valid_mark from 0 to 1 2025-04-27T13:10:49-06:00 INFO client/internal/routemanager/manager.go:193: Routing setup complete 2025-04-27T13:10:49-06:00 DEBG client/iface/device/wg_link_linux.go:65: adding device: wt0 2025-04-27T13:10:49-06:00 DEBG client/iface/device/wg_link_linux.go:115: adding address 100.71.200.176/16 to interface: wt0 2025-04-27T13:10:49-06:00 DEBG client/iface/device/device_kernel_unix.go:66: setting MTU: 1280 interface: wt0 2025-04-27T13:10:49-06:00 DEBG client/iface/configurer/kernel_unix.go:26: adding Wireguard private key 2025-04-27T13:10:49-06:00 INFO client/firewall/create_linux.go:73: creating an nftables firewall manager 2025-04-27T13:10:49-06:00 WARN client/firewall/nftables/router_linux.go:87: table 'filter' not found for forward rules 2025-04-27T13:10:49-06:00 DEBG client/firewall/nftables/router_linux.go:849: table 'filter' not found for forward rules, skipping accept rules 2025-04-27T13:10:49-06:00 DEBG client/iface/device/device_kernel_unix.go:90: bringing up interface: wt0 2025-04-27T13:10:49-06:00 DEBG client/internal/statemanager/manager.go:286: persisted states: [nftables_state], took 638.979µs 2025-04-27T13:10:49-06:00 DEBG client/iface/device/device_kernel_unix.go:113: device is ready to use: wt0 2025-04-27T13:10:49-06:00 INFO client/internal/dns/host_unix.go:54: System DNS manager discovered: file 2025-04-27T13:10:49-06:00 DEBG signal/client/grpc.go:128: signal connection state READY 2025-04-27T13:10:49-06:00 INFO client/internal/peer/guard/sr_watcher.go:106: reconnected to Signal or Relay server 2025-04-27T13:10:49-06:00 INFO signal/client/grpc.go:149: connected to the Signal Service stream 2025-04-27T13:10:49-06:00 DEBG client/internal/engine.go:899: connecting to Management Service updates stream 2025-04-27T13:10:49-06:00 INFO client/internal/engine.go:1650: Network monitor is disabled, not starting 2025-04-27T13:10:49-06:00 INFO client/internal/connect.go:281: Netbird engine started, the IP is: 100.71.200.176/16 2025-04-27T13:10:49-06:00 DEBG management/client/grpc.go:115: management connection state READY 2025-04-27T13:10:49-06:00 INFO management/client/grpc.go:162: connected to the Management Service stream 2025-04-27T13:10:50-06:00 DEBG management/client/grpc.go:259: got an update message from Management Service 2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:925: got TURNs update from Management Service, updating 2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:907: got STUNs update from Management Service, updating 2025-04-27T13:10:50-06:00 INFO relay/client/manager.go:223: update relay server URLs: [rels://net.anon-hJs8j.domain:8012] 2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:684: network map persisted with serial 4 2025-04-27T13:10:50-06:00 WARN client/internal/engine.go:785: running SSH server is not permitted 2025-04-27T13:10:50-06:00 DEBG client/firewall/nftables/acl_linux.go:647: failed to flush nftables: conn.Receive: netlink receive: no such file or directory 2025-04-27T13:10:50-06:00 ERRO client/internal/acl/manager.go:91: failed to flush firewall rules: conn.Receive: netlink receive: no such file or directory 2025-04-27T13:10:50-06:00 INFO client/internal/acl/manager.go:67: ACL rules processed in: 248.710779ms, total rules count: 1 2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:983: got peers update from Management Service, total peers to connect to = 3 2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:1219: creating peer connection UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:185: open connection to peer 2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:1219: creating peer connection 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= 2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:185: open connection to peer 2025-04-27T13:10:50-06:00 DEBG client/internal/engine.go:1219: creating peer connection NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= 2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:185: open connection to peer 2025-04-27T13:10:50-06:00 DEBG client/internal/dns.go:110: added reverse DNS zone: 71.100.anon-4AoHQ.domain. with 4 records 2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:50-06:00 DEBG client/internal/dns/service_listener.go:69: starting dns on 100.71.200.176:53 2025-04-27T13:10:50-06:00 DEBG client/internal/dns/server.go:213: registering handler local resolver [0 records] with priority 50 2025-04-27T13:10:50-06:00 DEBG client/internal/dns/handler_chain.go:86: adding handler pattern: domain=anon-Lu0W9.domain. original: domain=anon-Lu0W9.domain. wildcard=false match_subdomain=true priority=50 2025-04-27T13:10:50-06:00 DEBG client/internal/dns/server.go:213: registering handler local resolver [0 records] with priority 50 2025-04-27T13:10:50-06:00 DEBG client/internal/dns/handler_chain.go:86: adding handler pattern: domain=71.100.anon-4AoHQ.domain. original: domain=71.100.anon-4AoHQ.domain. wildcard=false match_subdomain=true priority=50 2025-04-27T13:10:50-06:00 DEBG client/internal/dns/server.go:494: extra match domains: map[] 2025-04-27T13:10:50-06:00 ERRO client/internal/dns/server.go:497: failed to apply DNS host manager update: unable to configure DNS for this peer using file manager without a nameserver group with all domains configured 2025-04-27T13:10:50-06:00 DEBG client/internal/peer/status.go:979: event published: id:"249d8b8a-a84c-4f3f-818a-d91a0ec7d2cc" severity:WARNING category:DNS message:"The host dns manager does not support match domains" userMessage:"The host dns manager does not support match domains without a catch-all nameserver group." timestamp:{seconds:1745781050 nanos:334060468} metadata:{key:"manager" value:"file"} 2025-04-27T13:10:50-06:00 DEBG client/internal/peer/status.go:979: event published: id:"82bf33ad-5bfb-4b9d-aad8-e477bf3bc61b" category:SYSTEM message:"Network map updated" timestamp:{seconds:1745781050 nanos:334393309} 2025-04-27T13:10:50-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:301: OnRemoteOffer, on status ICE: Disconnected, status Relay: Disconnected 2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:170: sending answer 2025-04-27T13:10:50-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: None, status ICE: Disconnected, status relay: Disconnected 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:125: OnRemoteAnswer skipping message because is not ready 2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 60766 2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:97: recreate ICE agent 2025-04-27T13:10:50-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= 2025-04-27T13:10:50-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:214: open connection to peer: sha-cEF9wzAkwN0Tt69OazEvlS3cirJaswq4XaYAuggZ1Jw= 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_relay.go:86: peer conn opened via Relay: rels://net.anon-hJs8j.domain:8012 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:465: Relay connection has been established, setup the WireGuard 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:736: setup proxied WireGuard connection 2025-04-27T13:10:50-06:00 INFO client/iface/wgproxy/ebpf/proxy.go:102: turn conn added to wg proxy store: rels://net.anon-hJs8j.domain:8012, endpoint port: :1 2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:474: created new wgProxy for relay connection: 127.0.0.1:1 2025-04-27T13:10:50-06:00 DEBG client/iface/iface.go:120: updating interface wt0 peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=, endpoint 127.0.0.1:1 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:108: gather candidates 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:118: turn agent dial 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/wg_watcher.go:48: enable WireGuard watcher 2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/wg_watcher.go:87: WireGuard watcher started 2025-04-27T13:10:50-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] 2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: None, status ICE: Disconnected, status relay: Disconnected 2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437 2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:97: recreate ICE agent 2025-04-27T13:10:50-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= 2025-04-27T13:10:50-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:214: open connection to peer: sha-EZtla+PO+m2Qtigeaz3fKeC5Cjnj8L2voN4XE7s64RQ= 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:86: peer conn opened via Relay: rels://net.anon-hJs8j.domain:8012 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:465: Relay connection has been established, setup the WireGuard 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:736: setup proxied WireGuard connection 2025-04-27T13:10:50-06:00 INFO client/iface/wgproxy/ebpf/proxy.go:102: turn conn added to wg proxy store: rels://net.anon-hJs8j.domain:8012, endpoint port: :2 2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:474: created new wgProxy for relay connection: 127.0.0.1:2 2025-04-27T13:10:50-06:00 DEBG client/iface/iface.go:120: updating interface wt0 peer 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=, endpoint 127.0.0.1:2 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:108: gather candidates 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:118: turn agent dial 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/wg_watcher.go:48: enable WireGuard watcher 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026 2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/wg_watcher.go:87: WireGuard watcher started 2025-04-27T13:10:50-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: None, status ICE: Disconnected, status relay: Disconnected 2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930 2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:97: recreate ICE agent 2025-04-27T13:10:50-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= 2025-04-27T13:10:50-06:00 INFO [relay: rels://net.anon-hJs8j.domain:8012] relay/client/client.go:214: open connection to peer: sha-2QMPzEP0DRcWkA7Mmiy5HEXzo3ZrsTTskGV2hqPUL9A= 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:86: peer conn opened via Relay: rels://net.anon-hJs8j.domain:8012 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:465: Relay connection has been established, setup the WireGuard 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:736: setup proxied WireGuard connection 2025-04-27T13:10:50-06:00 INFO client/iface/wgproxy/ebpf/proxy.go:102: turn conn added to wg proxy store: rels://net.anon-hJs8j.domain:8012, endpoint port: :3 2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:474: created new wgProxy for relay connection: 127.0.0.1:3 2025-04-27T13:10:50-06:00 DEBG client/iface/iface.go:120: updating interface wt0 peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=, endpoint 127.0.0.1:3 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:108: gather candidates 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:118: turn agent dial 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/wg_watcher.go:48: enable WireGuard watcher 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026 2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/wg_watcher.go:87: WireGuard watcher started 2025-04-27T13:10:50-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:509: start to communicate with peer via relay 2025-04-27T13:10:50-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:509: start to communicate with peer via relay 2025-04-27T13:10:50-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026 2025-04-27T13:10:50-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026 2025-04-27T13:10:50-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026 2025-04-27T13:10:50-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:509: start to communicate with peer via relay 2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 192.168.71.1:60766 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.71.1:60766 for dPTuKleRLBbZVbtZ 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.71.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 172.23.16.1:60766 for dPTuKleRLBbZVbtZ 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 172.23.16.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478 2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 srflx 198.51.100.2:60766 related 0.0.0.0:60766 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 srflx 198.51.100.2:21501 related 0.0.0.0:60766 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 192.168.91.1:60766 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.91.1:60766 for dPTuKleRLBbZVbtZ 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.91.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.2:21501 for dPTuKleRLBbZVbtZ 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.2:21501 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.2:60766 for dPTuKleRLBbZVbtZ 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.2:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478 2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 192.168.233.235:60766 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.233.235:60766 for dPTuKleRLBbZVbtZ 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 192.168.233.235:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478 2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 172.28.176.1:60766 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 127.0.0.1:60766 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 172.28.176.1:60766 for dPTuKleRLBbZVbtZ 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 172.28.176.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 127.0.0.1:60766 for dPTuKleRLBbZVbtZ 2025-04-27T13:10:51-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 127.0.0.1:60766 for dPTuKleRLBbZVbtZstun:relay.anon-hJs8j.domain:3478 2025-04-27T13:10:51-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= -> udp4 host 172.23.16.1:60766 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:124: agent dial succeeded 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:153: on ICE conn is ready to use 2025-04-27T13:10:51-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/conn.go:344: set ICE to active connection 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/wg_watcher.go:79: disable WireGuard watcher 2025-04-27T13:10:51-06:00 TRAC client/iface/wgproxy/ebpf/wrapper.go:66: pause proxy reading from: rels://net.anon-hJs8j.domain:8012 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Connected 2025-04-27T13:10:51-06:00 DEBG [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/worker_ice.go:329: selected candidate pair [local <-> remote] -> [udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026 <-> udp4 prflx 172.23.16.1:60766 related :0], peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI= 2025-04-27T13:10:51-06:00 DEBG client/iface/iface.go:120: updating interface wt0 peer UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=, endpoint 172.23.16.1:60766 2025-04-27T13:10:51-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/wg_watcher.go:111: WireGuard watcher stopped 2025-04-27T13:10:52-06:00 DEBG client/internal/engine.go:1582: signal health check: healthy=true 2025-04-27T13:10:52-06:00 DEBG client/internal/engine.go:1585: management health check: healthy=true 2025-04-27T13:10:52-06:00 DEBG util/net/dialer_dial.go:52: Dialing udp relay.anon-hJs8j.domain:3478 2025-04-27T13:10:53-06:00 DEBG client/internal/relay/relay.go:66: stun probe received address from stun:relay.anon-hJs8j.domain:3478: 198.51.100.2:21460 2025-04-27T13:10:53-06:00 DEBG util/net/listener_listen.go:119: Listener resolved IP for 198.51.anon-EUaGV.domain:3478: 198.51.anon-EUaGV.domain 2025-04-27T13:10:53-06:00 DEBG client/internal/relay/relay.go:158: turn probe relay address from turn:relay.anon-hJs8j.domain:3478?transport=udp: 10.10.0.6:52521 2025-04-27T13:10:53-06:00 DEBG client/internal/engine.go:1597: relay health check: healthy=true 2025-04-27T13:10:53-06:00 DEBG client/internal/engine.go:1612: all health checks completed: healthy=true 2025-04-27T13:10:53-06:00 INFO [peer: UiqCjrt75YlwmQLF3rUqTS2H0z1Y1nGiKBvnwoGh+jI=] client/internal/peer/guard/guard.go:84: start reconnect loop... 2025-04-27T13:10:53-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/guard/guard.go:84: start reconnect loop... 2025-04-27T13:10:53-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/guard/guard.go:84: start reconnect loop... 2025-04-27T13:10:54-06:00 TRAC [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected 2025-04-27T13:10:54-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:557: send offer to peer 2025-04-27T13:10:54-06:00 TRAC [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected 2025-04-27T13:10:54-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:557: send offer to peer 2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] 2025-04-27T13:10:54-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected 2025-04-27T13:10:54-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437 2025-04-27T13:10:54-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:54-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:10:54-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer 2025-04-27T13:10:54-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= 2025-04-27T13:10:54-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection 2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:54-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected 2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:54-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930 2025-04-27T13:10:54-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:54-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= 2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection 2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 10.10.0.6:58930 2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer 2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 198.51.100.1:58930 2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 srflx 10.10.0.2:58930 related 0.0.0.0:58930 2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 10.116.0.3:58930 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.10.0.6:58930 for oUgwHAPDudNDkqwH 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.10.0.6:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.10.0.2:58930 for oUgwHAPDudNDkqwH 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.10.0.2:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.1:58930 for oUgwHAPDudNDkqwH 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.1:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.116.0.3:58930 for oUgwHAPDudNDkqwH 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.116.0.3:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp 2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 10.40.0.1:58930 2025-04-27T13:10:54-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:54-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= -> udp4 host 10.42.12.0:58930 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.40.0.1:58930 for oUgwHAPDudNDkqwH 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.40.0.1:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.42.12.0:58930 for oUgwHAPDudNDkqwH 2025-04-27T13:10:54-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.42.12.0:58930 for oUgwHAPDudNDkqwHturn:relay.anon-hJs8j.domain:3478?transport=udp 2025-04-27T13:10:56-06:00 TRAC [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected 2025-04-27T13:10:56-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:557: send offer to peer 2025-04-27T13:10:56-06:00 TRAC [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected 2025-04-27T13:10:56-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:557: send offer to peer 2025-04-27T13:10:56-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] 2025-04-27T13:10:56-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected 2025-04-27T13:10:56-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437 2025-04-27T13:10:56-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:56-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:10:56-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer 2025-04-27T13:10:56-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= 2025-04-27T13:10:56-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection 2025-04-27T13:10:56-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:56-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected 2025-04-27T13:10:56-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930 2025-04-27T13:10:56-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:56-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:10:56-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer 2025-04-27T13:10:56-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= 2025-04-27T13:10:56-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection 2025-04-27T13:10:59-06:00 TRAC [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected 2025-04-27T13:10:59-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:557: send offer to peer 2025-04-27T13:10:59-06:00 TRAC [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected 2025-04-27T13:10:59-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:557: send offer to peer 2025-04-27T13:10:59-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:10:59-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected 2025-04-27T13:10:59-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930 2025-04-27T13:10:59-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:59-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:10:59-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer 2025-04-27T13:10:59-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= 2025-04-27T13:10:59-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection 2025-04-27T13:10:59-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] 2025-04-27T13:10:59-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected 2025-04-27T13:10:59-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437 2025-04-27T13:10:59-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:10:59-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= 2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection 2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:85: agent already exists, skipping the offer 2025-04-27T13:10:59-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] 2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= -> udp4 host 10.0.0.58:35437 2025-04-27T13:10:59-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.0.0.58:35437 for udfEnYczCYANHmMF 2025-04-27T13:10:59-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 10.0.0.58:35437 for udfEnYczCYANHmMFturn:relay.anon-hJs8j.domain:3478?transport=udp 2025-04-27T13:10:59-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] 2025-04-27T13:10:59-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:161: OnRemoteCandidate from peer 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= -> udp4 srflx 198.51.100.3:35437 related 0.0.0.0:35437 2025-04-27T13:10:59-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.3:35437 for udfEnYczCYANHmMF 2025-04-27T13:10:59-06:00 DEBG client/iface/bind/udp_mux.go:363: ICE: registered 198.51.100.3:35437 for udfEnYczCYANHmMFturn:relay.anon-hJs8j.domain:3478?transport=udp 2025-04-27T13:11:02-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Failed 2025-04-27T13:11:02-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:121: failed to dial the remote peer: connecting canceled by caller 2025-04-27T13:11:02-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Closed 2025-04-27T13:11:02-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Failed 2025-04-27T13:11:02-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:121: failed to dial the remote peer: connecting canceled by caller 2025-04-27T13:11:02-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Closed 2025-04-27T13:11:03-06:00 DEBG client/internal/engine.go:1582: signal health check: healthy=true 2025-04-27T13:11:03-06:00 DEBG client/internal/engine.go:1585: management health check: healthy=true 2025-04-27T13:11:03-06:00 DEBG util/net/dialer_dial.go:52: Dialing udp relay.anon-hJs8j.domain:3478 2025-04-27T13:11:03-06:00 DEBG client/internal/relay/relay.go:66: stun probe received address from stun:relay.anon-hJs8j.domain:3478: 198.51.100.2:53912 2025-04-27T13:11:03-06:00 DEBG util/net/listener_listen.go:119: Listener resolved IP for 198.51.anon-EUaGV.domain:3478: 198.51.anon-EUaGV.domain 2025-04-27T13:11:04-06:00 DEBG client/internal/relay/relay.go:158: turn probe relay address from turn:relay.anon-hJs8j.domain:3478?transport=udp: 10.10.0.6:64103 2025-04-27T13:11:04-06:00 DEBG client/internal/engine.go:1597: relay health check: healthy=true 2025-04-27T13:11:04-06:00 DEBG client/internal/engine.go:1612: all health checks completed: healthy=true 2025-04-27T13:11:04-06:00 DEBG client/internal/engine.go:1730: Retrieving latest network map with size 911 bytes 2025-04-27T13:11:04-06:00 INFO client/internal/debug/debug_linux.go:20: Collecting firewall rules 2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:55: Failed to collect iptables rules using iptables-save: execute iptables-save: exec: "iptables-save": executable file not found in $PATH (stderr: ) 2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:65: Failed to collect ipset information: ipset command not found: exec: "ipset": executable file not found in $PATH 2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table filter: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: ) 2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table nat: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: ) 2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table mangle: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: ) 2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table raw: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: ) 2025-04-27T13:11:04-06:00 WARN client/internal/debug/debug_linux.go:81: Failed to get statistics for table security: execute iptables -v -n -L: exec: "iptables": executable file not found in $PATH (stderr: ) 2025-04-27T13:11:05-06:00 TRAC [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected 2025-04-27T13:11:05-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:557: send offer to peer 2025-04-27T13:11:05-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] 2025-04-27T13:11:05-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected 2025-04-27T13:11:05-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 58930 2025-04-27T13:11:05-06:00 INFO [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:97: recreate ICE agent 2025-04-27T13:11:05-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ= 2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection 2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:108: gather candidates 2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:118: turn agent dial 2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking 2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026 2025-04-27T13:11:05-06:00 DEBG [peer: NoP4utioatlbr/4wcgtwwyI402EwS9yknquH7iCq1GQ=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026 2025-04-27T13:11:06-06:00 TRAC [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:776: connectivity guard check, relay state: Connected, ice state: Disconnected 2025-04-27T13:11:06-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:557: send offer to peer 2025-04-27T13:11:06-06:00 TRAC signal/client/grpc.go:403: received a new message from Peer [fingerprint: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] 2025-04-27T13:11:06-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/conn.go:272: OnRemoteAnswer, priority: PriorityRelay, status ICE: Disconnected, status relay: Connected 2025-04-27T13:11:06-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:91: received connection confirmation, running version 0.43.0 and with remote WireGuard listen port 35437 2025-04-27T13:11:06-06:00 INFO [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/handshaker.go:79: wait for remote offer confirmation 2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:81: OnNewOffer for ICE 2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:97: recreate ICE agent 2025-04-27T13:11:06-06:00 DEBG relay/client/manager.go:143: open peer connection via permanent server: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0= 2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_relay.go:68: handled offer by reusing existing relay connection 2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:108: gather candidates 2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:118: turn agent dial 2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:211: ICE ConnectionState has changed to Checking 2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 host 172.23.27.32:60026 2025-04-27T13:11:06-06:00 DEBG [peer: 85gBMA8vFbczKtzz4sA08kSnNmmvAFBf0lnRTU5PvR0=] client/internal/peer/worker_ice.go:299: discovered local candidate udp4 srflx 198.51.100.2:21482 related 0.0.0.0:60026 ``` </details>
saavagebueno added the bugnetworking labels 2025-11-20 06:07:52 -05:00
saavagebueno commented 2025-11-20 06:07:53 -05:00
Author
Owner
Copy Link

@B08Z commented on GitHub (Apr 28, 2025):

I have exactly the same issue.
I don't see any errors in my logs.
A UDP Dump on the interface sees the initial connection request and data / handshake but never a connection.

@B08Z commented on GitHub (Apr 28, 2025): I have exactly the same issue. I don't see any errors in my logs. A UDP Dump on the interface sees the initial connection request and data / handshake but never a connection.
saavagebueno commented 2025-11-20 06:07:53 -05:00
Author
Owner
Copy Link

@B08Z commented on GitHub (Apr 30, 2025):

Any update on how this can be achieved?

@B08Z commented on GitHub (Apr 30, 2025): Any update on how this can be achieved?
saavagebueno commented 2025-11-20 06:07:53 -05:00
Author
Owner
Copy Link

@B08Z commented on GitHub (Apr 30, 2025):

I am pretty sure this will fix if for those using standard let's encrypt certificates

https://github.com/netbirdio/netbird/issues/3672

@B08Z commented on GitHub (Apr 30, 2025): I am pretty sure this will fix if for those using standard let's encrypt certificates https://github.com/netbirdio/netbird/issues/3672
saavagebueno commented 2025-11-20 06:07:53 -05:00
Author
Owner
Copy Link

@alindt commented on GitHub (May 6, 2025):

Fixed in #3673.

relay-1 | 2025-05-06T09:29:52Z INFO relay/server/listener/quic/listener.go:50: QUIC client connected from: 192.0.2.1:59107

@alindt commented on GitHub (May 6, 2025): Fixed in #3673. `relay-1 | 2025-05-06T09:29:52Z INFO relay/server/listener/quic/listener.go:50: QUIC client connected from: 192.0.2.1:59107`
Sign in to join this conversation.
No Branch/Tag Specified
Branches Tags
Labels
Clear labels
2021 Q4
2022 Q1
2022 Q1
accessibility
acl
agent
agent
Android
Android
api
authentik
automation
azure
battery-usage
bug
cache
client
client-ui
cloud
cloud-only
cloudflare
community
compatibility
config-idp
config-issue
connection
contribution
coturn
cross-vpn
dashboard
data-usage
distribution
dns
docker
documentation
duplicate
enhancement
enhancement
event-stream
feature-request
freebsd
getting-started
go
good first issue
gui
help wanted
home-assistant
idp
inconsistency
integration
integrations
ios
ipv6
jwt
k8s
keycloak
linux
login
macos
management-service
missing-docs
mobile
moved-internal
needs-review
netbird-ui
networking
new-platform
nginx
notification
okta
openwrt
packaging
peer-management
peer-management
peer-management
performance
postgres
posture-checks
psk
pull-request
Mirrored from GitHub Pull Request
 question
refactor
relay
release
rfc
routes
security
security-related
self-hosting
server
signal
sleep-issue
ssh
ssl
status
store
synology
system-compatibility-issue
test-suite
third-party-integration
triage
triage-needed
troubleshooting
UX
waiting-feedback
windows
wontfix
zitadel
No Label bug networking
Milestone
No items
No Milestone
Projects
Clear projects
No project
Assignees
Clear assignees
saavagebueno
No Assignees
1 Participants
Notifications
Due Date
No due date set.
Dependencies

No dependencies set.

Reference: SVI/netbird#1846
Delete Branch "%!s()"

Deleting a branch is permanent. Although the deleted branch may continue to exist for a short time before it actually gets removed, it CANNOT be undone in most cases. Continue?