gistfile1.txt

[IDID_0] 2017/11/18 15:03:20.412509 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:03:20.489335 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:03:23.122014 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:03:23.234603 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:03:23.234603 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:06:25.5398696 +0200 IST m=+67427.827694501 and current time is 2017-11-18 15:03:10.6367164 +0200 IST m=+67232.924541301
[IDID_0] 2017/11/18 15:03:23.234603 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:03:32.1016647 +0200 IST m=+67254.389489601 and current time is 2017-11-18 15:03:10.6367164 +0200 IST m=+67232.924541301
[IDID_0] 2017/11/18 15:03:23.234603 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:03:23.234603 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:03:23.234603 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:03:23.234603 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:03:23.234603 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:03:23.998420 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:03:23.998420 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:03:23.998420 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:03:24.349260 service.go:421: DEBUG: sleep until next dial 21.4649483s
[IDID_0] 2017/11/18 15:03:33.122256 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:03:33.122256 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:03:33.233386 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:03:38.333441 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_83
[IDID_0] 2017/11/18 15:03:43.323030 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:03:43.609255 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:03:43.717876 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:03:45.814778 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:03:45.814778 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:03:45.858801 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:03:45.859802 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:03:45.860806 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:03:45.861803 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:03:45.861803 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:03:45.863808 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:03:45.863808 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:03:45.863808 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:03:55.688952 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:03:55.864554 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:03:55.864554 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 21.4649483s, next dial is at 2017-11-18 15:06:25.5398696 +0200 IST m=+67427.827694501 and current time is 2017-11-18 15:03:45.8147782 +0200 IST m=+67268.102603101
[IDID_0] 2017/11/18 15:03:55.864554 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:03:56.869270 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:03:56.869270 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:03:56.869270 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:03:56.917543 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:03:56.920544 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:03:56.922549 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:03:56.924550 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:03:56.927550 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:03:56.930555 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:03:56.933554 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:03:56.935558 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:04:05.694930 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:04:05.694930 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:04:05.793003 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:04:11.914102 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_264
[IDID_0] 2017/11/18 15:04:12.371481 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:04:12.396992 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:04:20.936181 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:04:20.936181 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:04:20.936181 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:04:20.936181 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:04:21.260437 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:04:21.260437 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:04:21.260437 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:04:21.314958 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:04:21.314958 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:04:21.314958 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:04:22.371827 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:04:22.371827 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:04:22.472900 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:04:31.315041 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:04:31.315041 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:06:25.5398696 +0200 IST m=+67427.827694501 and current time is 2017-11-18 15:04:20.9361818 +0200 IST m=+67303.224006601
[IDID_0] 2017/11/18 15:04:31.315041 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:04:45.8147782 +0200 IST m=+67328.102603101 and current time is 2017-11-18 15:04:20.9361818 +0200 IST m=+67303.224006601
[IDID_0] 2017/11/18 15:04:31.315041 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:04:31.315041 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:04:31.315041 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:04:31.315041 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:04:31.315535 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:04:31.315535 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:04:31.315535 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:04:31.315535 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:04:31.315535 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:04:31.PORT_2545 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:04:41.472734 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:04:43.199797 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:04:53.203590 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:04:53.206590 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_202
[IDID_0] 2017/11/18 15:04:53.720444 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:04:53.757049 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:04:53.826127 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:04:55.316284 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:04:55.316284 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:04:55.359041 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:04:55.360043 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:04:55.361044 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:04:55.362044 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:04:55.362044 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:04:55.364045 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:04:55.364045 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:04:55.364045 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:05:03.656217 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:05:03.764796 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:05:05.364998 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:05:05.364998 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:06:25.5398696 +0200 IST m=+67427.827694501 and current time is 2017-11-18 15:04:55.3162841 +0200 IST m=+67337.604109001
[IDID_0] 2017/11/18 15:05:05.364998 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:05:06.367549 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:05:06.367549 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:05:06.367549 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:05:06.408579 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:05:06.409580 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:05:06.4PORT_11 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:05:06.411580 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:05:06.873909 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:05:06.875908 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:05:06.877909 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:05:06.880911 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:05:16.482548 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:05:26.482662 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:05:27.255542 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:05:30.881260 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:05:30.881260 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:05:30.881260 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:05:30.881260 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:05:30.881260 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:05:30.881260 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:05:30.881260 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:05:30.884259 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:05:30.884259 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:05:30.884259 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:05:37.263249 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:05:37.264249 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_519
[IDID_0] 2017/11/18 15:05:37.965299 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:05:38.015835 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:05:38.033849 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:05:38.062867 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:05:38.144929 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:05:40.884771 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:05:40.884771 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:06:25.5398696 +0200 IST m=+67427.827694501 and current time is 2017-11-18 15:05:30.8812608 +0200 IST m=+67373.169085701
[IDID_0] 2017/11/18 15:05:40.884771 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:05:55.3162841 +0200 IST m=+67397.604109001 and current time is 2017-11-18 15:05:30.8812608 +0200 IST m=+67373.169085701
[IDID_0] 2017/11/18 15:05:40.884771 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:05:40.884771 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:05:40.884771 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:05:40.884771 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:05:40.884771 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:05:40.884771 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:05:40.884771 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:05:40.884771 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:05:41.294967 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:05:48.916371 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:05:58.929412 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:06:03.827973 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:06:03.939106 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:06:04.336976 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_204
[IDID_0] 2017/11/18 15:06:04.754155 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:06:05.331097 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:06:05.331097 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:06:05.375177 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:06:05.378180 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:06:07.015958 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:06:07.016958 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:06:07.016958 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:06:07.079734 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:06:07.079734 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:06:07.079734 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:06:08.884768 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:06:17.079960 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:06:17.079960 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:06:25.5398696 +0200 IST m=+67427.827694501 and current time is 2017-11-18 15:06:05.3310974 +0200 IST m=+67407.618922301
[IDID_0] 2017/11/18 15:06:17.079960 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:06:18.120265 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:06:18.120265 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:06:18.120265 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:06:18.182381 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:06:18.184384 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:06:18.185383 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:06:18.187385 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:06:18.188387 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:06:18.737859 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:06:18.737859 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:06:19.335278 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:06:22.274643 service.go:421: DEBUG: sleep until next dial 20.2087722s
[IDID_0] 2017/11/18 15:06:33.184661 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:06:33.304601 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:06:33.926318 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:06:42.485541 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:06:42.485541 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:06:42.485541 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:06:42.485541 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:06:42.485541 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:06:42.485541 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:06:42.485541 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:06:42.486541 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:06:42.486541 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:06:42.490048 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:06:43.927249 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:06:47.826633 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:06:47.923702 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:06:52.490985 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:06:52.490985 service.go:400: DEBUG: dial IDIDID_9 relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german
[IDID_0] 2017/11/18 15:06:52.911148 service.go:405: DEBUG: dial failed IDIDID_9 relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german Incorrect response code 1: not found
[IDID_0] 2017/11/18 15:06:52.911148 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 20.2087722s, next dial is at 2017-11-18 15:07:05.3310974 +0200 IST m=+67467.618922301 and current time is 2017-11-18 15:06:42.4855411 +0200 IST m=+67444.773366001
[IDID_0] 2017/11/18 15:06:52.911148 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:06:52.911148 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:06:52.911148 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:06:52.911148 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:06:52.911148 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:06:52.911148 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:06:52.911148 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:06:52.911148 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:06:52.911148 service.go:421: DEBUG: sleep until next dial 22.8455563s
[IDID_0] 2017/11/18 15:06:54.146138 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_468
[IDID_0] 2017/11/18 15:06:54.544595 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:06:55.499014 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:07:05.499086 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:07:05.499086 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:07:05.602776 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:07:11.028078 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:07:15.767715 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:07:15.767715 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:07:15.818751 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:07:15.827529 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:07:15.836534 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:07:17.294589 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:07:17.294589 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:07:17.304595 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:07:17.304595 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:07:17.304595 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:07:21.034332 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:07:21.088368 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:07:21.306524 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_150
[IDID_0] 2017/11/18 15:07:21.352773 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:07:22.129699 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:07:27.499273 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:07:27.499273 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:07:27.499273 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 22.8455563s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:07:15.767715 +0200 IST m=+67478.055539901
[IDID_0] 2017/11/18 15:07:27.499273 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:07:28.511111 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:07:28.511111 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:07:28.511111 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:07:28.578162 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:07:28.584166 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:07:28.585167 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:07:28.586168 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:07:28.586168 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:07:28.587169 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:07:28.PORT_4939 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:07:28.PORT_4939 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:07:37.510422 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:07:56.517063 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:07:56.517063 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:07:56.517063 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:07:56.517063 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:07:56.517063 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:07:56.517063 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:07:56.517063 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:07:56.526088 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:07:56.532071 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:07:56.532071 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:07:56.532071 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:08:06.526247 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:08:06.526247 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:08:06.532250 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:08:06.532250 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:07:56.5170637 +0200 IST m=+67518.804888501
[IDID_0] 2017/11/18 15:08:06.532250 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:08:15.767715 +0200 IST m=+67538.055539901 and current time is 2017-11-18 15:07:56.5170637 +0200 IST m=+67518.804888501
[IDID_0] 2017/11/18 15:08:06.532250 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:08:06.532250 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:08:06.532250 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:08:06.532250 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:08:06.532250 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:08:06.532250 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:08:06.532250 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:08:06.532250 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:08:06.713117 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_72
[IDID_0] 2017/11/18 15:08:06.751136 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:08:06.904927 service.go:421: DEBUG: sleep until next dial 19.2506514s
[IDID_0] 2017/11/18 15:08:07.839231 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:08:08.388848 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:08:08.443882 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:08:16.536428 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:08:26.555404 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:08:26.555404 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:08:26.557403 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:08:26.598977 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:08:26.602981 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:08:26.605983 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:08:28.300335 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:08:28.300335 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:08:28.838766 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:08:28.838766 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:08:28.838766 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:08:28.838766 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:08:28.9PORT_431 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:08:32.928244 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_129
[IDID_0] 2017/11/18 15:08:33.377277 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:08:35.086157 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:08:38.840151 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:08:38.840151 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 19.2506514s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:08:26.5554049 +0200 IST m=+67548.843229801
[IDID_0] 2017/11/18 15:08:38.840151 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:08:39.843556 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:08:39.843556 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:08:39.843556 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:08:39.888157 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:08:39.889160 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:08:39.891161 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:08:39.891661 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:08:39.892161 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:08:39.893162 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:08:39.894163 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:08:39.894663 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:08:45.087530 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:08:45.087530 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:08:45.243728 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:08:46.514805 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:08:56.515017 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:08:59.953219 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:09:00.077334 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:09:03.895397 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:09:03.895397 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:09:03.895397 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:09:03.895397 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:09:03.895397 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:09:03.895397 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:09:03.895397 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:09:03.903401 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:09:03.903401 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:09:03.903401 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:09:13.903565 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:09:13.903565 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:09:03.8953972 +0200 IST m=+67586.183222101
[IDID_0] 2017/11/18 15:09:13.903565 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:09:26.5554049 +0200 IST m=+67608.843229801 and current time is 2017-11-18 15:09:03.8953972 +0200 IST m=+67586.183222101
[IDID_0] 2017/11/18 15:09:13.903565 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:09:13.903565 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:09:13.903565 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:09:13.903565 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:09:13.903565 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:09:13.903565 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:09:13.903565 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:09:13.903565 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:09:13.903565 service.go:421: DEBUG: sleep until next dial 22.6600077s
[IDID_0] 2017/11/18 15:09:16.695291 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_176
[IDID_0] 2017/11/18 15:09:17.063541 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:09:20.092402 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:09:30.093633 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:09:31.668876 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:09:36.565863 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:09:36.565863 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:09:36.615470 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:09:36.617470 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:09:36.621476 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:09:36.624477 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:09:36.625475 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:09:36.687056 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:09:36.690056 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:09:36.692057 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:09:41.680072 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:09:41.681074 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:09:41.757123 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:09:41.785646 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:09:41.961271 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:09:44.239353 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_53
[IDID_0] 2017/11/18 15:09:44.637438 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:09:46.694953 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:09:46.694953 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 22.6600077s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:09:36.5658638 +0200 IST m=+67618.853688701
[IDID_0] 2017/11/18 15:09:46.700957 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:09:47.708829 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:09:47.708829 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:09:47.708829 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:09:47.748855 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:09:47.749857 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:09:47.750858 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:09:47.751857 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:09:50.034280 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:09:50.036283 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:09:50.037282 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:09:50.038283 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:09:54.314981 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:10:04.315145 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:10:08.518200 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:10:14.038952 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:10:14.038952 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:10:14.038952 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:10:14.038952 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:10:14.038952 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:10:14.038952 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:10:14.038952 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:10:14.039954 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:10:14.039954 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:10:14.039954 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:10:18.519387 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:10:18.519387 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:10:18.621558 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:10:18.632725 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:10:18.732927 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:10:24.040704 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:10:24.040704 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:10:14.0389526 +0200 IST m=+67656.326777501
[IDID_0] 2017/11/18 15:10:24.040704 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:10:36.5658638 +0200 IST m=+67678.853688701 and current time is 2017-11-18 15:10:14.0389526 +0200 IST m=+67656.326777501
[IDID_0] 2017/11/18 15:10:24.040704 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:10:24.040704 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:10:24.041703 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:10:24.041703 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:10:24.041703 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:10:24.041703 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:10:24.042704 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:10:24.042704 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:10:27.917542 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_213
[IDID_0] 2017/11/18 15:10:28.336716 service.go:247: INFO: Connected to already connected device (IDIDID_11)
[IDID_0] 2017/11/18 15:10:30.335252 service.go:421: DEBUG: sleep until next dial 22.5269112s
[IDID_0] 2017/11/18 15:10:39.326894 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:10:49.327747 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:10:51.789577 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:10:51.911258 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:10:52.720181 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:10:52.862525 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:10:52.862525 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:10:52.928222 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:10:52.929223 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:10:52.930224 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:10:52.932225 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:10:52.932225 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:10:52.934228 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:10:52.934228 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:10:52.934228 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:11:02.720633 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:11:02.935952 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:11:02.935952 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 22.5269112s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:10:52.8625252 +0200 IST m=+67695.1503PORT_41
[IDID_0] 2017/11/18 15:11:02.935952 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:11:03.947108 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:11:03.950105 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:11:03.950105 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:11:04.002359 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:11:04.004359 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:11:04.007367 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:11:04.010366 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:11:04.013366 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:11:04.015367 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:11:04.017368 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:11:04.020370 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:11:10.975047 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:11:11.095350 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:11:12.064972 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:11:22.065392 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:11:28.020540 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:11:28.020540 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:11:28.020540 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:11:28.020540 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:11:29.623882 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:11:29.623882 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:11:29.623882 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:11:29.677919 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:11:29.679920 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:11:29.679920 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:11:33.891211 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:11:39.682640 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:11:39.691644 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:11:28.0205408 +0200 IST m=+67730.308365701
[IDID_0] 2017/11/18 15:11:39.694646 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:11:52.8625252 +0200 IST m=+67755.1503PORT_41 and current time is 2017-11-18 15:11:28.0205408 +0200 IST m=+67730.308365701
[IDID_0] 2017/11/18 15:11:39.696647 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:11:39.697649 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:11:39.699650 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:11:39.699650 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:11:39.699650 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:11:39.699650 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:11:39.705654 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:11:39.705654 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:11:41.188949 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:11:43.892657 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:11:43.892657 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:11:44.013517 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:11:44.042646 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:11:44.110692 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:11:57.072945 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:12:05.194456 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:12:05.194456 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:12:05.239500 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:12:05.240501 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:12:05.675862 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:12:05.676862 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:12:05.678864 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:12:05.679864 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:12:05.679864 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:12:05.679864 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:12:07.073070 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:12:07.073070 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:12:07.270314 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:12:15.681277 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:12:15.693280 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:12:05.1944562 +0200 IST m=+67767.482281101
[IDID_0] 2017/11/18 15:12:15.696283 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:12:16.702923 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:12:16.702923 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:12:16.702923 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:12:16.752956 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:12:16.752956 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:12:16.754958 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:12:16.754958 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:12:16.755958 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:12:16.756959 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:12:16.756959 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:12:16.757959 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:12:25.260100 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:12:35.262059 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:12:35.262059 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:12:40.758795 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:12:40.758795 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:12:40.758795 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:12:40.758795 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:12:40.758795 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:12:41.976087 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:12:41.976087 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:12:41.977086 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:12:41.977086 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:12:41.977086 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:12:45.262454 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:12:45.263455 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:12:45.331859 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:12:45.367915 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:12:45.431506 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:12:49.482835 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:12:51.977284 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:12:51.977284 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:12:40.7587959 +0200 IST m=+67803.046620801
[IDID_0] 2017/11/18 15:12:51.977284 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:13:05.1944562 +0200 IST m=+67827.482281101 and current time is 2017-11-18 15:12:40.7587959 +0200 IST m=+67803.046620801
[IDID_0] 2017/11/18 15:12:51.977284 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:12:51.977284 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:12:51.977284 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:12:51.977284 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:12:51.977284 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:12:51.977284 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:12:51.977284 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:12:51.977284 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:12:52.582248 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:12:59.482859 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:12:59.482859 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_242
[IDID_0] 2017/11/18 15:13:09.484401 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:13:11.307205 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:13:11.413435 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:13:15.522630 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:13:16.583660 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:13:16.583660 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:13:16.650735 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:13:16.653737 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:13:16.655739 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:13:16.662742 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:13:16.663744 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:13:16.715778 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:13:16.715778 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:13:16.715778 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:13:25.544697 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:13:25.544697 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:13:25.632887 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:13:26.721484 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:13:26.721484 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:13:16.5836602 +0200 IST m=+67838.871485101
[IDID_0] 2017/11/18 15:13:26.721484 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:13:27.740434 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:13:27.740434 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:13:27.740434 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:13:27.784480 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:13:27.791484 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:13:27.792484 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:13:27.793485 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:13:29.496900 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:13:29.496900 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:13:29.498901 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:13:29.499902 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:13:39.985682 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:13:49.991672 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:13:49.992672 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:13:50.103503 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:13:53.503082 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:13:53.503082 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:13:53.503082 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:13:53.503082 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:13:53.503082 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:13:54.321406 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:13:58.504079 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:13:58.504079 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:13:58.507082 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:13:58.507082 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:13:58.507082 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:14:04.322217 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:14:08.508757 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:14:08.508757 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:13:53.503082 +0200 IST m=+67875.790906901
[IDID_0] 2017/11/18 15:14:08.508757 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:14:16.5836602 +0200 IST m=+67898.871485101 and current time is 2017-11-18 15:13:53.503082 +0200 IST m=+67875.790906901
[IDID_0] 2017/11/18 15:14:08.508757 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:14:08.508757 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:14:08.508757 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:14:08.508757 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:14:08.508757 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:14:08.508757 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:14:08.508757 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:14:08.508757 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:14:09.307797 service.go:421: DEBUG: sleep until next dial 23.0805782s
[IDID_0] 2017/11/18 15:14:11.121663 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:14:21.123173 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:14:21.123173 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:14:21.229274 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:14:32.389193 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:14:32.389193 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:14:32.433229 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:14:32.434230 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:14:32.436232 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:14:32.4PORT_94 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:14:32.4PORT_94 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:14:32.438233 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:14:32.438233 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:14:32.438233 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:14:35.494179 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:14:35.590404 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:14:39.811204 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:14:42.438697 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:14:42.438697 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 23.0805782s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:14:32.3891939 +0200 IST m=+67914.677018801
[IDID_0] 2017/11/18 15:14:42.438697 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:14:43.443528 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:14:43.443528 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:14:43.443528 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:14:43.496115 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:14:43.498116 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:14:43.500118 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:14:43.502120 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:14:43.503119 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:14:43.505120 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:14:43.506124 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:14:43.508123 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:14:49.811490 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:14:51.314884 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:14:51.428685 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:14:56.704115 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:15:06.704881 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:15:06.706882 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:15:06.823977 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:15:07.508185 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:15:07.508185 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:15:07.508185 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:15:07.508185 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:15:07.508185 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:15:09.005749 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:15:09.006748 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:15:09.007748 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:15:09.007748 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:15:09.007748 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:15:11.680177 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:15:19.009686 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:15:19.009686 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:15:07.5081853 +0200 IST m=+67949.796010201
[IDID_0] 2017/11/18 15:15:19.009686 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:15:32.3891939 +0200 IST m=+67974.677018801 and current time is 2017-11-18 15:15:07.5081853 +0200 IST m=+67949.796010201
[IDID_0] 2017/11/18 15:15:19.009686 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:15:19.009686 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:15:19.009686 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:15:19.009686 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:15:19.009686 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:15:19.009686 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:15:19.009686 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:15:19.009686 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:15:19.780496 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:15:21.681586 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:15:31.038970 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:15:41.039115 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:15:41.039115 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:15:41.201320 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:15:43.781651 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:15:43.785651 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:15:44.627348 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:15:44.629348 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:15:45.435752 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:15:45.437753 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:15:45.437753 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:15:45.493841 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:15:45.493841 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:15:45.493841 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:15:49.594909 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:15:49.710990 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:15:55.494774 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:15:55.494774 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:15:43.7816518 +0200 IST m=+67986.069476601
[IDID_0] 2017/11/18 15:15:55.494774 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:15:56.498222 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:15:56.498222 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:15:56.498222 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:15:56.545613 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:15:56.547613 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:15:56.550617 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:15:56.552617 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:15:56.554618 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:15:56.557622 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:15:56.559621 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:15:56.561622 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:15:56.694839 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:16:06.700748 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:16:06.702750 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:16:06.810446 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:16:15.232945 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:16:15.344471 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:16:17.855064 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:16:20.591438 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:16:20.591438 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:16:20.591438 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:16:20.591438 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:16:20.591438 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:16:20.591438 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:16:20.591438 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:16:21.504514 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:16:21.504514 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:16:21.504514 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:16:27.855940 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:16:32.373651 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:16:32.373651 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:16:42.4855411 +0200 IST m=+68044.773366001 and current time is 2017-11-18 15:16:20.591438 +0200 IST m=+68022.879262901
[IDID_0] 2017/11/18 15:16:32.373651 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:16:43.7816518 +0200 IST m=+68046.069476601 and current time is 2017-11-18 15:16:20.591438 +0200 IST m=+68022.879262901
[IDID_0] 2017/11/18 15:16:32.373651 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:16:32.373651 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:16:32.373651 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:16:32.373651 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:16:32.374148 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:16:32.374148 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:16:32.374148 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:16:32.374148 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:16:32.374148 service.go:421: DEBUG: sleep until next dial 21.8941031s
[IDID_0] 2017/11/18 15:16:34.812266 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:16:44.832002 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:16:49.942787 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:16:50.048066 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:16:54.283899 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:16:54.283899 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:16:54.328481 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:16:54.330483 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:16:54.334484 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:16:54.338489 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:16:54.338489 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:16:54.345494 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:16:54.345494 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:16:54.345494 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:16:58.132730 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:17:04.345608 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:17:04.345608 service.go:400: DEBUG: dial IDIDID_9 relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german
[IDID_0] 2017/11/18 15:17:04.709452 service.go:405: DEBUG: dial failed IDIDID_9 relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german Incorrect response code 1: not found
[IDID_0] 2017/11/18 15:17:04.709452 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:17:05.714564 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:17:05.714564 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:17:05.714564 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:17:05.755591 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:17:05.757594 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:17:05.758593 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:17:05.758593 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:17:05.759595 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:17:05.761595 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:17:05.761595 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:17:05.762596 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:17:08.134680 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:17:08.134680 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:17:18.135016 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:17:18.135016 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:17:18.161022 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): EOF
[IDID_0] 2017/11/18 15:17:29.862176 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:17:29.862176 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:17:29.862176 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:17:29.862176 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:17:29.862176 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:17:29.862176 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:17:29.862176 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:17:29.924720 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:17:29.924720 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:17:29.924720 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:17:36.265480 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:17:36.820594 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:17:39.926457 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:17:39.926457 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:17:29.8621766 +0200 IST m=+68092.1PORT_41501
[IDID_0] 2017/11/18 15:17:39.926457 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:17:54.2838994 +0200 IST m=+68116.571724301 and current time is 2017-11-18 15:17:29.8621766 +0200 IST m=+68092.1PORT_41501
[IDID_0] 2017/11/18 15:17:39.926457 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:17:39.926457 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:17:39.926968 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:17:39.926968 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:17:39.926968 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:17:39.926968 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:17:39.926968 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:17:39.926968 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:17:40.271508 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:17:42.320318 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:17:52.321210 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:17:52.321210 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:18:02.321731 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:18:02.321731 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:18:02.448554 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:18:04.272556 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:18:04.272556 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:18:04.326593 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:18:04.327593 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:18:04.329595 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:18:05.528048 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:18:05.528048 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:18:05.580633 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:18:05.580633 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:18:05.580633 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:18:13.638273 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:18:15.580988 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:18:15.580988 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:18:04.2725568 +0200 IST m=+68126.560381701
[IDID_0] 2017/11/18 15:18:15.580988 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:18:16.586755 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:18:16.586755 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:18:16.586755 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:18:16.626782 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:18:16.627783 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:18:16.629784 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:18:16.629784 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:18:16.630785 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:18:16.631785 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:18:16.631785 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:18:17.387314 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:18:18.964347 model.go:1210: INFO: Connection to IDIDID_11 closed: read timeout
[IDID_0] 2017/11/18 15:18:23.640088 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:18:34.928275 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:18:41.388776 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:18:41.388776 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:18:41.388776 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:18:41.388776 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:18:41.388776 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:18:41.388776 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:18:41.388776 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:18:41.390776 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:18:41.390776 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:18:41.390776 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:18:44.928779 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:18:44.928779 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:18:45.007332 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:18:45.033371 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:18:45.122038 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:18:51.391540 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:18:51.391540 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:18:41.3887763 +0200 IST m=+68163.676601201
[IDID_0] 2017/11/18 15:18:51.391540 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:19:04.2725568 +0200 IST m=+68186.560381701 and current time is 2017-11-18 15:18:41.3887763 +0200 IST m=+68163.676601201
[IDID_0] 2017/11/18 15:18:51.391540 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:18:51.391540 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:18:51.391540 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:18:57.619119 service.go:400: DEBUG: dial IDIDID_11 relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de
[IDID_0] 2017/11/18 15:18:58.102732 relay_dial.go:48: DEBUG: failed to set traffic class: operation not supported
[IDID_0] 2017/11/18 15:19:04.391307 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:19:08.103083 service.go:405: DEBUG: dial failed IDIDID_11 relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de read tcp IPv4_4:PORT_548->IPv4_13:PORT_9: i/o timeout
[IDID_0] 2017/11/18 15:19:08.103083 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:19:14.392704 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:19:17.785156 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:19:17.897742 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:19:18.103152 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:19:18.103152 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:19:18.103152 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:19:18.149239 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:19:18.157244 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:19:18.165249 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:19:18.186259 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:19:18.192263 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:19:21.458539 service.go:421: DEBUG: sleep until next dial 22.8837805s
[IDID_0] 2017/11/18 15:19:44.342589 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:19:44.342589 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:19:44.398625 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:19:44.399626 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:19:44.724057 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:19:44.726058 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:19:44.726058 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:19:44.728059 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:19:44.728059 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:19:44.729061 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:19:44.907928 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:19:54.729373 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:19:54.729373 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 22.8837805s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:19:44.3425894 +0200 IST m=+68226.630414301
[IDID_0] 2017/11/18 15:19:54.729373 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:19:54.908769 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:19:54.908769 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:19:55.735129 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:19:55.735129 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:19:55.735129 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:19:55.776724 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:19:55.777723 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:19:55.777723 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 22.8837805s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:19:44.3425894 +0200 IST m=+68226.630414301
[IDID_0] 2017/11/18 15:19:55.777723 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:20:04.909341 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:20:04.909341 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:20:05.042663 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:20:05.778623 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:20:05.778623 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:20:05.778623 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:20:05.778623 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:20:05.778623 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:20:10.808338 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:20:10.808338 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:20:10.808338 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:20:11.187836 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:20:14.031389 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:20:14.215179 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:20:24.425163 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:20:34.440968 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:20:34.440968 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:20:34.570068 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:20:35.391271 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:20:35.391271 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:20:35.391271 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:20:35.391271 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:20:35.391271 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:20:37.277247 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:20:37.278250 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:20:37.281251 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:20:37.281251 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:20:37.281251 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:20:49.203556 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:20:49.204555 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:20:35.391271 +0200 IST m=+68277.679095901
[IDID_0] 2017/11/18 15:20:49.204555 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:20:44.3425894 +0200 IST m=+68286.630414301 and current time is 2017-11-18 15:20:35.391271 +0200 IST m=+68277.679095901
[IDID_0] 2017/11/18 15:20:49.204555 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:20:49.204555 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:20:49.204555 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:20:49.650097 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 24s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:20:35.391271 +0200 IST m=+68277.679095901
[IDID_0] 2017/11/18 15:20:49.653099 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:20:44.3425894 +0200 IST m=+68286.630414301 and current time is 2017-11-18 15:20:35.391271 +0200 IST m=+68277.679095901
[IDID_0] 2017/11/18 15:20:49.655101 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:20:49.681620 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:20:49.689629 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:20:49.712644 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:20:49.714647 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:20:49.715646 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:20:49.716647 service.go:421: DEBUG: sleep until next dial 8.9513184s
[IDID_0] 2017/11/18 15:20:59.208992 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:20:59.208992 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:20:59.258024 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:20:59.265030 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:21:01.909253 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:21:01.910253 service.go:364: DEBUG: Not dialing kcp://IPv4_16:PORT_8 as sleep is 8.9513184s, next dial is at 2017-11-18 15:20:59.391271 +0200 IST m=+68301.679095901 and current time is 2017-11-18 15:20:59.2089925 +0200 IST m=+68301.496817301
[IDID_0] 2017/11/18 15:21:01.910253 service.go:364: DEBUG: Not dialing kcp://IPv4_16:PORT_422 as sleep is 8.9513184s, next dial is at 2017-11-18 15:20:59.391271 +0200 IST m=+68301.679095901 and current time is 2017-11-18 15:20:59.2089925 +0200 IST m=+68301.496817301
[IDID_0] 2017/11/18 15:21:01.910253 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 8.9513184s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:20:59.2089925 +0200 IST m=+68301.496817301
[IDID_0] 2017/11/18 15:21:01.910253 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:21:02.913769 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:21:02.913769 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:21:02.913769 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:21:02.914764 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:21:02.917766 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:21:02.917766 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 8.9513184s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:20:59.2089925 +0200 IST m=+68301.496817301
[IDID_0] 2017/11/18 15:21:02.917766 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:21:11.075226 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:21:13.038648 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:21:13.038648 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:21:13.038648 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:21:13.038648 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:21:13.038648 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:21:13.038648 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:21:13.038648 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:21:13.038648 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:21:13.038648 service.go:421: DEBUG: sleep until next dial 182.2786ms
[IDID_0] 2017/11/18 15:21:13.227023 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:21:13.227023 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:21:13.227023 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:21:13.227023 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:21:13.227023 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:21:13.227023 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:21:13.227023 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:21:13.488755 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:21:13.488755 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:21:13.488755 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:21:24.229681 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:21:24.240688 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:21:24.240688 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 182.2786ms, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:21:13.2270235 +0200 IST m=+68315.514848401
[IDID_0] 2017/11/18 15:21:24.240688 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 182.2786ms, next dial is at 2017-11-18 15:21:59.2089925 +0200 IST m=+68361.496817301 and current time is 2017-11-18 15:21:13.2270235 +0200 IST m=+68315.514848401
[IDID_0] 2017/11/18 15:21:24.240688 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:21:24.240688 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:21:24.240688 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:21:24.240688 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 182.2786ms, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:21:13.2270235 +0200 IST m=+68315.514848401
[IDID_0] 2017/11/18 15:21:24.240688 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 182.2786ms, next dial is at 2017-11-18 15:21:59.2089925 +0200 IST m=+68361.496817301 and current time is 2017-11-18 15:21:13.2270235 +0200 IST m=+68315.514848401
[IDID_0] 2017/11/18 15:21:24.240688 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:21:24.240688 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:21:24.240688 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:21:24.240688 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:21:24.240688 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:21:24.240688 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:21:24.240688 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:21:24.280719 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:21:24.314241 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): EOF
[IDID_0] 2017/11/18 15:21:24.314241 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:21:34.948765 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:21:35.380884 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:21:35.941757 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:21:44.437520 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:21:48.317279 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:21:48.317279 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:21:48.317279 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:21:48.318274 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:21:48.318274 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:21:48.318274 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:21:48.318274 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:21:48.478591 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:21:48.478591 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:21:48.478591 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:21:54.769985 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:21:55.177426 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:21:55.305155 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:21:58.478779 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:21:58.478779 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:21:48.3172796 +0200 IST m=+68350.605104501
[IDID_0] 2017/11/18 15:21:58.478779 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:21:59.2089925 +0200 IST m=+68361.496817301 and current time is 2017-11-18 15:21:48.3172796 +0200 IST m=+68350.605104501
[IDID_0] 2017/11/18 15:21:58.478779 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:21:58.478779 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:21:58.478779 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:21:58.522871 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 24s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:21:48.3172796 +0200 IST m=+68350.605104501
[IDID_0] 2017/11/18 15:21:58.522871 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:21:59.2089925 +0200 IST m=+68361.496817301 and current time is 2017-11-18 15:21:48.3172796 +0200 IST m=+68350.605104501
[IDID_0] 2017/11/18 15:21:58.522871 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:21:58.523869 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:21:58.525871 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:21:58.889469 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:21:58.891471 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:21:58.895473 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:21:59.657920 service.go:421: DEBUG: sleep until next dial 10.8917128s
[IDID_0] 2017/11/18 15:22:02.763654 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:22:10.550373 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:22:10.550373 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:22:10.600405 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:22:10.602406 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:22:10.604407 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:22:10.607410 service.go:364: DEBUG: Not dialing kcp://IPv4_16:PORT_8 as sleep is 10.8917128s, next dial is at 2017-11-18 15:22:12.3172796 +0200 IST m=+68374.605104501 and current time is 2017-11-18 15:22:10.5503738 +0200 IST m=+68372.838198701
[IDID_0] 2017/11/18 15:22:10.607410 service.go:364: DEBUG: Not dialing kcp://IPv4_16:PORT_422 as sleep is 10.8917128s, next dial is at 2017-11-18 15:22:12.3172796 +0200 IST m=+68374.605104501 and current time is 2017-11-18 15:22:10.5503738 +0200 IST m=+68372.838198701
[IDID_0] 2017/11/18 15:22:10.607410 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 10.8917128s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:22:10.5503738 +0200 IST m=+68372.838198701
[IDID_0] 2017/11/18 15:22:10.607410 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:22:11.613018 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:22:11.613018 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:22:11.613018 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:22:11.617018 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:22:11.618021 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:22:11.618021 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 10.8917128s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:22:10.5503738 +0200 IST m=+68372.838198701
[IDID_0] 2017/11/18 15:22:11.618021 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:22:12.764183 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:22:21.618151 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:22:21.618151 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:22:21.618151 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:22:21.618151 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:22:21.618151 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:22:21.618151 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:22:21.619154 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:22:21.619154 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:22:21.995766 service.go:421: DEBUG: sleep until next dial 1.7669058s
[IDID_0] 2017/11/18 15:22:23.763482 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:22:23.763482 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:22:23.763482 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:22:23.763482 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:22:23.763482 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:22:23.763482 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:22:23.763482 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:22:23.764483 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:22:23.764483 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:22:23.764483 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:22:29.816105 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:22:33.765263 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:22:33.765263 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 1.7669058s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:22:23.7634823 +0200 IST m=+68386.051307201
[IDID_0] 2017/11/18 15:22:33.765263 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 1.7669058s, next dial is at 2017-11-18 15:23:10.5503738 +0200 IST m=+68432.838198701 and current time is 2017-11-18 15:22:23.7634823 +0200 IST m=+68386.051307201
[IDID_0] 2017/11/18 15:22:33.765263 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:22:33.765263 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:22:33.765263 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:22:33.765263 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 1.7669058s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:22:23.7634823 +0200 IST m=+68386.051307201
[IDID_0] 2017/11/18 15:22:33.765263 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 1.7669058s, next dial is at 2017-11-18 15:23:10.5503738 +0200 IST m=+68432.838198701 and current time is 2017-11-18 15:22:23.7634823 +0200 IST m=+68386.051307201
[IDID_0] 2017/11/18 15:22:33.765263 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:22:33.765263 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:22:33.765263 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:22:33.765263 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:22:33.765263 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:22:33.765263 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:22:33.765263 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:22:39.817018 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:22:39.817018 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:22:49.818395 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:22:49.818395 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:22:49.904481 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:22:49.933533 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:22:50.040101 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:22:57.765674 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:22:57.765674 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:22:57.765674 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:22:57.765674 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:22:57.765674 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:22:57.765674 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:22:57.765674 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:22:57.766673 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:22:57.766673 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:22:57.766673 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:23:05.308842 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:23:05.404913 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:23:07.521709 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:23:07.767430 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:23:07.767430 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:22:57.7656744 +0200 IST m=+68420.053499301
[IDID_0] 2017/11/18 15:23:07.767430 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:23:10.5503738 +0200 IST m=+68432.838198701 and current time is 2017-11-18 15:22:57.7656744 +0200 IST m=+68420.053499301
[IDID_0] 2017/11/18 15:23:07.767430 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:23:07.767430 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:23:07.767430 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:23:07.808283 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 24s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:22:57.7656744 +0200 IST m=+68420.053499301
[IDID_0] 2017/11/18 15:23:07.808283 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:23:10.5503738 +0200 IST m=+68432.838198701 and current time is 2017-11-18 15:22:57.7656744 +0200 IST m=+68420.053499301
[IDID_0] 2017/11/18 15:23:07.808283 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:23:07.808283 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:23:07.809282 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:23:07.812285 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:23:07.812285 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:23:07.813286 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:23:09.096547 service.go:421: DEBUG: sleep until next dial 12.7846994s
[IDID_0] 2017/11/18 15:23:17.522465 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:23:21.849131 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:23:21.882153 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:23:21.882153 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:23:21.923184 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:23:21.924186 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:23:21.926187 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:23:23.033626 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:23:23.033626 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:23:23.034625 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:23:23.034625 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:23:23.034625 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:23:31.850557 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:23:33.034854 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:23:33.034854 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 12.7846994s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:23:21.882153 +0200 IST m=+68444.169977901
[IDID_0] 2017/11/18 15:23:33.035854 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:23:34.038888 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:23:34.038888 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:23:34.038888 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:23:34.080916 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:23:34.104932 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:23:34.104932 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 12.7846994s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:23:21.882153 +0200 IST m=+68444.169977901
[IDID_0] 2017/11/18 15:23:34.104932 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:23:39.334114 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:23:39.574482 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:23:44.142868 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:23:44.144870 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:23:44.144870 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:23:44.144870 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:23:44.145870 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:23:45.034393 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:23:45.034393 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:23:45.034393 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:23:45.034393 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:23:52.825461 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:24:02.842393 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:24:02.842393 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:24:09.035380 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:24:09.035380 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:24:09.035380 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:24:09.035380 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:24:09.035380 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:24:09.035380 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:24:09.035380 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:24:09.041382 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:24:09.041382 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:24:09.041382 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:24:12.843634 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:24:12.843634 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:24:12.962158 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:24:13.311594 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:24:13.444061 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:24:19.041503 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:24:19.041503 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:24:09.03538 +0200 IST m=+68491.323204801
[IDID_0] 2017/11/18 15:24:19.041503 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:24:21.882153 +0200 IST m=+68504.169977901 and current time is 2017-11-18 15:24:09.03538 +0200 IST m=+68491.323204801
[IDID_0] 2017/11/18 15:24:19.041503 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:24:19.041503 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:24:19.041503 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:24:20.4PORT_148 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 24s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:24:09.03538 +0200 IST m=+68491.323204801
[IDID_0] 2017/11/18 15:24:20.4PORT_148 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:24:21.882153 +0200 IST m=+68504.169977901 and current time is 2017-11-18 15:24:09.03538 +0200 IST m=+68491.323204801
[IDID_0] 2017/11/18 15:24:20.4PORT_148 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:24:20.443349 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:24:20.PORT_2215 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:24:20.453354 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:24:20.455355 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:24:20.457356 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:24:20.577154 service.go:421: DEBUG: sleep until next dial 12.8467731s
[IDID_0] 2017/11/18 15:24:24.805232 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:24:33.425258 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:24:33.425258 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:24:33.474290 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:24:33.476290 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:24:33.479294 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:24:33.481296 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:24:33.485299 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:24:33.488309 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:24:33.488309 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:24:33.488309 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:24:34.805900 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:24:43.489400 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:24:43.489400 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 12.8467731s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:24:33.4252582 +0200 IST m=+68515.713083001
[IDID_0] 2017/11/18 15:24:43.489400 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:24:44.494951 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:24:44.494951 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:24:44.494951 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:24:44.538664 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:24:44.539665 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:24:44.539665 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 12.8467731s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:24:33.4252582 +0200 IST m=+68515.713083001
[IDID_0] 2017/11/18 15:24:44.539665 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:24:47.768347 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:24:54.545467 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:24:54.545467 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:24:54.545467 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:24:54.545467 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:24:54.545467 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:24:54.545467 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:24:54.545467 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:24:54.545467 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:24:54.545467 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:24:57.769432 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:24:57.769432 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:24:57.881518 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:25:16.969827 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:25:18.547096 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:25:18.547596 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:25:18.547596 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:25:18.547596 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:25:19.349915 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:25:19.349915 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:25:19.349915 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:25:19.401113 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:25:19.401113 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:25:19.401113 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:25:26.970388 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:25:26.970388 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:25:29.402486 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:25:29.402486 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:25:18.5475964 +0200 IST m=+68560.835PORT_1751
[IDID_0] 2017/11/18 15:25:29.402486 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:25:33.4252582 +0200 IST m=+68575.713083001 and current time is 2017-11-18 15:25:18.5475964 +0200 IST m=+68560.835PORT_1751
[IDID_0] 2017/11/18 15:25:29.402486 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:25:29.402486 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:25:29.402486 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:25:29.446512 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 24s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:25:18.5475964 +0200 IST m=+68560.835PORT_1751
[IDID_0] 2017/11/18 15:25:29.446512 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:25:33.4252582 +0200 IST m=+68575.713083001 and current time is 2017-11-18 15:25:18.5475964 +0200 IST m=+68560.835PORT_1751
[IDID_0] 2017/11/18 15:25:29.446512 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:25:29.447514 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:25:29.450516 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:25:29.451516 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:25:29.451516 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:25:29.452516 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:25:29.453518 service.go:421: DEBUG: sleep until next dial 14.8776618s
[IDID_0] 2017/11/18 15:25:36.971649 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:25:36.971649 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:25:36.978159 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): EOF
[IDID_0] 2017/11/18 15:25:36.978159 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:25:37.068760 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:25:44.496497 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:25:44.496497 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:25:44.541524 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:25:44.543526 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:25:44.544526 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:25:47.285273 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:25:49.390963 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:25:49.390963 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:25:49.391462 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:25:49.391462 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:25:49.391963 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:25:57.285959 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:25:59.393033 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:25:59.393033 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 14.8776618s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:25:44.4964976 +0200 IST m=+68586.784322501
[IDID_0] 2017/11/18 15:25:59.393033 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:26:00.398883 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:26:00.398883 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:26:00.398883 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:26:00.443813 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:26:00.447813 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:26:00.778852 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 14.8776618s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:25:44.4964976 +0200 IST m=+68586.784322501
[IDID_0] 2017/11/18 15:26:00.778852 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:26:04.527105 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:26:11.011706 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:26:11.011706 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:26:11.011706 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:26:11.011706 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:26:11.012207 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:26:11.012207 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:26:11.012207 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:26:11.012207 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:26:11.731174 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:26:14.553769 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:26:19.488972 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:26:19.615190 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:26:35.731456 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:26:35.731456 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:26:36.110229 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:26:36.110229 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:26:36.110229 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:26:36.110229 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:26:36.111231 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:26:36.114233 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:26:36.114233 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:26:36.114233 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:26:37.290612 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:26:46.136663 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:26:46.136663 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:26:54.2838994 +0200 IST m=+68656.571724301 and current time is 2017-11-18 15:26:35.7314565 +0200 IST m=+68638.019281401
[IDID_0] 2017/11/18 15:26:46.136663 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:26:44.4964976 +0200 IST m=+68646.784322501 and current time is 2017-11-18 15:26:35.7314565 +0200 IST m=+68638.019281401
[IDID_0] 2017/11/18 15:26:46.136663 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:26:46.136663 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:26:46.142668 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:26:46.193721 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 24s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:26:35.7314565 +0200 IST m=+68638.019281401
[IDID_0] 2017/11/18 15:26:46.193721 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:26:44.4964976 +0200 IST m=+68646.784322501 and current time is 2017-11-18 15:26:35.7314565 +0200 IST m=+68638.019281401
[IDID_0] 2017/11/18 15:26:46.193721 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:26:46.194722 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:26:46.196724 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:26:46.198725 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:26:46.200726 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:26:46.201727 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:26:46.899664 service.go:421: DEBUG: sleep until next dial 8.7650411s
[IDID_0] 2017/11/18 15:26:47.291238 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:26:47.291238 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:26:55.666065 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:26:55.669567 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:26:55.710362 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:26:55.711362 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:26:55.712363 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:26:55.713363 service.go:364: DEBUG: Not dialing kcp://IPv4_16:PORT_8 as sleep is 8.7650411s, next dial is at 2017-11-18 15:26:59.7314565 +0200 IST m=+68662.019281401 and current time is 2017-11-18 15:26:55.6680663 +0200 IST m=+68657.955891201
[IDID_0] 2017/11/18 15:26:55.713363 service.go:364: DEBUG: Not dialing kcp://IPv4_16:PORT_422 as sleep is 8.7650411s, next dial is at 2017-11-18 15:26:59.7314565 +0200 IST m=+68662.019281401 and current time is 2017-11-18 15:26:55.6680663 +0200 IST m=+68657.955891201
[IDID_0] 2017/11/18 15:26:55.713363 service.go:400: DEBUG: dial IDIDID_9 relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german
[IDID_0] 2017/11/18 15:26:56.081587 service.go:405: DEBUG: dial failed IDIDID_9 relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german Incorrect response code 1: not found
[IDID_0] 2017/11/18 15:26:56.081587 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:26:57.087974 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:26:57.087974 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:26:57.087974 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:26:57.088972 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:26:57.088972 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:26:57.088972 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 8.7650411s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:26:55.6680663 +0200 IST m=+68657.955891201
[IDID_0] 2017/11/18 15:26:57.088972 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:26:57.291948 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:26:57.291948 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:26:57.356930 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:26:57.380465 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:26:57.466902 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:27:07.090275 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:27:07.090778 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:27:07.090778 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:27:07.090778 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:27:07.090778 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:27:07.090778 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:27:07.090778 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:27:07.090778 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:27:08.143961 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:27:09.217679 service.go:421: DEBUG: sleep until next dial 4.0633902s
[IDID_0] 2017/11/18 15:27:13.281832 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:27:13.281832 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:27:13.281832 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:27:13.281832 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:27:13.281832 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:27:13.281832 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:27:13.281832 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:27:13.282827 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:27:13.282827 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:27:13.282827 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:27:18.151168 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:27:23.282993 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:27:23.282993 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 4.0633902s, next dial is at 2017-11-18 15:36:55.6680663 +0200 IST m=+69257.955891201 and current time is 2017-11-18 15:27:13.2818326 +0200 IST m=+68675.569657501
[IDID_0] 2017/11/18 15:27:23.282993 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 4.0633902s, next dial is at 2017-11-18 15:27:55.6680663 +0200 IST m=+68717.955891201 and current time is 2017-11-18 15:27:13.2818326 +0200 IST m=+68675.569657501
[IDID_0] 2017/11/18 15:27:23.282993 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:27:23.330156 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:27:23.331157 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:27:23.331157 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 4.0633902s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:27:13.2818326 +0200 IST m=+68675.569657501
[IDID_0] 2017/11/18 15:27:23.331157 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 4.0633902s, next dial is at 2017-11-18 15:27:55.6680663 +0200 IST m=+68717.955891201 and current time is 2017-11-18 15:27:13.2818326 +0200 IST m=+68675.569657501
[IDID_0] 2017/11/18 15:27:23.331157 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:27:23.331157 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:27:23.331157 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:27:23.331157 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:27:23.336160 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:27:23.336160 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:27:23.336160 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:27:24.038770 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:27:34.039390 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:27:34.039390 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:27:34.138463 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:27:47.336663 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:27:47.336663 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:27:49.368303 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:27:49.368303 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:27:49.736150 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:27:49.736650 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:27:49.736650 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:27:49.737650 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:27:49.737650 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:27:49.737650 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:27:58.557077 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:27:59.738353 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:27:59.738353 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:36:55.6680663 +0200 IST m=+69257.955891201 and current time is 2017-11-18 15:27:47.3366636 +0200 IST m=+68709.624488501
[IDID_0] 2017/11/18 15:27:59.738353 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:27:55.6680663 +0200 IST m=+68717.955891201 and current time is 2017-11-18 15:27:47.3366636 +0200 IST m=+68709.624488501
[IDID_0] 2017/11/18 15:27:59.738353 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:27:59.738353 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:27:59.738353 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:27:59.782484 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 24s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:27:47.3366636 +0200 IST m=+68709.624488501
[IDID_0] 2017/11/18 15:27:59.782484 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:27:55.6680663 +0200 IST m=+68717.955891201 and current time is 2017-11-18 15:27:47.3366636 +0200 IST m=+68709.624488501
[IDID_0] 2017/11/18 15:27:59.782484 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:27:59.782484 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:27:59.785487 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:27:59.786487 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:27:59.787488 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:27:59.787488 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:27:59.788488 service.go:421: DEBUG: sleep until next dial 8.3314027s
[IDID_0] 2017/11/18 15:28:08.121680 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:28:08.121680 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:28:08.186702 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:28:08.196707 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:28:08.204713 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:28:08.207715 service.go:364: DEBUG: Not dialing kcp://IPv4_16:PORT_8 as sleep is 8.3314027s, next dial is at 2017-11-18 15:28:11.3366636 +0200 IST m=+68733.624488501 and current time is 2017-11-18 15:28:08.1216801 +0200 IST m=+68730.409505001
[IDID_0] 2017/11/18 15:28:08.210717 service.go:364: DEBUG: Not dialing kcp://IPv4_16:PORT_422 as sleep is 8.3314027s, next dial is at 2017-11-18 15:28:11.3366636 +0200 IST m=+68733.624488501 and current time is 2017-11-18 15:28:08.1216801 +0200 IST m=+68730.409505001
[IDID_0] 2017/11/18 15:28:08.211718 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 8.3314027s, next dial is at 2017-11-18 15:36:55.6680663 +0200 IST m=+69257.955891201 and current time is 2017-11-18 15:28:08.1216801 +0200 IST m=+68730.409505001
[IDID_0] 2017/11/18 15:28:08.213719 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:28:08.557276 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:28:08.558274 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:28:09.223850 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:28:09.223850 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:28:09.223850 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:28:09.223850 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:28:09.223850 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:28:09.223850 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 8.3314027s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:28:08.1216801 +0200 IST m=+68730.409505001
[IDID_0] 2017/11/18 15:28:09.223850 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:28:18.559643 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:28:18.559643 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:28:18.646207 service.go:247: INFO: Connected to already connected device (IDIDID_4)
[IDID_0] 2017/11/18 15:28:19.224095 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:28:19.224095 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:28:19.224095 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:28:19.224095 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:28:19.224095 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:28:19.224095 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:28:19.224095 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:28:19.224095 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:28:19.224095 service.go:421: DEBUG: sleep until next dial 3.2149835s
[IDID_0] 2017/11/18 15:28:22.188040 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:28:22.322135 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:28:22.439223 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:28:22.439223 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:28:22.439223 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:28:22.439223 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:28:22.439223 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:28:22.439223 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:28:22.439223 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:28:22.440224 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:28:22.440224 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:28:22.440224 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:28:32.442078 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:28:32.442078 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 3.2149835s, next dial is at 2017-11-18 15:36:55.6680663 +0200 IST m=+69257.955891201 and current time is 2017-11-18 15:28:22.4392236 +0200 IST m=+68744.727048401
[IDID_0] 2017/11/18 15:28:32.442078 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 3.2149835s, next dial is at 2017-11-18 15:29:08.1216801 +0200 IST m=+68790.409505001 and current time is 2017-11-18 15:28:22.4392236 +0200 IST m=+68744.727048401
[IDID_0] 2017/11/18 15:28:32.442078 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:28:32.490366 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:28:32.492362 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:28:32.492362 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 3.2149835s, next dial is at 2017-11-18 15:28:41.3887763 +0200 IST m=+68763.676601201 and current time is 2017-11-18 15:28:22.4392236 +0200 IST m=+68744.727048401
[IDID_0] 2017/11/18 15:28:32.492362 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 3.2149835s, next dial is at 2017-11-18 15:29:08.1216801 +0200 IST m=+68790.409505001 and current time is 2017-11-18 15:28:22.4392236 +0200 IST m=+68744.727048401
[IDID_0] 2017/11/18 15:28:32.492362 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:28:32.492362 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:28:32.502374 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:28:32.504378 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:28:32.504378 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:28:32.504378 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:28:32.504378 service.go:421: DEBUG: sleep until next dial 18.9495528s
[IDID_0] 2017/11/18 15:28:33.461215 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:28:43.462557 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:28:44.121438 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:28:51.455141 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:28:51.455141 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:28:51.455141 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:28:51.455141 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:28:51.455141 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:28:52.614935 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:28:52.614935 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:28:52.616942 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:28:52.617440 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:28:52.617440 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:28:54.122169 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:28:54.122169 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:28:54.228245 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:29:02.617624 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:29:02.617624 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 18.9495528s, next dial is at 2017-11-18 15:36:55.6680663 +0200 IST m=+69257.955891201 and current time is 2017-11-18 15:28:51.4551411 +0200 IST m=+68773.742966001
[IDID_0] 2017/11/18 15:29:02.617624 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 18.9495528s, next dial is at 2017-11-18 15:29:08.1216801 +0200 IST m=+68790.409505001 and current time is 2017-11-18 15:28:51.4551411 +0200 IST m=+68773.742966001
[IDID_0] 2017/11/18 15:29:02.617624 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:29:02.617624 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:29:02.617624 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:29:02.688672 service.go:400: DEBUG: dial IDIDID_11 relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de
[IDID_0] 2017/11/18 15:29:03.203037 relay_dial.go:48: DEBUG: failed to set traffic class: operation not supported
[IDID_0] 2017/11/18 15:29:13.203979 service.go:405: DEBUG: dial failed IDIDID_11 relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de read tcp IPv4_4:PORT_549->IPv4_13:PORT_9: i/o timeout
[IDID_0] 2017/11/18 15:29:13.204980 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 18.9495528s, next dial is at 2017-11-18 15:29:08.1216801 +0200 IST m=+68790.409505001 and current time is 2017-11-18 15:28:51.4551411 +0200 IST m=+68773.742966001
[IDID_0] 2017/11/18 15:29:13.207982 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:29:13.251041 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:29:13.2PORT_500 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:29:13.261049 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:29:13.263050 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:29:13.270054 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:29:13.629157 service.go:421: DEBUG: sleep until next dial 16.666539s
[IDID_0] 2017/11/18 15:29:23.464390 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:29:30.971819 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:29:30.971819 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:29:31.014845 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:29:31.016850 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:29:31.020850 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:29:31.025853 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:29:31.025853 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:29:31.051373 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:29:31.051373 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:29:31.051373 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:29:35.200101 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:29:35.202102 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:29:41.051511 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:29:41.051511 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 16.666539s, next dial is at 2017-11-18 15:36:55.6680663 +0200 IST m=+69257.955891201 and current time is 2017-11-18 15:29:30.9718199 +0200 IST m=+68813.259644801
[IDID_0] 2017/11/18 15:29:41.051511 service.go:400: DEBUG: dial IDIDID_9 tcp://IPv4_16:PORT_7
[IDID_0] 2017/11/18 15:29:42.055465 tcp_dial.go:36: DEBUG: dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:29:42.055465 service.go:405: DEBUG: dial failed IDIDID_9 tcp://IPv4_16:PORT_7 dial tcp IPv4_16:PORT_7: connectex: No connection could be made because the target machine actively refused it.
[IDID_0] 2017/11/18 15:29:42.055465 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:29:42.104545 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:29:42.107547 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:29:43.300133 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 16.666539s, next dial is at 2017-11-18 15:38:51.4551411 +0200 IST m=+69373.742966001 and current time is 2017-11-18 15:29:30.9718199 +0200 IST m=+68813.259644801
[IDID_0] 2017/11/18 15:29:43.300133 service.go:400: DEBUG: dial IDIDID_11 tcp://IPv4_21:PORT_7
[IDID_0] 2017/11/18 15:29:45.202879 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:29:45.202879 kcp_listen.go:120: DEBUG: connect from IPv4_21:PORT_8
[IDID_0] 2017/11/18 15:29:45.209882 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): EOF
[IDID_0] 2017/11/18 15:29:45.209882 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:29:45.216887 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): EOF
[IDID_0] 2017/11/18 15:29:53.301833 tcp_dial.go:36: DEBUG: dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:29:53.301833 service.go:405: DEBUG: dial failed IDIDID_11 tcp://IPv4_21:PORT_7 dial tcp IPv4_21:PORT_7: i/o timeout
[IDID_0] 2017/11/18 15:29:53.301833 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:29:53.301833 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:29:53.305836 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:29:53.307837 service.go:344: DEBUG: Reconnect loop for IDIDID_16
[IDID_0] 2017/11/18 15:29:53.307837 service.go:344: DEBUG: Reconnect loop for IDIDID_1
[IDID_0] 2017/11/18 15:29:53.307837 service.go:344: DEBUG: Reconnect loop for IDIDID_2
[IDID_0] 2017/11/18 15:29:53.468472 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_2
[IDID_0] 2017/11/18 15:29:54.119735 service.go:421: DEBUG: sleep until next dial 24s
[IDID_0] 2017/11/18 15:30:03.469661 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:30:18.217484 service.go:317: DEBUG: Reconnect loop
[IDID_0] 2017/11/18 15:30:18.217484 service.go:344: DEBUG: Reconnect loop for IDIDID_5
[IDID_0] 2017/11/18 15:30:18.217484 service.go:344: DEBUG: Reconnect loop for IDIDID_6
[IDID_0] 2017/11/18 15:30:18.217484 service.go:344: DEBUG: Reconnect loop for IDIDID_7
[IDID_0] 2017/11/18 15:30:18.220485 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3
[IDID_0] 2017/11/18 15:30:21.808459 service.go:344: DEBUG: Reconnect loop for IDIDID_9
[IDID_0] 2017/11/18 15:30:21.808459 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_8
[IDID_0] 2017/11/18 15:30:21.808459 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_8 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:30:23.475387 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_8 tls: received unexpected handshake message of type *tls.clientHelloMsg when waiting for *tls.serverHelloMsg
[IDID_0] 2017/11/18 15:30:23.475387 service.go:400: DEBUG: dial IDIDID_9 kcp://IPv4_16:PORT_422
[IDID_0] 2017/11/18 15:30:23.475387 kcp_dial.go:42: DEBUG: dial kcp://IPv4_16:PORT_422 using existing conn on [::]:PORT_8
[IDID_0] 2017/11/18 15:30:28.911005 kcp_listen.go:142: DEBUG: TLS handshake (BEP/kcp): i/o timeout
[IDID_0] 2017/11/18 15:30:28.966548 kcp_listen.go:120: DEBUG: connect from IPv4_18:PORT_8
[IDID_0] 2017/11/18 15:30:31.358858 service.go:247: INFO: Connected to already connected device (IDIDID_17)
[IDID_0] 2017/11/18 15:30:37.022569 service.go:405: DEBUG: dial failed IDIDID_9 kcp://IPv4_16:PORT_422 i/o timeout
[IDID_0] 2017/11/18 15:30:37.022569 service.go:364: DEBUG: Not dialing relay://IPv4_7:PORT_9/?id=7JD2UM6&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=some german as sleep is 24s, next dial is at 2017-11-18 15:36:55.6680663 +0200 IST m=+69257.955891201 and current time is 2017-11-18 15:30:18.2174844 +0200 IST m=+68860.505309301
[IDID_0] 2017/11/18 15:30:37.022569 service.go:364: DEBUG: Not dialing tcp://IPv4_16:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:30:30.9718199 +0200 IST m=+68873.259644801 and current time is 2017-11-18 15:30:18.2174844 +0200 IST m=+68860.505309301
[IDID_0] 2017/11/18 15:30:37.022569 service.go:344: DEBUG: Reconnect loop for IDIDID_8
[IDID_0] 2017/11/18 15:30:37.022569 service.go:344: DEBUG: Reconnect loop for IDIDID_10
[IDID_0] 2017/11/18 15:30:37.023069 service.go:344: DEBUG: Reconnect loop for IDIDID_11
[IDID_0] 2017/11/18 15:30:37.087612 service.go:364: DEBUG: Not dialing relay://IPv4_13:PORT_9/?id=OHWS367&pingInterval=1m0s&networkTimeout=2m0s&sessionLimitBps=0&globalLimitBps=0&statusAddr=:22070&providedBy=https://blog.veloc1ty.de as sleep is 24s, next dial is at 2017-11-18 15:38:51.4551411 +0200 IST m=+69373.742966001 and current time is 2017-11-18 15:30:18.2174844 +0200 IST m=+68860.505309301
[IDID_0] 2017/11/18 15:30:37.087612 service.go:364: DEBUG: Not dialing tcp://IPv4_21:PORT_7 as sleep is 24s, next dial is at 2017-11-18 15:30:30.9718199 +0200 IST m=+68873.259644801 and current time is 2017-11-18 15:30:18.2174844 +0200 IST m=+68860.505309301
[IDID_0] 2017/11/18 15:30:37.087612 service.go:344: DEBUG: Reconnect loop for IDIDID_12
[IDID_0] 2017/11/18 15:30:37.103622 service.go:344: DEBUG: Reconnect loop for IDIDID_13
[IDID_0] 2017/11/18 15:30:37.355701 service.go:344: DEBUG: Reconnect loop for IDIDID_15
[IDID_0] 2017/11/18 15:30:42.962856 kcp_listen.go:120: DEBUG: connect from IPv4_16:PORT_3