[GH-ISSUE #1657] work connection closed before response StartWorkConn message: EOF #1313

Closed
opened 2026-05-05 12:50:09 -06:00 by gitea-mirror · 16 comments
Owner

Originally created by @windowscv on GitHub (Feb 16, 2020).
Original GitHub issue: https://github.com/fatedier/frp/issues/1657

Issue is only used for submiting bug report and documents typo. If there are same issues or answers can be found in documents, we will close it directly.
(为了节约时间,提高处理问题的效率,不按照格式填写的 issue 将会直接关闭。)
(请不要在 issue 评论中出现无意义的 加1我也是 等内容,将会被直接删除。)
(由于个人精力有限,和系统环境,网络环境等相关的求助问题请转至其他论坛或社交平台。)

Use the commands below to provide key information from your environment:
You do NOT have to include this information if this is a FEATURE REQUEST

What version of frp are you using (./frpc -v or ./frps -v)?
frps 0.31.2
frpc 0.31.2
What operating system and processor architecture are you using (go env)?
centos 7.3+bbr fq

Configures you used:
FRPS:

[common]
bind_addr = 0.0.0.0
bind_port = 54431
kcp_bind_port = 5444
dashboard_port = 6443
dashboard_user = admin
dashboard_pwd = TI5UUwqg
vhost_http_port = 801
vhost_https_port = 443
log_file = ./frps.log
log_level = info
log_max_days = 3
token = 123456
subdomain_host = 47.52.219.XX
max_pool_count = 50
authentication_timeout = 0
tcp_mux = true

FRPC:

 [common]
 server_addr = 47.52.219.XX
 server_port = 54431
 pool_count  = 1
 tcp_mux     = true
 protocol    = tcp
 token       = 123456
 
 [ali1]
 type            = tcp
 local_ip        = 127.0.0.1
 local_port      = 18087
 use_encryption  = false
 use_compression = false
 remote_port     = 11686
 
 [ali2]
 type            = udp
 local_ip        = 127.0.0.1
 local_port      = 18087
 use_encryption  = false
 use_compression = false
 remote_port     = 11686

Steps to reproduce the issue:
1.在两台机器连接测试 香港-香港,出现错误
work connection closed before response StartWorkConn message: EOF
read from workConn for udp error: EOF
和reconnect to server error: i/o deadline reached
其中第一个最为频繁
2.在一台本地机器同时安装frpc和frps进行测试

Describe the results you received:
以下是本地测试的结果

2020/02/16 11:52:19 [I] [service.go:250] [5f2661ba26dd3706] login to server success, get run id [5f2661ba26dd3706], server udp port [0]
2020/02/16 11:52:19 [I] [proxy_manager.go:144] [5f2661ba26dd3706] proxy added: [ali2 ali1]
2020/02/16 11:52:19 [I] [control.go:164] [5f2661ba26dd3706] [ali11] start proxy success
2020/02/16 11:52:19 [I] [control.go:164] [5f2661ba26dd3706] [ali1] start proxy success
2020/02/16 11:52:19 [I] [proxy.go:438] [5f2661ba26dd3706] [ali11] incoming a new work connection for udp proxy, 47.52.219.XX:54431
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:13 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:13 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:13 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:21 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:21 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF
2020/02/16 12:34:21 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF

Describe the results you expected:
有可能是多路复用导致的吗

Additional information you deem important (e.g. issue happens only occasionally):
发生错误后断开

Can you point out what caused this issue (optional)

Originally created by @windowscv on GitHub (Feb 16, 2020). Original GitHub issue: https://github.com/fatedier/frp/issues/1657 Issue is only used for submiting bug report and documents typo. If there are same issues or answers can be found in documents, we will close it directly. (为了节约时间,提高处理问题的效率,不按照格式填写的 issue 将会直接关闭。) (请不要在 issue 评论中出现无意义的 **加1**,**我也是** 等内容,将会被直接删除。) (由于个人精力有限,和系统环境,网络环境等相关的求助问题请转至其他论坛或社交平台。) Use the commands below to provide key information from your environment: You do NOT have to include this information if this is a FEATURE REQUEST **What version of frp are you using (./frpc -v or ./frps -v)?** frps 0.31.2 frpc 0.31.2 **What operating system and processor architecture are you using (`go env`)?** centos 7.3+bbr fq **Configures you used:** FRPS: ``` [common] bind_addr = 0.0.0.0 bind_port = 54431 kcp_bind_port = 5444 dashboard_port = 6443 dashboard_user = admin dashboard_pwd = TI5UUwqg vhost_http_port = 801 vhost_https_port = 443 log_file = ./frps.log log_level = info log_max_days = 3 token = 123456 subdomain_host = 47.52.219.XX max_pool_count = 50 authentication_timeout = 0 tcp_mux = true ``` FRPC: ``` [common] server_addr = 47.52.219.XX server_port = 54431 pool_count = 1 tcp_mux = true protocol = tcp token = 123456 [ali1] type = tcp local_ip = 127.0.0.1 local_port = 18087 use_encryption = false use_compression = false remote_port = 11686 [ali2] type = udp local_ip = 127.0.0.1 local_port = 18087 use_encryption = false use_compression = false remote_port = 11686 ``` **Steps to reproduce the issue:** 1.在两台机器连接测试 香港-香港,出现错误 work connection closed before response StartWorkConn message: EOF read from workConn for udp error: EOF 和reconnect to server error: i/o deadline reached 其中第一个最为频繁 2.在一台本地机器同时安装frpc和frps进行测试 **Describe the results you received:** 以下是本地测试的结果 ``` 2020/02/16 11:52:19 [I] [service.go:250] [5f2661ba26dd3706] login to server success, get run id [5f2661ba26dd3706], server udp port [0] 2020/02/16 11:52:19 [I] [proxy_manager.go:144] [5f2661ba26dd3706] proxy added: [ali2 ali1] 2020/02/16 11:52:19 [I] [control.go:164] [5f2661ba26dd3706] [ali11] start proxy success 2020/02/16 11:52:19 [I] [control.go:164] [5f2661ba26dd3706] [ali1] start proxy success 2020/02/16 11:52:19 [I] [proxy.go:438] [5f2661ba26dd3706] [ali11] incoming a new work connection for udp proxy, 47.52.219.XX:54431 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:32:34 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:13 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:13 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:13 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:18 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:19 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:21 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:21 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF 2020/02/16 12:34:21 [E] [control.go:147] [5f2661ba26dd3706] work connection closed before response StartWorkConn message: EOF ``` **Describe the results you expected:** 有可能是多路复用导致的吗 **Additional information you deem important (e.g. issue happens only occasionally):** 发生错误后断开 **Can you point out what caused this issue (optional)**
Author
Owner

@fatedier commented on GitHub (Feb 16, 2020):

log_level 设置为 trace,然后 frpc 和 frps 的日志都贴一下。

<!-- gh-comment-id:586703045 --> @fatedier commented on GitHub (Feb 16, 2020): log_level 设置为 trace,然后 frpc 和 frps 的日志都贴一下。
Author
Owner

@windowscv commented on GitHub (Feb 16, 2020):

log_level 设置为 trace,然后 frpc 和 frps 的日志都贴一下。

特地设置了时区..但是好像没生效,frps里写了authentication_timeout = 0
FRPC

2020/02/16 12:59:49 [I] [service.go:250] [81cc680146704764] login to server success, get run id [81cc680146704764], server udp port [0]
2020/02/16 12:59:49 [I] [proxy_manager.go:144] [81cc680146704764] proxy added: [ali1 ali11]
2020/02/16 12:59:49 [I] [control.go:164] [81cc680146704764] [ali1] start proxy success
2020/02/16 12:59:49 [I] [control.go:164] [81cc680146704764] [ali11] start proxy success
2020/02/16 12:59:50 [I] [proxy.go:438] [81cc680146704764] [ali11] incoming a new work connection for udp proxy, 47.52.219.XX:54431
2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF
2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF
2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF
2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF
2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF
2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF
2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF
2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF
2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF

FRPS

2020/02/16 21:09:45 [I] [service.go:152] frps tcp listen on 0.0.0.0:54431
2020/02/16 21:09:45 [I] [service.go:161] frps kcp listen on udp 0.0.0.0:5444
2020/02/16 21:09:45 [I] [service.go:194] http service listen on 0.0.0.0:801
2020/02/16 21:09:45 [I] [service.go:215] https service listen on 0.0.0.0:443
2020/02/16 21:09:45 [I] [service.go:251] Dashboard listen on 0.0.0.0:6443
2020/02/16 21:09:45 [I] [root.go:205] start frps success
2020/02/16 21:09:48 [T] [service.go:285] start check TLS connection...
2020/02/16 21:09:48 [T] [service.go:293] success check TLS connection
2020/02/16 21:09:48 [I] [service.go:392] [dbafcb32b3cfcd81] client login info: ip [47.52.219.xx:59918] version [0.31.2] hostname [] os [linux] arch [amd64]
2020/02/16 21:09:48 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:48 [I] [tcp.go:63] [dbafcb32b3cfcd81] [ali1] tcp proxy listen port [11686]
2020/02/16 21:09:48 [I] [control.go:445] [dbafcb32b3cfcd81] new proxy [ali1] success
2020/02/16 21:09:48 [I] [udp.go:81] [dbafcb32b3cfcd81] [ali11] udp proxy listen port [11686]
2020/02/16 21:09:48 [I] [control.go:445] [dbafcb32b3cfcd81] new proxy [ali11] success
2020/02/16 21:09:48 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51441]
2020/02/16 21:09:48 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:48 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:48 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:48 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.2XX:51441])
2020/02/16 21:09:48 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:48 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed
2020/02/16 21:09:48 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51440]
2020/02/16 21:09:48 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:48 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:48 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:48 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.2XX:51440])
2020/02/16 21:09:48 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:49 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.6X:7134]
2020/02/16 21:09:49 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:49 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:49 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:49 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.6X:7134])
2020/02/16 21:09:49 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed
2020/02/16 21:09:49 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:49 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49344]
2020/02/16 21:09:49 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:49 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:49 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:49 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49344])
2020/02/16 21:09:49 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:49 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed
2020/02/16 21:09:49 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:49 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali11] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:49 [T] [udp.go:95] [dbafcb32b3cfcd81] [ali11] loop waiting message from udp workConn
2020/02/16 21:09:49 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:49 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.6X:7135]
2020/02/16 21:09:49 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:49 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:49 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:49 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.6X:7135])
2020/02/16 21:09:49 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed
2020/02/16 21:09:49 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49347]
2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49347])
2020/02/16 21:09:50 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed
2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:50 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49338]
2020/02/16 21:09:50 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49338])
2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:50 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed
2020/02/16 21:09:50 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51442]
2020/02/16 21:09:50 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.2XX:51442])
2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:50 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed
2020/02/16 21:09:50 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49349]
2020/02/16 21:09:50 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49349])
2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:50 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed
2020/02/16 21:09:50 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49336]
2020/02/16 21:09:50 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49336])
2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:51 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51447]
2020/02/16 21:09:51 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:51 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
2020/02/16 21:09:51 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/16 21:09:51 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.2XX:51447])
2020/02/16 21:09:51 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered
2020/02/16 21:09:51 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51445]
2020/02/16 21:09:51 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool
2020/02/16 21:09:51 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918]
<!-- gh-comment-id:586705169 --> @windowscv commented on GitHub (Feb 16, 2020): > log_level 设置为 trace,然后 frpc 和 frps 的日志都贴一下。 特地设置了时区..但是好像没生效,frps里写了authentication_timeout = 0 FRPC ``` 2020/02/16 12:59:49 [I] [service.go:250] [81cc680146704764] login to server success, get run id [81cc680146704764], server udp port [0] 2020/02/16 12:59:49 [I] [proxy_manager.go:144] [81cc680146704764] proxy added: [ali1 ali11] 2020/02/16 12:59:49 [I] [control.go:164] [81cc680146704764] [ali1] start proxy success 2020/02/16 12:59:49 [I] [control.go:164] [81cc680146704764] [ali11] start proxy success 2020/02/16 12:59:50 [I] [proxy.go:438] [81cc680146704764] [ali11] incoming a new work connection for udp proxy, 47.52.219.XX:54431 2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF 2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF 2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF 2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF 2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF 2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF 2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF 2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF 2020/02/16 13:04:42 [E] [control.go:147] [81cc680146704764] work connection closed before response StartWorkConn message: EOF ``` FRPS ``` 2020/02/16 21:09:45 [I] [service.go:152] frps tcp listen on 0.0.0.0:54431 2020/02/16 21:09:45 [I] [service.go:161] frps kcp listen on udp 0.0.0.0:5444 2020/02/16 21:09:45 [I] [service.go:194] http service listen on 0.0.0.0:801 2020/02/16 21:09:45 [I] [service.go:215] https service listen on 0.0.0.0:443 2020/02/16 21:09:45 [I] [service.go:251] Dashboard listen on 0.0.0.0:6443 2020/02/16 21:09:45 [I] [root.go:205] start frps success 2020/02/16 21:09:48 [T] [service.go:285] start check TLS connection... 2020/02/16 21:09:48 [T] [service.go:293] success check TLS connection 2020/02/16 21:09:48 [I] [service.go:392] [dbafcb32b3cfcd81] client login info: ip [47.52.219.xx:59918] version [0.31.2] hostname [] os [linux] arch [amd64] 2020/02/16 21:09:48 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:48 [I] [tcp.go:63] [dbafcb32b3cfcd81] [ali1] tcp proxy listen port [11686] 2020/02/16 21:09:48 [I] [control.go:445] [dbafcb32b3cfcd81] new proxy [ali1] success 2020/02/16 21:09:48 [I] [udp.go:81] [dbafcb32b3cfcd81] [ali11] udp proxy listen port [11686] 2020/02/16 21:09:48 [I] [control.go:445] [dbafcb32b3cfcd81] new proxy [ali11] success 2020/02/16 21:09:48 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51441] 2020/02/16 21:09:48 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:48 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:48 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:48 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.2XX:51441]) 2020/02/16 21:09:48 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:48 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed 2020/02/16 21:09:48 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51440] 2020/02/16 21:09:48 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:48 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:48 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:48 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.2XX:51440]) 2020/02/16 21:09:48 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:49 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.6X:7134] 2020/02/16 21:09:49 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:49 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:49 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:49 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.6X:7134]) 2020/02/16 21:09:49 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed 2020/02/16 21:09:49 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:49 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49344] 2020/02/16 21:09:49 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:49 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:49 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:49 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49344]) 2020/02/16 21:09:49 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:49 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed 2020/02/16 21:09:49 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:49 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali11] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:49 [T] [udp.go:95] [dbafcb32b3cfcd81] [ali11] loop waiting message from udp workConn 2020/02/16 21:09:49 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:49 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.6X:7135] 2020/02/16 21:09:49 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:49 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:49 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:49 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.6X:7135]) 2020/02/16 21:09:49 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed 2020/02/16 21:09:49 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49347] 2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49347]) 2020/02/16 21:09:50 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed 2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:50 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49338] 2020/02/16 21:09:50 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49338]) 2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:50 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed 2020/02/16 21:09:50 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51442] 2020/02/16 21:09:50 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.2XX:51442]) 2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:50 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed 2020/02/16 21:09:50 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49349] 2020/02/16 21:09:50 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49349]) 2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:50 [D] [proxy.go:251] [dbafcb32b3cfcd81] [ali1] join connections closed 2020/02/16 21:09:50 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.1XX:49336] 2020/02/16 21:09:50 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:50 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:50 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:50 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.1XX:49336]) 2020/02/16 21:09:50 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:51 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51447] 2020/02/16 21:09:51 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:51 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] 2020/02/16 21:09:51 [T] [proxy.go:226] [dbafcb32b3cfcd81] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/16 21:09:51 [D] [proxy.go:237] [dbafcb32b3cfcd81] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:59918]) userConn(l[172.31.50.103:11686] r[223.88.XX.2XX:51447]) 2020/02/16 21:09:51 [D] [control.go:217] [dbafcb32b3cfcd81] new work connection registered 2020/02/16 21:09:51 [D] [proxy.go:150] [dbafcb32b3cfcd81] [ali1] get a user connection [223.88.XX.2XX:51445] 2020/02/16 21:09:51 [D] [control.go:245] [dbafcb32b3cfcd81] get work connection from pool 2020/02/16 21:09:51 [I] [proxy.go:92] [dbafcb32b3cfcd81] [ali1] get a new work connection: [47.52.219.xx:59918] ```
Author
Owner

@fatedier commented on GitHub (Feb 17, 2020):

你贴的 frpc 和 frps 的日志的 RunID 对不上,最好贴一下同一时间点的日志。

<!-- gh-comment-id:586826522 --> @fatedier commented on GitHub (Feb 17, 2020): 你贴的 frpc 和 frps 的日志的 RunID 对不上,最好贴一下同一时间点的日志。
Author
Owner

@windowscv commented on GitHub (Feb 17, 2020):

你贴的 frpc 和 frps 的日志的 RunID 对不上,最好贴一下同一时间点的日志。

不知道为什么,在同一台机器的环境测试,清除了日志的,时间线还是不同..但是日志确实是同一时间的

<!-- gh-comment-id:587044833 --> @windowscv commented on GitHub (Feb 17, 2020): > 你贴的 frpc 和 frps 的日志的 RunID 对不上,最好贴一下同一时间点的日志。 不知道为什么,在同一台机器的环境测试,清除了日志的,时间线还是不同..但是日志确实是同一时间的
Author
Owner

@fatedier commented on GitHub (Feb 18, 2020):

@as1543100166 时间其实还好,主要是 RunID,每次客户端连上服务端后,服务端会主动分配一个 RunID,表征这个客户端,服务端和客户端打印的日志都会加上这个 id,用来判断打印出的日志对应的是哪个客户端和哪次连接。

RunID 不一样,说明打印出的日志可能对应不上。

<!-- gh-comment-id:587245969 --> @fatedier commented on GitHub (Feb 18, 2020): @as1543100166 时间其实还好,主要是 RunID,每次客户端连上服务端后,服务端会主动分配一个 RunID,表征这个客户端,服务端和客户端打印的日志都会加上这个 id,用来判断打印出的日志对应的是哪个客户端和哪次连接。 RunID 不一样,说明打印出的日志可能对应不上。
Author
Owner

@windowscv commented on GitHub (Feb 18, 2020):

@fatedier
FRPS

2020/02/18 13:41:00 [I] [service.go:152] frps tcp listen on 0.0.0.0:54431
2020/02/18 13:41:00 [I] [service.go:161] frps kcp listen on udp 0.0.0.0:5444
2020/02/18 13:41:00 [I] [service.go:194] http service listen on 0.0.0.0:801
2020/02/18 13:41:00 [I] [service.go:215] https service listen on 0.0.0.0:443
2020/02/18 13:41:00 [I] [service.go:251] Dashboard listen on 0.0.0.0:6443
2020/02/18 13:41:00 [I] [root.go:205] start frps success
2020/02/18 13:41:06 [T] [service.go:285] start check TLS connection...
2020/02/18 13:41:06 [T] [service.go:293] success check TLS connection
2020/02/18 13:41:06 [I] [service.go:392] [5f0704510c2134ce] client login info: ip [47.52.219.xx:48990] version [0.31.2] hostname [] os [linux] arch [amd64]
2020/02/18 13:41:06 [D] [control.go:217] [5f0704510c2134ce] new work connection registered
2020/02/18 13:41:06 [I] [tcp.go:63] [5f0704510c2134ce] [ali1] tcp proxy listen port [11686]
2020/02/18 13:41:06 [I] [control.go:445] [5f0704510c2134ce] new proxy [ali1] success
2020/02/18 13:41:06 [I] [udp.go:81] [5f0704510c2134ce] [ali11] udp proxy listen port [11686]
2020/02/18 13:41:06 [I] [control.go:445] [5f0704510c2134ce] new proxy [ali11] success
2020/02/18 13:41:06 [D] [control.go:245] [5f0704510c2134ce] get work connection from pool
2020/02/18 13:41:06 [I] [proxy.go:92] [5f0704510c2134ce] [ali11] get a new work connection: [47.52.219.xx:48990]
2020/02/18 13:41:06 [T] [udp.go:95] [5f0704510c2134ce] [ali11] loop waiting message from udp workConn
2020/02/18 13:41:06 [D] [control.go:217] [5f0704510c2134ce] new work connection registered
2020/02/18 13:41:08 [D] [proxy.go:150] [5f0704510c2134ce] [ali1] get a user connection [223.xx.83.xx:6997]
2020/02/18 13:41:08 [D] [control.go:245] [5f0704510c2134ce] get work connection from pool
2020/02/18 13:41:08 [I] [proxy.go:92] [5f0704510c2134ce] [ali1] get a new work connection: [47.52.219.xx:48990]
2020/02/18 13:41:08 [T] [proxy.go:226] [5f0704510c2134ce] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/18 13:41:08 [D] [proxy.go:237] [5f0704510c2134ce] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:48990]) userConn(l[172.31.50.103:11686] r[223.xx.83.xx:6997])
2020/02/18 13:41:08 [D] [control.go:217] [5f0704510c2134ce] new work connection registered
2020/02/18 13:41:09 [D] [proxy.go:150] [5f0704510c2134ce] [ali1] get a user connection [223.xx.83.xx:7002]
2020/02/18 13:41:09 [D] [control.go:245] [5f0704510c2134ce] get work connection from pool
2020/02/18 13:41:09 [I] [proxy.go:92] [5f0704510c2134ce] [ali1] get a new work connection: [47.52.219.xx:48990]
2020/02/18 13:41:09 [T] [proxy.go:226] [5f0704510c2134ce] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/18 13:41:09 [D] [proxy.go:237] [5f0704510c2134ce] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:48990]) userConn(l[172.31.50.103:11686] r[223.xx.83.xx:7002])
2020/02/18 13:41:09 [D] [control.go:217] [5f0704510c2134ce] new work connection registered
2020/02/18 13:41:09 [D] [proxy.go:150] [5f0704510c2134ce] [ali1] get a user connection [223.xx.83.1xx:49155]

FRPC

2020/02/18 05:41:06 [I] [service.go:250] [5f0704510c2134ce] login to server success, get run id [5f0704510c2134ce], server udp port [0]
2020/02/18 05:41:06 [I] [proxy_manager.go:144] [5f0704510c2134ce] proxy added: [ali1 ali11]
2020/02/18 05:41:06 [I] [control.go:164] [5f0704510c2134ce] [ali1] start proxy success
2020/02/18 05:41:06 [I] [control.go:164] [5f0704510c2134ce] [ali11] start proxy success
2020/02/18 05:41:06 [I] [proxy.go:438] [5f0704510c2134ce] [ali11] incoming a new work connection for udp proxy, 47.52.219.xx:54431
2020/02/18 05:41:58 [E] [control.go:147] [5f0704510c2134ce] work connection closed before response StartWorkConn message: EOF

问题似乎出在
2020/02/18 13:41:58 [D] [control.go:219] [5f0704510c2134ce] work connection pool is full, discarding

<!-- gh-comment-id:587289690 --> @windowscv commented on GitHub (Feb 18, 2020): @fatedier FRPS ``` 2020/02/18 13:41:00 [I] [service.go:152] frps tcp listen on 0.0.0.0:54431 2020/02/18 13:41:00 [I] [service.go:161] frps kcp listen on udp 0.0.0.0:5444 2020/02/18 13:41:00 [I] [service.go:194] http service listen on 0.0.0.0:801 2020/02/18 13:41:00 [I] [service.go:215] https service listen on 0.0.0.0:443 2020/02/18 13:41:00 [I] [service.go:251] Dashboard listen on 0.0.0.0:6443 2020/02/18 13:41:00 [I] [root.go:205] start frps success 2020/02/18 13:41:06 [T] [service.go:285] start check TLS connection... 2020/02/18 13:41:06 [T] [service.go:293] success check TLS connection 2020/02/18 13:41:06 [I] [service.go:392] [5f0704510c2134ce] client login info: ip [47.52.219.xx:48990] version [0.31.2] hostname [] os [linux] arch [amd64] 2020/02/18 13:41:06 [D] [control.go:217] [5f0704510c2134ce] new work connection registered 2020/02/18 13:41:06 [I] [tcp.go:63] [5f0704510c2134ce] [ali1] tcp proxy listen port [11686] 2020/02/18 13:41:06 [I] [control.go:445] [5f0704510c2134ce] new proxy [ali1] success 2020/02/18 13:41:06 [I] [udp.go:81] [5f0704510c2134ce] [ali11] udp proxy listen port [11686] 2020/02/18 13:41:06 [I] [control.go:445] [5f0704510c2134ce] new proxy [ali11] success 2020/02/18 13:41:06 [D] [control.go:245] [5f0704510c2134ce] get work connection from pool 2020/02/18 13:41:06 [I] [proxy.go:92] [5f0704510c2134ce] [ali11] get a new work connection: [47.52.219.xx:48990] 2020/02/18 13:41:06 [T] [udp.go:95] [5f0704510c2134ce] [ali11] loop waiting message from udp workConn 2020/02/18 13:41:06 [D] [control.go:217] [5f0704510c2134ce] new work connection registered 2020/02/18 13:41:08 [D] [proxy.go:150] [5f0704510c2134ce] [ali1] get a user connection [223.xx.83.xx:6997] 2020/02/18 13:41:08 [D] [control.go:245] [5f0704510c2134ce] get work connection from pool 2020/02/18 13:41:08 [I] [proxy.go:92] [5f0704510c2134ce] [ali1] get a new work connection: [47.52.219.xx:48990] 2020/02/18 13:41:08 [T] [proxy.go:226] [5f0704510c2134ce] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/18 13:41:08 [D] [proxy.go:237] [5f0704510c2134ce] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:48990]) userConn(l[172.31.50.103:11686] r[223.xx.83.xx:6997]) 2020/02/18 13:41:08 [D] [control.go:217] [5f0704510c2134ce] new work connection registered 2020/02/18 13:41:09 [D] [proxy.go:150] [5f0704510c2134ce] [ali1] get a user connection [223.xx.83.xx:7002] 2020/02/18 13:41:09 [D] [control.go:245] [5f0704510c2134ce] get work connection from pool 2020/02/18 13:41:09 [I] [proxy.go:92] [5f0704510c2134ce] [ali1] get a new work connection: [47.52.219.xx:48990] 2020/02/18 13:41:09 [T] [proxy.go:226] [5f0704510c2134ce] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/18 13:41:09 [D] [proxy.go:237] [5f0704510c2134ce] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:48990]) userConn(l[172.31.50.103:11686] r[223.xx.83.xx:7002]) 2020/02/18 13:41:09 [D] [control.go:217] [5f0704510c2134ce] new work connection registered 2020/02/18 13:41:09 [D] [proxy.go:150] [5f0704510c2134ce] [ali1] get a user connection [223.xx.83.1xx:49155] ``` FRPC ``` 2020/02/18 05:41:06 [I] [service.go:250] [5f0704510c2134ce] login to server success, get run id [5f0704510c2134ce], server udp port [0] 2020/02/18 05:41:06 [I] [proxy_manager.go:144] [5f0704510c2134ce] proxy added: [ali1 ali11] 2020/02/18 05:41:06 [I] [control.go:164] [5f0704510c2134ce] [ali1] start proxy success 2020/02/18 05:41:06 [I] [control.go:164] [5f0704510c2134ce] [ali11] start proxy success 2020/02/18 05:41:06 [I] [proxy.go:438] [5f0704510c2134ce] [ali11] incoming a new work connection for udp proxy, 47.52.219.xx:54431 2020/02/18 05:41:58 [E] [control.go:147] [5f0704510c2134ce] work connection closed before response StartWorkConn message: EOF ``` 问题似乎出在 `2020/02/18 13:41:58 [D] [control.go:219] [5f0704510c2134ce] work connection pool is full, discarding`
Author
Owner

@windowscv commented on GitHub (Feb 21, 2020):

@fatedier
或许发现了问题 我的理解中 pool_count = 1 这个参数的意思是预先链接,如果有需要就从队列中取出一个链接使用,然后再新建到参数设置的链接上限,这样始终有活动的链接可用
但是实际上,同时只会有一个链接可用....如果超了就会报错

更改为更大,或者为0即修复了这个问题

<!-- gh-comment-id:589537055 --> @windowscv commented on GitHub (Feb 21, 2020): @fatedier 或许发现了问题 我的理解中 pool_count = 1 这个参数的意思是预先链接,如果有需要就从队列中取出一个链接使用,然后再新建到参数设置的链接上限,这样始终有活动的链接可用 但是实际上,同时只会有一个链接可用....如果超了就会报错 更改为更大,或者为0即修复了这个问题
Author
Owner

@fatedier commented on GitHub (Feb 21, 2020):

@as1543100166 正常情况下,是保持这么多个数的连接,取出一个,就请求再建立一个。在某些异常情况下,会请求的次数过多,这样就丢弃多出的连接(这个并不会对实际使用造成影响)。

这个报错只是丢弃了多出的连接,和你遇到的 i/o deadline 以及其他的网络问题没有关系的。后续可以考虑增加这个 pool_count 的默认值,或者不打印出这个错误了。

<!-- gh-comment-id:589541305 --> @fatedier commented on GitHub (Feb 21, 2020): @as1543100166 正常情况下,是保持这么多个数的连接,取出一个,就请求再建立一个。在某些异常情况下,会请求的次数过多,这样就丢弃多出的连接(这个并不会对实际使用造成影响)。 这个报错只是丢弃了多出的连接,和你遇到的 i/o deadline 以及其他的网络问题没有关系的。后续可以考虑增加这个 pool_count 的默认值,或者不打印出这个错误了。
Author
Owner

@windowscv commented on GitHub (Feb 21, 2020):

@fatedier
还是会出现这个问题,出现这个错误后就会断开
还有我这里一个frps连接了多个frpc,我发现在其他frpc重连时,其他所有的都会断开(好像)
准备详细测试下..

2020/02/21 20:37:16 [I] [tcp.go:63] [5de85747467cd271] [test] tcp proxy listen port [11089]
2020/02/21 20:37:16 [I] [control.go:445] [5de85747467cd271] new proxy [test] success
2020/02/21 20:37:16 [I] [udp.go:81] [5de85747467cd271] [test1] udp proxy listen port [11089]
2020/02/21 20:37:16 [I] [control.go:445] [5de85747467cd271] new proxy [test1] success
2020/02/21 20:37:17 [I] [proxy.go:92] [5de85747467cd271] [test1] get a new work connection: [45.89.228.1xx:41478]
2020/02/21 20:37:17 [I] [control.go:305] [dd254682dfddd9b0] control writer is closing
2020/02/21 20:37:17 [I] [control.go:383] [dd254682dfddd9b0] client exit success
2020/02/21 20:37:18 [I] [service.go:392] [dd254682dfddd9b0] client login info: ip [172.105.205.117:46636] version [0.31.2] hostname [] os [linux] arch [amd64]
2020/02/21 20:37:19 [I] [udp.go:81] [dd254682dfddd9b0] [asd2] udp proxy listen port [11088]
2020/02/21 20:37:19 [I] [control.go:445] [dd254682dfddd9b0] new proxy [asd2] success
2020/02/21 20:37:19 [I] [tcp.go:63] [dd254682dfddd9b0] [asd1] tcp proxy listen port [11088]
2020/02/21 20:37:19 [I] [control.go:445] [dd254682dfddd9b0] new proxy [asd1] success
2020/02/21 20:37:20 [I] [proxy.go:92] [dd254682dfddd9b0] [asd2] get a new work connection: [172.105.205.117:46636]
<!-- gh-comment-id:589638777 --> @windowscv commented on GitHub (Feb 21, 2020): @fatedier 还是会出现这个问题,出现这个错误后就会断开 还有我这里一个frps连接了多个frpc,我发现在其他frpc重连时,其他所有的都会断开(好像) 准备详细测试下.. ``` 2020/02/21 20:37:16 [I] [tcp.go:63] [5de85747467cd271] [test] tcp proxy listen port [11089] 2020/02/21 20:37:16 [I] [control.go:445] [5de85747467cd271] new proxy [test] success 2020/02/21 20:37:16 [I] [udp.go:81] [5de85747467cd271] [test1] udp proxy listen port [11089] 2020/02/21 20:37:16 [I] [control.go:445] [5de85747467cd271] new proxy [test1] success 2020/02/21 20:37:17 [I] [proxy.go:92] [5de85747467cd271] [test1] get a new work connection: [45.89.228.1xx:41478] 2020/02/21 20:37:17 [I] [control.go:305] [dd254682dfddd9b0] control writer is closing 2020/02/21 20:37:17 [I] [control.go:383] [dd254682dfddd9b0] client exit success 2020/02/21 20:37:18 [I] [service.go:392] [dd254682dfddd9b0] client login info: ip [172.105.205.117:46636] version [0.31.2] hostname [] os [linux] arch [amd64] 2020/02/21 20:37:19 [I] [udp.go:81] [dd254682dfddd9b0] [asd2] udp proxy listen port [11088] 2020/02/21 20:37:19 [I] [control.go:445] [dd254682dfddd9b0] new proxy [asd2] success 2020/02/21 20:37:19 [I] [tcp.go:63] [dd254682dfddd9b0] [asd1] tcp proxy listen port [11088] 2020/02/21 20:37:19 [I] [control.go:445] [dd254682dfddd9b0] new proxy [asd1] success 2020/02/21 20:37:20 [I] [proxy.go:92] [dd254682dfddd9b0] [asd2] get a new work connection: [172.105.205.117:46636] ```
Author
Owner

@fatedier commented on GitHub (Feb 21, 2020):

@as1543100166 还是日志级别设置为 trace,如果在本地测试的时候能复现,可以把测试的配置贴出来,我这里自己复现一下。

<!-- gh-comment-id:589689069 --> @fatedier commented on GitHub (Feb 21, 2020): @as1543100166 还是日志级别设置为 trace,如果在本地测试的时候能复现,可以把测试的配置贴出来,我这里自己复现一下。
Author
Owner

@fatedier commented on GitHub (Feb 25, 2020):

@as1543100166 有进展吗?

<!-- gh-comment-id:590656695 --> @fatedier commented on GitHub (Feb 25, 2020): @as1543100166 有进展吗?
Author
Owner

@windowscv commented on GitHub (Feb 25, 2020):

@fatedier
我这边暂时解决了,我把tcp_mux关闭之后,基本上解决了(很少出现断开,除非是心跳失败)
具体原因未知(怀疑是多路复用的心跳失败了)

<!-- gh-comment-id:590657535 --> @windowscv commented on GitHub (Feb 25, 2020): @fatedier 我这边暂时解决了,我把tcp_mux关闭之后,基本上解决了(很少出现断开,除非是心跳失败) 具体原因未知(怀疑是多路复用的心跳失败了)
Author
Owner

@fatedier commented on GitHub (Feb 25, 2020):

@as1543100166 恩,多路复用这块目前用的是第三方库,自己本身会有一个心跳检测,时间间隔比 frp 自身的心跳更短一些。如果网络有波动的话,心跳失败就会断开连接。我主要关心的是在单机环境下,是否能够复现这个问题。

<!-- gh-comment-id:590659011 --> @fatedier commented on GitHub (Feb 25, 2020): @as1543100166 恩,多路复用这块目前用的是第三方库,自己本身会有一个心跳检测,时间间隔比 frp 自身的心跳更短一些。如果网络有波动的话,心跳失败就会断开连接。我主要关心的是在单机环境下,是否能够复现这个问题。
Author
Owner

@windowscv commented on GitHub (Feb 25, 2020):

@fatedier
这是我在本地环境下刚刚测试的,开启tcp_mux之后frpc依旧会报错(但是好像并不会断开,没有测试关闭之后有没有报错)
我之前的问题应该就是丢包导致多路复用心跳失败的锅了
frps

[common]
bind_addr = 0.0.0.0
bind_port = 54431
kcp_bind_port = 5444
dashboard_port = 6443
dashboard_user = admin
dashboard_pwd = TI5UUwqg
vhost_http_port = 801
vhost_https_port = 443
log_file = ./frps.log
log_level = trace
log_max_days = 3
token = 123456
subdomain_host = 47.52.219.xx
max_pool_count = 50
authentication_timeout = 0
tcp_mux = true
2020/02/25 11:09:00 [I] [service.go:152] frps tcp listen on 0.0.0.0:54431
2020/02/25 11:09:00 [I] [service.go:161] frps kcp listen on udp 0.0.0.0:5444
2020/02/25 11:09:00 [I] [service.go:194] http service listen on 0.0.0.0:801
2020/02/25 11:09:00 [I] [service.go:215] https service listen on 0.0.0.0:443
2020/02/25 11:09:00 [I] [service.go:251] Dashboard listen on 0.0.0.0:6443
2020/02/25 11:09:00 [I] [root.go:205] start frps success
2020/02/25 11:09:03 [T] [service.go:285] start check TLS connection...
2020/02/25 11:09:03 [T] [service.go:293] success check TLS connection
2020/02/25 11:09:03 [I] [service.go:392] [47fb3f32af8c6a02] client login info: ip [47.52.219.xx:57660] version [0.31.2] hostname [] os [linux] arch [amd64]
2020/02/25 11:09:03 [I] [tcp.go:63] [47fb3f32af8c6a02] [ali1] tcp proxy listen port [11686]
2020/02/25 11:09:03 [I] [control.go:445] [47fb3f32af8c6a02] new proxy [ali1] success
2020/02/25 11:09:03 [I] [udp.go:81] [47fb3f32af8c6a02] [ali11] udp proxy listen port [11686]
2020/02/25 11:09:03 [I] [control.go:445] [47fb3f32af8c6a02] new proxy [ali11] success
2020/02/25 11:09:03 [D] [proxy.go:150] [47fb3f32af8c6a02] [ali1] get a user connection [2xx.88.xx.178:34928]
2020/02/25 11:09:03 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered
2020/02/25 11:09:03 [I] [proxy.go:92] [47fb3f32af8c6a02] [ali1] get a new work connection: [47.52.219.xx:57660]
2020/02/25 11:09:03 [T] [proxy.go:226] [47fb3f32af8c6a02] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/25 11:09:03 [D] [proxy.go:237] [47fb3f32af8c6a02] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:57660]) userConn(l[172.31.50.103:11686] r[2xx.88.xx.178:34928])
2020/02/25 11:09:03 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:09:03 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered
2020/02/25 11:09:03 [D] [proxy.go:150] [47fb3f32af8c6a02] [ali1] get a user connection [2xx.88.xx.107:50552]
2020/02/25 11:09:03 [D] [control.go:245] [47fb3f32af8c6a02] get work connection from pool
2020/02/25 11:09:03 [I] [proxy.go:92] [47fb3f32af8c6a02] [ali1] get a new work connection: [47.52.219.xx:57660]
2020/02/25 11:09:03 [T] [proxy.go:226] [47fb3f32af8c6a02] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/25 11:09:03 [D] [proxy.go:237] [47fb3f32af8c6a02] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:57660]) userConn(l[172.31.50.103:11686] r[2xx.88.xx.107:50552])
2020/02/25 11:09:03 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered
2020/02/25 11:09:03 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:09:03 [D] [proxy.go:150] [47fb3f32af8c6a02] [ali1] get a user connection [2xx.88.xx.178:34902]
2020/02/25 11:10:19 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered
2020/02/25 11:10:20 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:10:20 [D] [proxy.go:150] [47fb3f32af8c6a02] [ali1] get a user connection [2xx.88.xx.107:50792]
2020/02/25 11:10:20 [D] [control.go:245] [47fb3f32af8c6a02] get work connection from pool
2020/02/25 11:10:20 [I] [proxy.go:92] [47fb3f32af8c6a02] [ali1] get a new work connection: [47.52.219.xx:57660]
2020/02/25 11:10:20 [T] [proxy.go:226] [47fb3f32af8c6a02] [ali1] handler user tcp connection, use_encryption: false, use_compression: false
2020/02/25 11:10:20 [D] [proxy.go:237] [47fb3f32af8c6a02] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:57660]) userConn(l[172.31.50.103:11686] r[2xx.88.xx.107:50792])
2020/02/25 11:10:20 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered
2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed
2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed

FRPc

[common]
server_addr = 47.52.219.xx
server_port = 54431
pool_count  = 0
tcp_mux     = true
protocol    = tcp
token       = 154310

[ali1]
type            = tcp
local_ip        = 127.0.0.1
local_port      = 10087
use_encryption  = false
use_compression = false
remote_port     = 11686

[ali11]
type            = udp
local_ip        = 127.0.0.1
local_port      = 10087
use_encryption  = false
use_compression = false
remote_port     = 11686
2020/02/25 03:09:03 [I] [service.go:250] [47fb3f32af8c6a02] login to server success, get run id [47fb3f32af8c6a02], server udp port [0]
2020/02/25 03:09:03 [I] [proxy_manager.go:144] [47fb3f32af8c6a02] proxy added: [ali1 ali11]
2020/02/25 03:09:03 [I] [control.go:164] [47fb3f32af8c6a02] [ali1] start proxy success
2020/02/25 03:09:03 [I] [control.go:164] [47fb3f32af8c6a02] [ali11] start proxy success
2020/02/25 03:09:03 [I] [proxy.go:438] [47fb3f32af8c6a02] [ali11] incoming a new work connection for udp proxy, 47.52.219.xx:54431
2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF
2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF

<!-- gh-comment-id:590662289 --> @windowscv commented on GitHub (Feb 25, 2020): @fatedier 这是我在本地环境下刚刚测试的,开启tcp_mux之后frpc依旧会报错(但是好像并不会断开,没有测试关闭之后有没有报错) 我之前的问题应该就是丢包导致多路复用心跳失败的锅了 frps ``` [common] bind_addr = 0.0.0.0 bind_port = 54431 kcp_bind_port = 5444 dashboard_port = 6443 dashboard_user = admin dashboard_pwd = TI5UUwqg vhost_http_port = 801 vhost_https_port = 443 log_file = ./frps.log log_level = trace log_max_days = 3 token = 123456 subdomain_host = 47.52.219.xx max_pool_count = 50 authentication_timeout = 0 tcp_mux = true ``` ``` 2020/02/25 11:09:00 [I] [service.go:152] frps tcp listen on 0.0.0.0:54431 2020/02/25 11:09:00 [I] [service.go:161] frps kcp listen on udp 0.0.0.0:5444 2020/02/25 11:09:00 [I] [service.go:194] http service listen on 0.0.0.0:801 2020/02/25 11:09:00 [I] [service.go:215] https service listen on 0.0.0.0:443 2020/02/25 11:09:00 [I] [service.go:251] Dashboard listen on 0.0.0.0:6443 2020/02/25 11:09:00 [I] [root.go:205] start frps success 2020/02/25 11:09:03 [T] [service.go:285] start check TLS connection... 2020/02/25 11:09:03 [T] [service.go:293] success check TLS connection 2020/02/25 11:09:03 [I] [service.go:392] [47fb3f32af8c6a02] client login info: ip [47.52.219.xx:57660] version [0.31.2] hostname [] os [linux] arch [amd64] 2020/02/25 11:09:03 [I] [tcp.go:63] [47fb3f32af8c6a02] [ali1] tcp proxy listen port [11686] 2020/02/25 11:09:03 [I] [control.go:445] [47fb3f32af8c6a02] new proxy [ali1] success 2020/02/25 11:09:03 [I] [udp.go:81] [47fb3f32af8c6a02] [ali11] udp proxy listen port [11686] 2020/02/25 11:09:03 [I] [control.go:445] [47fb3f32af8c6a02] new proxy [ali11] success 2020/02/25 11:09:03 [D] [proxy.go:150] [47fb3f32af8c6a02] [ali1] get a user connection [2xx.88.xx.178:34928] 2020/02/25 11:09:03 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered 2020/02/25 11:09:03 [I] [proxy.go:92] [47fb3f32af8c6a02] [ali1] get a new work connection: [47.52.219.xx:57660] 2020/02/25 11:09:03 [T] [proxy.go:226] [47fb3f32af8c6a02] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/25 11:09:03 [D] [proxy.go:237] [47fb3f32af8c6a02] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:57660]) userConn(l[172.31.50.103:11686] r[2xx.88.xx.178:34928]) 2020/02/25 11:09:03 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:09:03 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered 2020/02/25 11:09:03 [D] [proxy.go:150] [47fb3f32af8c6a02] [ali1] get a user connection [2xx.88.xx.107:50552] 2020/02/25 11:09:03 [D] [control.go:245] [47fb3f32af8c6a02] get work connection from pool 2020/02/25 11:09:03 [I] [proxy.go:92] [47fb3f32af8c6a02] [ali1] get a new work connection: [47.52.219.xx:57660] 2020/02/25 11:09:03 [T] [proxy.go:226] [47fb3f32af8c6a02] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/25 11:09:03 [D] [proxy.go:237] [47fb3f32af8c6a02] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:57660]) userConn(l[172.31.50.103:11686] r[2xx.88.xx.107:50552]) 2020/02/25 11:09:03 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered 2020/02/25 11:09:03 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:09:03 [D] [proxy.go:150] [47fb3f32af8c6a02] [ali1] get a user connection [2xx.88.xx.178:34902] 2020/02/25 11:10:19 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered 2020/02/25 11:10:20 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:10:20 [D] [proxy.go:150] [47fb3f32af8c6a02] [ali1] get a user connection [2xx.88.xx.107:50792] 2020/02/25 11:10:20 [D] [control.go:245] [47fb3f32af8c6a02] get work connection from pool 2020/02/25 11:10:20 [I] [proxy.go:92] [47fb3f32af8c6a02] [ali1] get a new work connection: [47.52.219.xx:57660] 2020/02/25 11:10:20 [T] [proxy.go:226] [47fb3f32af8c6a02] [ali1] handler user tcp connection, use_encryption: false, use_compression: false 2020/02/25 11:10:20 [D] [proxy.go:237] [47fb3f32af8c6a02] [ali1] join connections, workConn(l[172.31.50.103:54431] r[47.52.219.xx:57660]) userConn(l[172.31.50.103:11686] r[2xx.88.xx.107:50792]) 2020/02/25 11:10:20 [D] [control.go:217] [47fb3f32af8c6a02] new work connection registered 2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed 2020/02/25 11:10:24 [D] [proxy.go:251] [47fb3f32af8c6a02] [ali1] join connections closed ``` FRPc ``` [common] server_addr = 47.52.219.xx server_port = 54431 pool_count = 0 tcp_mux = true protocol = tcp token = 154310 [ali1] type = tcp local_ip = 127.0.0.1 local_port = 10087 use_encryption = false use_compression = false remote_port = 11686 [ali11] type = udp local_ip = 127.0.0.1 local_port = 10087 use_encryption = false use_compression = false remote_port = 11686 ``` ``` 2020/02/25 03:09:03 [I] [service.go:250] [47fb3f32af8c6a02] login to server success, get run id [47fb3f32af8c6a02], server udp port [0] 2020/02/25 03:09:03 [I] [proxy_manager.go:144] [47fb3f32af8c6a02] proxy added: [ali1 ali11] 2020/02/25 03:09:03 [I] [control.go:164] [47fb3f32af8c6a02] [ali1] start proxy success 2020/02/25 03:09:03 [I] [control.go:164] [47fb3f32af8c6a02] [ali11] start proxy success 2020/02/25 03:09:03 [I] [proxy.go:438] [47fb3f32af8c6a02] [ali11] incoming a new work connection for udp proxy, 47.52.219.xx:54431 2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:58 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF 2020/02/25 03:09:59 [E] [control.go:147] [47fb3f32af8c6a02] work connection closed before response StartWorkConn message: EOF ```
Author
Owner

@fatedier commented on GitHub (Feb 25, 2020):

@as1543100166 你这个单机的测试,基本上是没有问题的,这个报错可以忽略的,不影响,之后的版本中会考虑优化一下,这样的情况就不打印错误日志了。

<!-- gh-comment-id:590664610 --> @fatedier commented on GitHub (Feb 25, 2020): @as1543100166 你这个单机的测试,基本上是没有问题的,这个报错可以忽略的,不影响,之后的版本中会考虑优化一下,这样的情况就不打印错误日志了。
Author
Owner

@wangjintianya commented on GitHub (Feb 23, 2023):

@as1543100166 恩,多路复用这块目前用的是第三方库,自己本身会有一个心跳检测,时间间隔比 frp 自身的心跳更短一些。如果网络有波动的话,心跳失败就会断开连接。我主要关心的是在单机环境下,是否能够复现这个问题。

这个问题后面修复了吗

<!-- gh-comment-id:1441101036 --> @wangjintianya commented on GitHub (Feb 23, 2023): > @as1543100166 恩,多路复用这块目前用的是第三方库,自己本身会有一个心跳检测,时间间隔比 frp 自身的心跳更短一些。如果网络有波动的话,心跳失败就会断开连接。我主要关心的是在单机环境下,是否能够复现这个问题。 这个问题后面修复了吗
Sign in to join this conversation.
No milestone
No project
No assignees
1 participant
Notifications
Due date
The due date is invalid or out of range. Please use the format "yyyy-mm-dd".

No due date set.

Dependencies

No dependencies set.

Reference: github-starred/frp#1313
No description provided.