UPnP not working since upgrade to 0.13

falkben · May 26, 2016, 6:13pm

After upgrading all 3 of my devices (2x Windows, 1x Linux) to 0.13, I’m unable to connect through my router using UPnP. Previously, on 0.12, I had no problems. Specifying port forward rules allows them to pass through (port forward TCP port 22000).

AudriusButkevicius · May 26, 2016, 6:47pm

UPnP does not require rules, so you must be confusing something. Also, make sure all devices are on 0.13.

falkben · May 26, 2016, 6:59pm

It seems like I was not clear.

UPnP fails. However, I can get around this issue by using port forwarding rules whereas before, I did not have any port forward rules.

All devices are on 0.13.

AudriusButkevicius · May 26, 2016, 7:11pm

Does it provide an error message?

Can run with STTRACE=nat,upnp environment variable, and provide the logs of the failure?

falkben · May 26, 2016, 7:55pm

It does not provide an error - it will connect through a relay if I let it. If I disable relays, it just doesn’t connect.

Attached are logs from the two windows devices. The linux device has the port forward rule so it is able to make a direct connection, but without the port forward rule, it would also be on a relay or not connected.

I tried setting the environmental variable, but I am not sure they worked with Synctrayzor.

HOME (behind router and UPnP): http://pastebin.com/QqcnCMxv

falkben · May 26, 2016, 7:56pm

WORK: http://pastebin.com/kQSAkh6c

AudriusButkevicius · May 26, 2016, 7:58pm

Can you get the logs with the debug flags? Also add pmp,discovery to the mix: STTRACE=upnp,nat,pmp,discovery

falkben · May 26, 2016, 7:59pm

I set the variable in a command window like this and then restarted Synctrayzor. Is there some other way?

set STTRACE=nat,upnp

AudriusButkevicius · May 26, 2016, 7:59pm

There are probably debug options in synctrayzor somewhere.

falkben · May 26, 2016, 8:04pm

Found them, letting the logs populate after restarting syncthing, and will send them shortly.

falkben · May 26, 2016, 8:09pm

WORK, not behind router:

[XVEBW] 2016/05/26 16:02:18.581892 main.go:561: INFO: syncthing v0.13.4 "Copper Cockroach" (go1.6.2 windows-amd64) WIN-P6RP886TVDJ\Administrator@WIN-P6RP886TVDJ 2016-05-26 09:16:08 UTC
[XVEBW] 2016/05/26 16:02:18.581892 main.go:562: INFO: My ID: XVEBWC6
[XVEBW] 2016/05/26 16:02:18.884910 main.go:853: INFO: Single thread hash performance is ~190 MB/s
[XVEBW] 2016/05/26 16:02:22.897139 model.go:209: INFO: Ready to synchronize eptesicus_forest_collab (readwrite)
[XVEBW] 2016/05/26 16:02:25.901311 model.go:209: INFO: Ready to synchronize nhwhg_collab (readwrite)
[XVEBW] 2016/05/26 16:02:28.146440 model.go:209: INFO: Ready to synchronize small_space_beampattern (readwrite)
[XVEBW] 2016/05/26 16:02:28.168441 model.go:209: INFO: Ready to synchronize ISOs (readwrite)
[XVEBW] 2016/05/26 16:02:28.169441 main.go:705: INFO: Using discovery server https://discovery-v4-1.syncthing.net/v2/?id=SR7AARM
[XVEBW] 2016/05/26 16:02:28.169441 main.go:705: INFO: Using discovery server https://discovery-v4-2.syncthing.net/v2/?id=DVU36WY
[XVEBW] 2016/05/26 16:02:28.169441 main.go:705: INFO: Using discovery server https://discovery-v4-3.syncthing.net/v2/?id=VK6HNJ3
[XVEBW] 2016/05/26 16:02:28.169441 main.go:705: INFO: Using discovery server https://discovery-v6-1.syncthing.net/v2/?id=SR7AARM
[XVEBW] 2016/05/26 16:02:28.169441 main.go:705: INFO: Using discovery server https://discovery-v6-2.syncthing.net/v2/?id=DVU36WY
[XVEBW] 2016/05/26 16:02:28.169441 main.go:705: INFO: Using discovery server https://discovery-v6-3.syncthing.net/v2/?id=VK6HNJ3
[XVEBW] 2016/05/26 16:02:28.184442 main.go:750: INFO: Device G7PJ4UV is "killerdeathman" at [dynamic]
[XVEBW] 2016/05/26 16:02:28.184442 main.go:750: INFO: Device XVEBWC6 is "fuscination" at [dynamic]
[XVEBW] 2016/05/26 16:02:28.184442 main.go:750: INFO: Device 44HMFSN is "pine64" at [dynamic]
[XVEBW] 2016/05/26 16:02:28.188442 tcp_listen.go:69: INFO: TCP listener ([::]:22000) starting
[XVEBW] 2016/05/26 16:02:28.204443 usage_report.go:264: INFO: Starting usage reporting
[XVEBW] 2016/05/26 16:02:28.207443 rwfolder.go:307: INFO: Completed initial scan (rw) of folder ISOs
[XVEBW] 2016/05/26 16:02:28.209443 gui.go:347: INFO: GUI and API listening on 127.0.0.1:8384
[XVEBW] 2016/05/26 16:02:28.209443 gui.go:348: INFO: Access the GUI via the following URL: http://localhost:8384/
[XVEBW] 2016/05/26 16:02:28.220444 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Local Area Connection
[XVEBW] 2016/05/26 16:02:28.223444 upnp.go:165: DEBUG: Sending search request for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Local Area Connection
[XVEBW] 2016/05/26 16:02:28.223444 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Local Area Connection
[XVEBW] 2016/05/26 16:02:28.230444 upnp.go:165: DEBUG: Sending search request for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Local Area Connection
[XVEBW] 2016/05/26 16:02:28.231444 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Loopback Pseudo-Interface 1
[XVEBW] 2016/05/26 16:02:28.235445 upnp.go:173: DEBUG: Listening for UPnP response for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Local Area Connection
[XVEBW] 2016/05/26 16:02:28.235445 upnp.go:173: DEBUG: Listening for UPnP response for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Local Area Connection
[XVEBW] 2016/05/26 16:02:28.235445 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Loopback Pseudo-Interface 1
[XVEBW] 2016/05/26 16:02:28.236445 upnp.go:165: DEBUG: Sending search request for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Loopback Pseudo-Interface 1
[XVEBW] 2016/05/26 16:02:28.236445 upnp.go:173: DEBUG: Listening for UPnP response for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Loopback Pseudo-Interface 1
[XVEBW] 2016/05/26 16:02:28.240445 upnp.go:165: DEBUG: Sending search request for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Loopback Pseudo-Interface 1
[XVEBW] 2016/05/26 16:02:28.240445 upnp.go:173: DEBUG: Listening for UPnP response for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Loopback Pseudo-Interface 1
[XVEBW] 2016/05/26 16:02:31.229616 rwfolder.go:307: INFO: Completed initial scan (rw) of folder small_space_beampattern
[XVEBW] 2016/05/26 16:02:31.515632 service.go:229: INFO: Established secure connection to G7PJ4UV at 10.160.95.179:55580-199.15.254.138:443 (Relay (Client))
[XVEBW] 2016/05/26 16:02:31.515632 model.go:1044: INFO: Device G7PJ4UV client is "syncthing v0.13.4" named "killerdeathman"
[XVEBW] 2016/05/26 16:02:32.590694 service.go:229: INFO: Established secure connection to 44HMFSN at 10.160.95.179:55590-23.92.71.120:443 (Relay (Client))
[XVEBW] 2016/05/26 16:02:32.590694 model.go:1044: INFO: Device 44HMFSN client is "syncthing v0.13.4" named "pine64"
[XVEBW] 2016/05/26 16:02:32.627696 rwfolder.go:307: INFO: Completed initial scan (rw) of folder nhwhg_collab
[XVEBW] 2016/05/26 16:02:34.221787 rwfolder.go:307: INFO: Completed initial scan (rw) of folder eptesicus_forest_collab
[XVEBW] 2016/05/26 16:02:35.613867 model.go:756: INFO: Connection to G7PJ4UV closed: switching connections
[XVEBW] 2016/05/26 16:02:36.037891 model.go:756: INFO: Connection to G7PJ4UV closed: write tcp 10.160.95.179:55580->199.15.254.138:443: use of closed network connection
[XVEBW] 2016/05/26 16:02:38.037005 service.go:158: INFO: Failed to exchange Hello messages with 44HMFSN (108.31.56.174:22000): read tcp 10.160.95.179:55617->108.31.56.174:22000: i/o timeout
[XVEBW] 2016/05/26 16:02:38.224016 upnp.go:192: DEBUG: Discovery for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Local Area Connection finished.
[XVEBW] 2016/05/26 16:02:38.231016 upnp.go:192: DEBUG: Discovery for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Local Area Connection finished.
[XVEBW] 2016/05/26 16:02:38.237017 upnp.go:192: DEBUG: Discovery for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Loopback Pseudo-Interface 1 finished.
[XVEBW] 2016/05/26 16:02:38.241017 upnp.go:192: DEBUG: Discovery for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Loopback Pseudo-Interface 1 finished.
[XVEBW] 2016/05/26 16:02:38.241017 service.go:61: INFO: Detected 0 NAT devices
[XVEBW] 2016/05/26 16:02:38.776047 static.go:92: INFO: Joined relay relay://104.233.126.133:22067
[XVEBW] 2016/05/26 16:03:20.448431 service.go:229: INFO: Established secure connection to G7PJ4UV at 10.160.95.179:55669-104.233.126.133:22067 (Relay (Server))
[XVEBW] 2016/05/26 16:03:20.448431 model.go:1044: INFO: Device G7PJ4UV client is "syncthing v0.13.4" named "killerdeathman"
[XVEBW] 2016/05/26 16:04:30.792454 model.go:756: INFO: Connection to 44HMFSN closed: switching connections
[XVEBW] 2016/05/26 16:04:31.261481 model.go:756: INFO: Connection to 44HMFSN closed: write tcp 10.160.95.179:55590->23.92.71.120:443: use of closed network connection
[XVEBW] 2016/05/26 16:04:32.935577 model.go:756: INFO: Connection to 44HMFSN closed: switching connections
[XVEBW] 2016/05/26 16:04:33.369602 service.go:229: INFO: Established secure connection to 44HMFSN at 10.160.95.179:55633-108.31.56.174:22000 (TCP (Client))
[XVEBW] 2016/05/26 16:04:33.371602 model.go:1044: INFO: Device 44HMFSN client is "syncthing v0.13.4" named "pine64"
[XVEBW] 2016/05/26 16:04:37.670848 model.go:756: INFO: Connection to G7PJ4UV closed: switching connections
[XVEBW] 2016/05/26 16:04:40.314999 service.go:158: INFO: Failed to exchange Hello messages with 44HMFSN (108.31.56.174:22000): write tcp 10.160.95.179:55679->108.31.56.174:22000: wsasend: An existing connection was forcibly closed by the remote host.
[XVEBW] 2016/05/26 16:04:40.328000 model.go:756: INFO: Connection to G7PJ4UV closed: read tcp 10.160.95.179:55669->104.233.126.133:22067: use of closed network connection
[XVEBW] 2016/05/26 16:04:48.914491 service.go:229: INFO: Established secure connection to G7PJ4UV at 10.160.95.179:55686-104.171.113.18:10508 (Relay (Client))
[XVEBW] 2016/05/26 16:04:48.914491 model.go:1044: INFO: Device G7PJ4UV client is "syncthing v0.13.4" named "killerdeathman"
[XVEBW] 2016/05/26 16:05:05.701451 model.go:756: INFO: Connection to G7PJ4UV closed: switching connections
[XVEBW] 2016/05/26 16:05:06.448494 service.go:182: INFO: Connected to already connected device (44HMFSN)
[XVEBW] 2016/05/26 16:05:06.448494 model.go:756: INFO: Connection to G7PJ4UV closed: write tcp 10.160.95.179:55686->104.171.113.18:10508: use of closed network connection
[XVEBW] 2016/05/26 16:05:15.503012 service.go:229: INFO: Established secure connection to G7PJ4UV at 10.160.95.179:55692-104.233.126.133:22067 (Relay (Server))
[XVEBW] 2016/05/26 16:05:15.503012 model.go:1044: INFO: Device G7PJ4UV client is "syncthing v0.13.4" named "killerdeathman"

falkben · May 26, 2016, 8:11pm

HOME - behind router with UPnP:

[G7PJ4] 14:16:35 INFO: syncthing v0.13.4 "Copper Cockroach" (go1.6.2 windows-amd64) WIN-P6RP886TVDJ\Administrator@WIN-P6RP886TVDJ 2016-05-26 09:16:08 UTC
[G7PJ4] 14:16:35 INFO: My ID: G7PJ4UV
[G7PJ4] 14:16:36 INFO: Single thread hash performance is ~162 MB/s
[G7PJ4] 14:16:43 INFO: Ready to synchronize nhwhg_collab (readwrite)
[G7PJ4] 14:16:46 INFO: Ready to synchronize small_space_beampattern (readwrite)
[G7PJ4] 14:16:47 INFO: Ready to synchronize Videos (readonly)
[G7PJ4] 14:16:53 INFO: Ready to synchronize eptesicus_forest_collab (readwrite)
[G7PJ4] 14:16:53 INFO: Using discovery server https://discovery-v4-1.syncthing.net/v2/?id=SR7AARM
[G7PJ4] 14:16:53 INFO: Using discovery server https://discovery-v4-2.syncthing.net/v2/?id=DVU36WY
[G7PJ4] 14:16:53 INFO: Using discovery server https://discovery-v4-3.syncthing.net/v2/?id=VK6HNJ3
[G7PJ4] 14:16:53 INFO: Using discovery server https://discovery-v6-1.syncthing.net/v2/?id=SR7AARM
[G7PJ4] 14:16:53 INFO: Using discovery server https://discovery-v6-2.syncthing.net/v2/?id=DVU36WY
[G7PJ4] 14:16:53 INFO: Using discovery server https://discovery-v6-3.syncthing.net/v2/?id=VK6HNJ3
[G7PJ4] 14:16:53 INFO: TCP listener ([::]:22001) starting
[G7PJ4] 14:16:53 INFO: Device G7PJ4UV is "killerdeathman" at [dynamic]
[G7PJ4] 14:16:53 INFO: Device XVEBWC6 is "fuscination" at [dynamic]
[G7PJ4] 14:16:53 INFO: Device 44HMFSN is "pine64" at [dynamic]
[G7PJ4] 14:16:53 INFO: Starting usage reporting
[G7PJ4] 14:16:53 INFO: GUI and API listening on 127.0.0.1:8384
[G7PJ4] 14:16:53 INFO: Access the GUI via the following URL: http://localhost:8384/
[G7PJ4] 14:16:54 INFO: Completed initial scan (ro) of folder Videos
[G7PJ4] 14:17:04 INFO: New NAT port mapping: external TCP address 192.168.1.2:2665 to local address 0.0.0.0:22001.
[G7PJ4] 14:17:04 INFO: New NAT port mapping: external TCP address 192.168.1.2:2665 to local address 0.0.0.0:22001.
[G7PJ4] 14:17:04 INFO: Detected 2 NAT devices
[G7PJ4] 14:17:12 INFO: Completed initial scan (rw) of folder small_space_beampattern
[G7PJ4] 14:17:18 INFO: Established secure connection to 44HMFSN at [fe80::1c72:7b46:95bd:afce%Ethernet]:54996-[fe80::d02f:97ff:fe79:2820%Ethernet]:22000 (TCP (Client))
[G7PJ4] 14:17:18 INFO: Device 44HMFSN client is "syncthing v0.13.4" named "pine64"
[G7PJ4] 14:17:20 INFO: Connected to already connected device (44HMFSN)
[G7PJ4] 14:17:26 INFO: Completed initial scan (rw) of folder nhwhg_collab
[G7PJ4] 14:17:30 INFO: Completed initial scan (rw) of folder eptesicus_forest_collab
[G7PJ4] 14:24:31 INFO: TCP listener ([::]:22000) starting
[G7PJ4] 14:24:43 INFO: Joined relay relay://199.15.254.138:443
[G7PJ4] 14:26:48 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:55386-199.15.254.138:443 (Relay (Server))
[G7PJ4] 14:26:48 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 14:27:56 INFO: Connection to XVEBWC6 closed: EOF
[G7PJ4] 15:22:39 INFO: syncthing v0.13.4 "Copper Cockroach" (go1.6.2 windows-amd64) WIN-P6RP886TVDJ\Administrator@WIN-P6RP886TVDJ 2016-05-26 09:16:08 UTC
[G7PJ4] 15:22:39 INFO: My ID: G7PJ4UV
[G7PJ4] 15:22:39 INFO: Single thread hash performance is ~158 MB/s
[G7PJ4] 15:22:58 INFO: Ready to synchronize nhwhg_collab (readwrite)
[G7PJ4] 15:23:01 INFO: Ready to synchronize small_space_beampattern (readwrite)
[G7PJ4] 15:23:03 INFO: Ready to synchronize Videos (readonly)
[G7PJ4] 15:23:08 INFO: Ready to synchronize eptesicus_forest_collab (readwrite)
[G7PJ4] 15:23:08 INFO: Using discovery server https://discovery-v4-1.syncthing.net/v2/?id=SR7AARM
[G7PJ4] 15:23:08 INFO: Using discovery server https://discovery-v4-2.syncthing.net/v2/?id=DVU36WY
[G7PJ4] 15:23:08 INFO: Using discovery server https://discovery-v4-3.syncthing.net/v2/?id=VK6HNJ3
[G7PJ4] 15:23:08 INFO: Using discovery server https://discovery-v6-1.syncthing.net/v2/?id=SR7AARM
[G7PJ4] 15:23:08 INFO: Using discovery server https://discovery-v6-2.syncthing.net/v2/?id=DVU36WY
[G7PJ4] 15:23:08 INFO: Using discovery server https://discovery-v6-3.syncthing.net/v2/?id=VK6HNJ3
[G7PJ4] 15:23:08 INFO: TCP listener ([::]:22000) starting
[G7PJ4] 15:23:08 INFO: Device G7PJ4UV is "killerdeathman" at [dynamic]
[G7PJ4] 15:23:08 INFO: Device XVEBWC6 is "fuscination" at [dynamic]
[G7PJ4] 15:23:08 INFO: Device 44HMFSN is "pine64" at [dynamic]
[G7PJ4] 15:23:08 INFO: Starting usage reporting
[G7PJ4] 15:23:08 INFO: GUI and API listening on 127.0.0.1:8384
[G7PJ4] 15:23:08 INFO: Access the GUI via the following URL: http://localhost:8384/
[G7PJ4] 15:23:10 INFO: Completed initial scan (ro) of folder Videos
[G7PJ4] 15:23:19 INFO: Joined relay relay://104.171.113.18:10508
[G7PJ4] 15:23:19 INFO: New NAT port mapping: external TCP address 192.168.1.2:5877 to local address 0.0.0.0:22000.
[G7PJ4] 15:23:19 INFO: New NAT port mapping: external TCP address 192.168.1.2:5877 to local address 0.0.0.0:22000.
[G7PJ4] 15:23:19 INFO: Detected 2 NAT devices
[G7PJ4] 15:23:34 INFO: Completed initial scan (rw) of folder small_space_beampattern
[G7PJ4] 15:23:38 INFO: Established secure connection to 44HMFSN at [fe80::1c72:7b46:95bd:afce%Ethernet]:50050-[fe80::d02f:97ff:fe79:2820%Ethernet]:22000 (TCP (Client))
[G7PJ4] 15:23:38 INFO: Device 44HMFSN client is "syncthing v0.13.4" named "pine64"
[G7PJ4] 15:23:53 INFO: Completed initial scan (rw) of folder nhwhg_collab
[G7PJ4] 15:24:07 INFO: Completed initial scan (rw) of folder eptesicus_forest_collab
[G7PJ4] 15:30:10 INFO: Shutting down
[G7PJ4] 15:30:10 INFO: Exiting
[G7PJ4] 15:31:05 INFO: syncthing v0.13.4 "Copper Cockroach" (go1.6.2 windows-amd64) WIN-P6RP886TVDJ\Administrator@WIN-P6RP886TVDJ 2016-05-26 09:16:08 UTC
[G7PJ4] 15:31:05 INFO: My ID: G7PJ4UV
[G7PJ4] 15:31:05 INFO: Single thread hash performance is ~161 MB/s
[G7PJ4] 15:31:08 INFO: Ready to synchronize Videos (readonly)
[G7PJ4] 15:31:13 INFO: Ready to synchronize eptesicus_forest_collab (readwrite)
[G7PJ4] 15:31:18 INFO: Ready to synchronize nhwhg_collab (readwrite)
[G7PJ4] 15:31:21 INFO: Ready to synchronize small_space_beampattern (readwrite)
[G7PJ4] 15:31:21 INFO: Using discovery server https://discovery-v4-1.syncthing.net/v2/?id=SR7AARM
[G7PJ4] 15:31:21 INFO: Using discovery server https://discovery-v4-2.syncthing.net/v2/?id=DVU36WY
[G7PJ4] 15:31:21 INFO: Using discovery server https://discovery-v4-3.syncthing.net/v2/?id=VK6HNJ3
[G7PJ4] 15:31:21 INFO: Using discovery server https://discovery-v6-1.syncthing.net/v2/?id=SR7AARM
[G7PJ4] 15:31:21 INFO: Using discovery server https://discovery-v6-2.syncthing.net/v2/?id=DVU36WY
[G7PJ4] 15:31:21 INFO: Using discovery server https://discovery-v6-3.syncthing.net/v2/?id=VK6HNJ3
[G7PJ4] 15:31:21 INFO: TCP listener ([::]:22000) starting
[G7PJ4] 15:31:21 INFO: Device G7PJ4UV is "killerdeathman" at [dynamic]
[G7PJ4] 15:31:21 INFO: Device XVEBWC6 is "fuscination" at [dynamic]
[G7PJ4] 15:31:21 INFO: Device 44HMFSN is "pine64" at [dynamic]
[G7PJ4] 15:31:21 INFO: Starting usage reporting
[G7PJ4] 15:31:21 INFO: GUI and API listening on 127.0.0.1:8384
[G7PJ4] 15:31:21 INFO: Access the GUI via the following URL: http://localhost:8384/
[G7PJ4] 15:31:21 INFO: Completed initial scan (ro) of folder Videos
[G7PJ4] 15:31:32 INFO: Joined relay relay://199.15.254.138:443
[G7PJ4] 15:31:32 INFO: New NAT port mapping: external TCP address 192.168.1.2:5877 to local address 0.0.0.0:22000.
[G7PJ4] 15:31:32 INFO: New NAT port mapping: external TCP address 192.168.1.2:5877 to local address 0.0.0.0:22000.
[G7PJ4] 15:31:32 INFO: Detected 2 NAT devices
[G7PJ4] 15:31:39 INFO: Completed initial scan (rw) of folder small_space_beampattern
[G7PJ4] 15:31:50 INFO: Completed initial scan (rw) of folder nhwhg_collab
[G7PJ4] 15:31:54 INFO: Established secure connection to 44HMFSN at [fe80::1c72:7b46:95bd:afce%Ethernet]:50356-[fe80::d02f:97ff:fe79:2820%Ethernet]:22000 (TCP (Client))
[G7PJ4] 15:31:54 INFO: Device 44HMFSN client is "syncthing v0.13.4" named "pine64"
[G7PJ4] 15:31:54 INFO: Completed initial scan (rw) of folder eptesicus_forest_collab
[G7PJ4] 15:34:16 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50378-199.15.254.138:443 (Relay (Server))
[G7PJ4] 15:34:16 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 15:34:22 INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50378->199.15.254.138:443: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 15:34:25 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50380-199.15.254.138:443 (Relay (Server))
[G7PJ4] 15:34:25 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 15:35:51 INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50380->199.15.254.138:443: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 15:35:51 INFO: Connected to already connected device (XVEBWC6)
[G7PJ4] 15:35:55 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50389-199.15.254.138:443 (Relay (Server))
[G7PJ4] 15:35:55 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 15:37:05 INFO: Connection to XVEBWC6 closed: unexpected EOF
[G7PJ4] 15:37:56 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50408-192.99.235.194:22067 (Relay (Client))
[G7PJ4] 15:37:56 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 15:38:17 INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50408->192.99.235.194:22067: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 15:46:05 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50512-199.15.254.138:443 (Relay (Server))
[G7PJ4] 15:46:05 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 15:46:22 INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50512->199.15.254.138:443: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 15:47:55 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50531-192.99.235.194:22067 (Relay (Client))
[G7PJ4] 15:47:55 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 15:48:41 INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50531->192.99.235.194:22067: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 15:56:16 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50599-199.15.254.138:443 (Relay (Server))
[G7PJ4] 15:56:16 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 15:56:43 INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50599->199.15.254.138:443: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 15:58:05 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50618-192.99.235.194:22067 (Relay (Client))
[G7PJ4] 15:58:05 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 15:59:48 INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50618->192.99.235.194:22067: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 16:02:34 INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50701-199.15.254.138:443 (Relay (Server))
[G7PJ4] 16:02:34 INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 16:02:38 INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50701->199.15.254.138:443: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 16:03:02 INFO: Enabled debug data for "nat"
[G7PJ4] 16:03:02 INFO: Enabled debug data for "upnp"
[G7PJ4] 16:03:08 INFO: Restarting
[G7PJ4] 16:03:08 INFO: Exiting
[G7PJ4] 2016/05/26 16:03:09.140553 main.go:561: INFO: syncthing v0.13.4 "Copper Cockroach" (go1.6.2 windows-amd64) WIN-P6RP886TVDJ\Administrator@WIN-P6RP886TVDJ 2016-05-26 09:16:08 UTC
[G7PJ4] 2016/05/26 16:03:09.142053 main.go:562: INFO: My ID: G7PJ4UV
[G7PJ4] 2016/05/26 16:03:09.446092 main.go:853: INFO: Single thread hash performance is ~162 MB/s
[G7PJ4] 2016/05/26 16:03:11.019791 model.go:209: INFO: Ready to synchronize Videos (readonly)
[G7PJ4] 2016/05/26 16:03:15.735605 model.go:209: INFO: Ready to synchronize eptesicus_forest_collab (readwrite)
[G7PJ4] 2016/05/26 16:03:19.367675 model.go:209: INFO: Ready to synchronize nhwhg_collab (readwrite)
[G7PJ4] 2016/05/26 16:03:21.690072 model.go:209: INFO: Ready to synchronize small_space_beampattern (readwrite)
[G7PJ4] 2016/05/26 16:03:21.690072 main.go:705: INFO: Using discovery server https://discovery-v4-1.syncthing.net/v2/?id=SR7AARM
[G7PJ4] 2016/05/26 16:03:21.690072 main.go:705: INFO: Using discovery server https://discovery-v4-2.syncthing.net/v2/?id=DVU36WY
[G7PJ4] 2016/05/26 16:03:21.690572 main.go:705: INFO: Using discovery server https://discovery-v4-3.syncthing.net/v2/?id=VK6HNJ3
[G7PJ4] 2016/05/26 16:03:21.691072 tcp_listen.go:69: INFO: TCP listener ([::]:22000) starting
[G7PJ4] 2016/05/26 16:03:22.281147 main.go:705: INFO: Using discovery server https://discovery-v6-1.syncthing.net/v2/?id=SR7AARM
[G7PJ4] 2016/05/26 16:03:22.281147 main.go:705: INFO: Using discovery server https://discovery-v6-2.syncthing.net/v2/?id=DVU36WY
[G7PJ4] 2016/05/26 16:03:22.281147 main.go:705: INFO: Using discovery server https://discovery-v6-3.syncthing.net/v2/?id=VK6HNJ3
[G7PJ4] 2016/05/26 16:03:22.304150 main.go:750: INFO: Device G7PJ4UV is "killerdeathman" at [dynamic]
[G7PJ4] 2016/05/26 16:03:22.306150 main.go:750: INFO: Device XVEBWC6 is "fuscination" at [dynamic]
[G7PJ4] 2016/05/26 16:03:22.306651 main.go:750: INFO: Device 44HMFSN is "pine64" at [dynamic]
[G7PJ4] 2016/05/26 16:03:22.307151 usage_report.go:264: INFO: Starting usage reporting
[G7PJ4] 2016/05/26 16:03:22.320152 gui.go:347: INFO: GUI and API listening on 127.0.0.1:8384
[G7PJ4] 2016/05/26 16:03:22.320152 gui.go:348: INFO: Access the GUI via the following URL: http://localhost:8384/
[G7PJ4] 2016/05/26 16:03:22.692699 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Ethernet
[G7PJ4] 2016/05/26 16:03:22.693199 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Teredo Tunneling Pseudo-Interface
[G7PJ4] 2016/05/26 16:03:22.694699 upnp.go:154: DEBUG: listen udp4 0.0.0.0:52749->239.255.255.250: setsockopt: no such network interface
[G7PJ4] 2016/05/26 16:03:22.694699 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Ethernet
[G7PJ4] 2016/05/26 16:03:22.695699 upnp.go:165: DEBUG: Sending search request for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Ethernet
[G7PJ4] 2016/05/26 16:03:22.695699 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Teredo Tunneling Pseudo-Interface
[G7PJ4] 2016/05/26 16:03:22.697200 upnp.go:154: DEBUG: listen udp4 0.0.0.0:52751->239.255.255.250: setsockopt: no such network interface
[G7PJ4] 2016/05/26 16:03:22.697200 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on isatap.{6482FEF5-1A87-48D5-80EF-46E642D80C4F}
[G7PJ4] 2016/05/26 16:03:22.697200 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on isatap.{6482FEF5-1A87-48D5-80EF-46E642D80C4F}
[G7PJ4] 2016/05/26 16:03:22.697200 upnp.go:173: DEBUG: Listening for UPnP response for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Ethernet
[G7PJ4] 2016/05/26 16:03:22.697200 upnp.go:165: DEBUG: Sending search request for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Ethernet
[G7PJ4] 2016/05/26 16:03:22.697200 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Loopback Pseudo-Interface 1
[G7PJ4] 2016/05/26 16:03:22.697200 upnp.go:150: DEBUG: Starting discovery of device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Loopback Pseudo-Interface 1
[G7PJ4] 2016/05/26 16:03:22.697200 upnp.go:173: DEBUG: Listening for UPnP response for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Ethernet
[G7PJ4] 2016/05/26 16:03:22.728204 upnp.go:154: DEBUG: listen udp4 0.0.0.0:52752->239.255.255.250: setsockopt: no such network interface
[G7PJ4] 2016/05/26 16:03:22.731705 upnp.go:154: DEBUG: listen udp4 0.0.0.0:52753->239.255.255.250: setsockopt: no such network interface
[G7PJ4] 2016/05/26 16:03:22.736205 upnp.go:165: DEBUG: Sending search request for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Loopback Pseudo-Interface 1
[G7PJ4] 2016/05/26 16:03:22.737705 upnp.go:173: DEBUG: Listening for UPnP response for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Loopback Pseudo-Interface 1
[G7PJ4] 2016/05/26 16:03:22.740706 upnp.go:165: DEBUG: Sending search request for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Loopback Pseudo-Interface 1
[G7PJ4] 2016/05/26 16:03:22.741206 upnp.go:173: DEBUG: Listening for UPnP response for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Loopback Pseudo-Interface 1
[G7PJ4] 2016/05/26 16:03:22.748706 upnp.go:196: DEBUG: Handling UPnP response:
HTTP/1.1 200 OK
CACHE-CONTROL: max-age=120
ST: urn:schemas-upnp-org:device:InternetGatewayDevice:1
USN: uuid:0bb7e645-02c6-40f3-8954-48297866d2eb::urn:schemas-upnp-org:device:InternetGatewayDevice:1
EXT:
SERVER: AsusWRT/380.58 UPnP/1.1 MiniUPnPd/1.9
LOCATION: http://192.168.11.1:49329/rootDesc.xml
OPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01
01-NLS: 1464283356
BOOTID.UPNP.ORG: 1464283356
CONFIGID.UPNP.ORG: 1337
[G7PJ4] 2016/05/26 16:03:22.750706 upnp.go:196: DEBUG: Handling UPnP response:
HTTP/1.1 200 OK
CACHE-CONTROL: max-age=120
ST: urn:schemas-upnp-org:device:InternetGatewayDevice:2
USN: uuid:0bb7e645-02c6-40f3-8954-48297866d2eb::urn:schemas-upnp-org:device:InternetGatewayDevice:2
EXT:
SERVER: AsusWRT/380.58 UPnP/1.1 MiniUPnPd/1.9
LOCATION: http://192.168.11.1:49329/rootDesc.xml
OPT: "http://schemas.upnp.org/upnp/1/0/"; ns=01
01-NLS: 1464283356
BOOTID.UPNP.ORG: 1464283356
CONFIGID.UPNP.ORG: 1337
[G7PJ4] 2016/05/26 16:03:22.754207 upnp.go:354: DEBUG: http://192.168.11.1:49329/rootDesc.xml - no services of type urn:schemas-upnp-org:service:WANIPConnection:1  found on connection.
[G7PJ4] 2016/05/26 16:03:22.754207 upnp.go:363: DEBUG: http://192.168.11.1:49329/rootDesc.xml - found urn:schemas-upnp-org:service:WANIPConnection:1 with URL http://192.168.11.1:49329/ctl/IPConn
[G7PJ4] 2016/05/26 16:03:22.754207 upnp.go:354: DEBUG: http://192.168.11.1:49329/rootDesc.xml - no services of type urn:schemas-upnp-org:service:WANPPPConnection:1  found on connection.
[G7PJ4] 2016/05/26 16:03:22.755207 upnp.go:354: DEBUG: http://192.168.11.1:49329/rootDesc.xml - no services of type urn:schemas-upnp-org:service:WANIPConnection:1  found on connection.
[G7PJ4] 2016/05/26 16:03:22.755207 upnp.go:363: DEBUG: http://192.168.11.1:49329/rootDesc.xml - found urn:schemas-upnp-org:service:WANIPConnection:1 with URL http://192.168.11.1:49329/ctl/IPConn
[G7PJ4] 2016/05/26 16:03:22.755707 upnp.go:354: DEBUG: http://192.168.11.1:49329/rootDesc.xml - no services of type urn:schemas-upnp-org:service:WANPPPConnection:1  found on connection.
[G7PJ4] 2016/05/26 16:03:22.786711 upnp.go:124: DEBUG: UPnP discovery result 0bb7e645-02c6-40f3-8954-48297866d2eb with services:
[G7PJ4] 2016/05/26 16:03:22.786711 upnp.go:126: DEBUG: * [urn:upnp-org:serviceId:WANIPConn1] http://192.168.11.1:49329/ctl/IPConn
[G7PJ4] 2016/05/26 16:03:22.789711 upnp.go:115: DEBUG: Skipping duplicate result 0bb7e645-02c6-40f3-8954-48297866d2eb with services:
[G7PJ4] 2016/05/26 16:03:22.789711 upnp.go:117: DEBUG: * [urn:upnp-org:serviceId:WANIPConn1] http://192.168.11.1:49329/ctl/IPConn
[G7PJ4] 2016/05/26 16:03:22.825216 rofolder.go:79: INFO: Completed initial scan (ro) of folder Videos
[G7PJ4] 2016/05/26 16:03:22.911727 service.go:229: INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50729-104.233.126.133:22067 (Relay (Client))
[G7PJ4] 2016/05/26 16:03:22.911727 model.go:1044: INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 2016/05/26 16:03:32.696272 upnp.go:192: DEBUG: Discovery for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Ethernet finished.
[G7PJ4] 2016/05/26 16:03:32.697272 upnp.go:192: DEBUG: Discovery for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Ethernet finished.
[G7PJ4] 2016/05/26 16:03:32.736277 upnp.go:192: DEBUG: Discovery for device type urn:schemas-upnp-org:device:InternetGatewayDevice:1 on Loopback Pseudo-Interface 1 finished.
[G7PJ4] 2016/05/26 16:03:32.741277 upnp.go:192: DEBUG: Discovery for device type urn:schemas-upnp-org:device:InternetGatewayDevice:2 on Loopback Pseudo-Interface 1 finished.
[G7PJ4] 2016/05/26 16:03:32.741277 service.go:264: DEBUG: Acquiring TCP 0.0.0.0:22000 mapping on NAT-PMP@192.168.11.1
[G7PJ4] 2016/05/26 16:03:32.757780 service.go:272: DEBUG: Acquired TCP 0.0.0.0:22000 -> 192.168.1.2:5877 mapping on NAT-PMP@192.168.11.1
[G7PJ4] 2016/05/26 16:03:32.757780 structs.go:32: INFO: New NAT port mapping: external TCP address 192.168.1.2:5877 to local address 0.0.0.0:22000.
[G7PJ4] 2016/05/26 16:03:32.757780 service.go:264: DEBUG: Acquiring TCP 0.0.0.0:22000 mapping on 0bb7e645-02c6-40f3-8954-48297866d2eb
[G7PJ4] 2016/05/26 16:03:32.757780 upnp.go:423: DEBUG: SOAP Request URL: http://192.168.11.1:49329/ctl/IPConn
[G7PJ4] 2016/05/26 16:03:32.757780 upnp.go:424: DEBUG: SOAP Action: 
[G7PJ4] 2016/05/26 16:03:32.757780 upnp.go:425: DEBUG: SOAP Request:
<?xml version="1.0" ?>
	<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/">
	<s:Body><u:AddPortMapping xmlns:u="urn:schemas-upnp-org:service:WANIPConnection:1">
	<NewRemoteHost></NewRemoteHost>
	<NewExternalPort>5877</NewExternalPort>
	<NewProtocol>TCP</NewProtocol>
	<NewInternalPort>22000</NewInternalPort>
	<NewInternalClient>192.168.11.51</NewInternalClient>
	<NewEnabled>1</NewEnabled>
	<NewPortMappingDescription>syncthing-5877</NewPortMappingDescription>
	<NewLeaseDuration>3600</NewLeaseDuration>
	</u:AddPortMapping></s:Body>
	</s:Envelope>
[G7PJ4] 2016/05/26 16:03:32.760780 upnp.go:434: DEBUG: SOAP Response: 200 OK
<?xml version="1.0"?>
<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:AddPortMappingResponse xmlns:u="urn:schemas-upnp-org:service:WANIPConnection:1"/></s:Body></s:Envelope>
[G7PJ4] 2016/05/26 16:03:32.761279 upnp.go:423: DEBUG: SOAP Request URL: http://192.168.11.1:49329/ctl/IPConn
[G7PJ4] 2016/05/26 16:03:32.761279 upnp.go:424: DEBUG: SOAP Action: 
[G7PJ4] 2016/05/26 16:03:32.761279 upnp.go:425: DEBUG: SOAP Request:
<?xml version="1.0" ?>
	<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/">
	<s:Body><u:GetExternalIPAddress xmlns:u="urn:schemas-upnp-org:service:WANIPConnection:1" /></s:Body>
	</s:Envelope>
[G7PJ4] 2016/05/26 16:03:32.762780 upnp.go:434: DEBUG: SOAP Response: 200 OK
<?xml version="1.0"?>
<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/"><s:Body><u:GetExternalIPAddressResponse xmlns:u="urn:schemas-upnp-org:service:WANIPConnection:1"><NewExternalIPAddress>192.168.1.2</NewExternalIPAddress></u:GetExternalIPAddressResponse></s:Body></s:Envelope>
[G7PJ4] 2016/05/26 16:03:32.762780 service.go:272: DEBUG: Acquired TCP 0.0.0.0:22000 -> 192.168.1.2:5877 mapping on 0bb7e645-02c6-40f3-8954-48297866d2eb
[G7PJ4] 2016/05/26 16:03:32.762780 structs.go:32: INFO: New NAT port mapping: external TCP address 192.168.1.2:5877 to local address 0.0.0.0:22000.
[G7PJ4] 2016/05/26 16:03:32.762780 service.go:61: INFO: Detected 2 NAT devices
[G7PJ4] 2016/05/26 16:03:33.778014 static.go:92: INFO: Joined relay relay://104.171.113.18:10508
[G7PJ4] 2016/05/26 16:04:02.119044 rwfolder.go:307: INFO: Completed initial scan (rw) of folder small_space_beampattern
[G7PJ4] 2016/05/26 16:04:29.914015 rwfolder.go:307: INFO: Completed initial scan (rw) of folder nhwhg_collab
[G7PJ4] 2016/05/26 16:04:37.200144 service.go:158: INFO: Failed to exchange Hello messages with 44HMFSN (192.168.11.53:36492): read tcp 192.168.11.51:22000->192.168.11.53:36492: i/o timeout
[G7PJ4] 2016/05/26 16:04:37.786718 rwfolder.go:307: INFO: Completed initial scan (rw) of folder eptesicus_forest_collab
[G7PJ4] 2016/05/26 16:04:39.201002 service.go:158: INFO: Failed to exchange Hello messages with 44HMFSN ([fe80::d02f:97ff:fe79:2820%Ethernet]:22000): read tcp [fe80::1c72:7b46:95bd:afce%Ethernet]:50859->[fe80::d02f:97ff:fe79:2820%Ethernet]:22000: i/o timeout
[G7PJ4] 2016/05/26 16:04:42.863033 model.go:756: INFO: Connection to XVEBWC6 closed: EOF
[G7PJ4] 2016/05/26 16:04:51.477372 service.go:229: INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50917-104.171.113.18:10508 (Relay (Server))
[G7PJ4] 2016/05/26 16:04:51.477873 model.go:1044: INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 2016/05/26 16:05:01.295039 service.go:229: INFO: Established secure connection to 44HMFSN at [fe80::1c72:7b46:95bd:afce%Ethernet]:50920-[fe80::d02f:97ff:fe79:2820%Ethernet]:22000 (TCP (Client))
[G7PJ4] 2016/05/26 16:05:01.295039 model.go:1044: INFO: Device 44HMFSN client is "syncthing v0.13.4" named "pine64"
[G7PJ4] 2016/05/26 16:05:10.125964 model.go:756: INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50917->104.171.113.18:10508: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 2016/05/26 16:05:17.970681 service.go:229: INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50923-104.233.126.133:22067 (Relay (Client))
[G7PJ4] 2016/05/26 16:05:17.971182 model.go:1044: INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 2016/05/26 16:06:22.492077 model.go:756: INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50923->104.233.126.133:22067: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 2016/05/26 16:06:52.558984 service.go:229: INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50940-104.233.126.133:22067 (Relay (Client))
[G7PJ4] 2016/05/26 16:06:52.558984 model.go:1044: INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 2016/05/26 16:07:35.020714 model.go:756: INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50940->104.233.126.133:22067: wsasend: An existing connection was forcibly closed by the remote host.
[G7PJ4] 2016/05/26 16:08:39.773201 service.go:229: INFO: Established secure connection to XVEBWC6 at 192.168.11.51:50951-104.171.113.18:10508 (Relay (Server))
[G7PJ4] 2016/05/26 16:08:39.773702 model.go:1044: INFO: Device XVEBWC6 client is "syncthing v0.13.4" named "fuscination"
[G7PJ4] 2016/05/26 16:09:53.508136 model.go:756: INFO: Connection to XVEBWC6 closed: write tcp 192.168.11.51:50951->104.171.113.18:10508: wsasend: An existing connection was forcibly closed by the remote host.

AudriusButkevicius · May 26, 2016, 8:26pm

So the work logs are not of interest to us.

Do you run the router at home behind another router? Because it’s reporting it’s external IP as 192.168.1.2

falkben · May 26, 2016, 9:40pm

Yes behind another router. The internet topology has not changed though. I have the second router set as DMZ.

AudriusButkevicius · May 26, 2016, 10:27pm

In 0.13 we’ve started reporting the external address that the router reports, so that’s your issue.

But I’ve made a pull request which although does the wrong thing, but brings the functionality back:

falkben · May 27, 2016, 2:57pm

Thank you very much!

I’m just curious, why wouldn’t you use a service to pull down the external address?

AudriusButkevicius · May 27, 2016, 3:08pm

The discovery servers already know this, it’s just that arguably the router should be more correct, as it’s aware of how the routing should be performed.

system · June 26, 2016, 3:16pm

This topic was automatically closed 30 days after the last reply. New replies are no longer allowed.