search

nymtech / nym

Nym provides strong network-level privacy against sophisticated end-to-end attackers, and anonymous transactions using blinded, re-randomizable, decentralized credentials.
https://nymtech.net
1.28k stars 234 forks source link

Sphinx client error when sending larger file 'socks5 outbound > failed to write response back to the socket' #484

Open rachyandco opened 3 years ago

rachyandco commented 3 years ago

I am using sphinx client (with --vpn-mode) with an open proxy with telegram connected through proxy:

When sending a picture, the following logs are to be seen. The picture (400Kb) was successfully uploaded

log on socks5proxy (local machine)

2020-12-06T15:56:25.533 INFO  nym_socks5_client::socks::client > Starting proxy for 2001:67c:4e8:f004:0:0:0:a:443 (id: 4538841645171104273)
 2020-12-06T15:56:26.532 INFO  nym_socks5_client::socks::client > Starting proxy for 149.154.167.92:443 (id: 8357911634587629068)
 2020-12-06T15:56:26.532 INFO  nym_socks5_client::socks::client > Starting proxy for 2001:67c:4e8:f004:0:0:0:a:443 (id: 10007322987301896512)
 2020-12-06T15:56:26.532 INFO  nym_socks5_client::socks::client > Starting proxy for 149.154.167.92:80 (id: 13596644272005813144)
 2020-12-06T15:56:28.011 ERROR (14407089235322256037) socks5 outbound > failed to write response back to the socket - Broken pipe (os error 32)
 2020-12-06T15:56:28.011 INFO  nym_socks5_client::socks::client       > Proxy for 2001:67c:4e8:f004:0:0:0:a:443 is finished (id: 14407089235322256037)
 2020-12-06T15:56:52.416 INFO  nym_socks5_client::socks::client       > Proxy for 149.154.167.92:443 is finished (id: 15886788598551936159)

on the server side:

Dec  6 14:56:14 nym nym-network-requester[124933]:  2020-12-06T14:56:14.757 INFO  nym_network_requester::core            > Starting proxy for 2001:67c:4e8:f004:0:0:0:a:443 (currently there are 38 proxies being handled)
Dec  6 14:56:20 nym nym-client[650]:  2020-12-06T14:56:20.096 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 20 (set id: 195454304)
Dec  6 14:56:20 nym nym-client[650]:  2020-12-06T14:56:20.252 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 2 (set id: 546997799)
Dec  6 14:56:20 nym nym-client[650]:  2020-12-06T14:56:20.287 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 3 (set id: 546997799)
Dec  6 14:56:20 nym nym-client[650]:  2020-12-06T14:56:20.420 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 14 (set id: 195454304)
Dec  6 14:56:20 nym nym-client[650]:  2020-12-06T14:56:20.439 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 19 (set id: 546997799)
Dec  6 14:56:20 nym nym-client[650]:  2020-12-06T14:56:20.512 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 11 (set id: 546997799)
Dec  6 14:56:20 nym nym-client[650]:  2020-12-06T14:56:20.690 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 3 (set id: 109288536)
Dec  6 14:56:20 nym nym-client[650]:  2020-12-06T14:56:20.745 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 1 (set id: 109288536)
Dec  6 14:56:20 nym nym-client[650]:  2020-12-06T14:56:20.757 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 9 (set id: 546997799)
Dec  6 14:56:22 nym nym-client[650]:  2020-12-06T14:56:22.248 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 15 (set id: 546997799)
Dec  6 14:56:22 nym nym-client[650]:  2020-12-06T14:56:22.346 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 5 (set id: 195454304)
Dec  6 14:56:22 nym nym-client[650]:  2020-12-06T14:56:22.486 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 2 (set id: 546997799)
Dec  6 14:56:22 nym nym-client[650]:  2020-12-06T14:56:22.540 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 19 (set id: 195454304)
Dec  6 14:56:24 nym nym-client[650]:  2020-12-06T14:56:24.089 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 17 (set id: 546997799)
Dec  6 14:56:24 nym nym-client[650]:  2020-12-06T14:56:24.565 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 15 (set id: 546997799)
Dec  6 14:56:25 nym nym-network-requester[124933]:  2020-12-06T14:56:25.819 INFO  nym_network_requester::core            > Starting proxy for 149.154.167.92:443 (currently there are 39 proxies being handled)
Dec  6 14:56:25 nym nym-network-requester[124933]:  2020-12-06T14:56:25.954 INFO  nym_network_requester::core            > Starting proxy for 149.154.167.92:443 (currently there are 40 proxies being handled)
Dec  6 14:56:25 nym nym-network-requester[124933]:  2020-12-06T14:56:25.975 WARN  proxy_helpers::connection_controller   > Received a 'Send' before 'Connect' - going to buffer the data
Dec  6 14:56:26 nym nym-network-requester[124933]:  2020-12-06T14:56:26.212 WARN  proxy_helpers::connection_controller   > Received a 'Send' before 'Connect' - going to buffer the data
Dec  6 14:56:26 nym nym-network-requester[124933]:  2020-12-06T14:56:26.251 INFO  nym_network_requester::core            > Starting proxy for 2001:67c:4e8:f004:0:0:0:a:443 (currently there are 41 proxies being handled)
Dec  6 14:56:26 nym nym-network-requester[124933]:  2020-12-06T14:56:26.292 WARN  proxy_helpers::connection_controller   > Received a 'Send' before 'Connect' - going to buffer the data
Dec  6 14:56:26 nym nym-network-requester[124933]:  2020-12-06T14:56:26.314 INFO  nym_network_requester::core            > Starting proxy for 149.154.167.92:80 (currently there are 42 proxies being handled)
Dec  6 14:56:27 nym nym-network-requester[124933]:  2020-12-06T14:56:27.345 WARN  proxy_helpers::connection_controller   > Received a 'Send' before 'Connect' - going to buffer the data
Dec  6 14:56:27 nym nym-network-requester[124933]:  2020-12-06T14:56:27.383 WARN  proxy_helpers::connection_controller   > Received a 'Send' before 'Connect' - going to buffer the data
Dec  6 14:56:27 nym nym-network-requester[124933]:  2020-12-06T14:56:27.395 INFO  nym_network_requester::core            > Starting proxy for 2001:67c:4e8:f004:0:0:0:a:443 (currently there are 43 proxies being handled)
Dec  6 14:56:27 nym nym-network-requester[124933]:  2020-12-06T14:56:27.402 INFO  nym_network_requester::core            > Starting proxy for 149.154.167.92:443 (currently there are 44 proxies being handled)
Dec  6 14:56:27 nym nym-network-requester[124933]:  2020-12-06T14:56:27.553 WARN  proxy_helpers::connection_controller   > Received a 'Send' before 'Connect' - going to buffer the data
Dec  6 14:56:28 nym nym-network-requester[124933]:  2020-12-06T14:56:28.116 INFO  nym_network_requester::core            > Starting proxy for 149.154.167.92:80 (currently there are 45 proxies being handled)
Dec  6 14:56:28 nym nym-network-requester[124933]:  2020-12-06T14:56:28.249 INFO  nym_network_requester::core            > Starting proxy for 2001:67c:4e8:f004:0:0:0:a:443 (currently there are 46 proxies being handled)
Dec  6 14:56:28 nym nym-network-requester[124933]:  2020-12-06T14:56:28.714 INFO  nym_network_requester::core            > Starting proxy for 149.154.167.92:80 (currently there are 47 proxies being handled)
Dec  6 14:56:29 nym nym-client[650]:  2020-12-06T14:56:29.104 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 18 (set id: 1156435496)
Dec  6 14:56:29 nym nym-client[650]:  2020-12-06T14:56:29.454 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 14 (set id: 1156435496)
Dec  6 14:56:31 nym nym-client[650]:  2020-12-06T14:56:31.878 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 7 (set id: 1156435496)
Dec  6 14:56:32 nym nym-client[650]:  2020-12-06T14:56:32.546 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 3 (set id: 1054044899)
Dec  6 14:56:33 nym nym-client[650]:  2020-12-06T14:56:33.004 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 21 (set id: 1054044899)
Dec  6 14:56:33 nym nym-client[650]:  2020-12-06T14:56:33.093 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 20 (set id: 1054044899)
Dec  6 14:56:33 nym nym-client[650]:  2020-12-06T14:56:33.224 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 32 (set id: 1054044899)
Dec  6 14:56:33 nym nym-client[650]:  2020-12-06T14:56:33.342 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 28 (set id: 1054044899)
Dec  6 14:56:33 nym nym-client[650]:  2020-12-06T14:56:33.547 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 30 (set id: 1054044899)
Dec  6 14:56:33 nym nym-client[650]:  2020-12-06T14:56:33.856 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 31 (set id: 1054044899)
Dec  6 14:56:34 nym nym-client[650]:  2020-12-06T14:56:34.947 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 7 (set id: 1054044899)
Dec  6 14:56:51 nym nym-network-requester[124933]:  2020-12-06T14:56:51.972 INFO  nym_network_requester::core            > Proxy for 149.154.167.92:443 is finished  (currently there are 46 proxies being handled)
Dec  6 14:57:12 nym nym-network-requester[124933]:  2020-12-06T14:57:12.355 INFO  nym_network_requester::core            > Proxy for 149.154.167.92:443 is finished  (currently there are 45 proxies being handled)
Dec  6 14:57:35 nym nym-network-requester[124933]:  2020-12-06T14:57:35.855 INFO  nym_network_requester::core            > Starting proxy for 149.154.167.92:80 (currently there are 46 proxies being handled)
Dec  6 14:57:36 nym nym-network-requester[124933]:  2020-12-06T14:57:36.010 INFO  nym_network_requester::core            > Starting proxy for 149.154.167.92:443 (currently there are 47 proxies being handled)
Dec  6 14:57:36 nym nym-network-requester[124933]:  2020-12-06T14:57:36.076 WARN  proxy_helpers::connection_controller   > Received a 'Send' before 'Connect' - going to buffer the data
Dec  6 14:57:36 nym nym-network-requester[124933]:  2020-12-06T14:57:36.113 INFO  nym_network_requester::core            > Starting proxy for 2001:67c:4e8:f004:0:0:0:a:443 (currently there are 48 proxies being handled)
Dec  6 14:57:36 nym nym-network-requester[124933]:  2020-12-06T14:57:36.955 INFO  nym_network_requester::core            > Starting proxy for 2001:67c:4e8:f004:0:0:0:a:443 (currently there are 49 proxies being handled)
rachyandco commented 3 years ago

sending (successfully) a larger file (10MB and 100MB) is generating also extra errors on the client side

 2020-12-06T16:18:49.112 ERROR (1332126686756355032) socks5 outbound  > failed to write response back to the socket - Broken pipe (os error 32)
 2020-12-06T16:18:49.112 INFO  nym_socks5_client::socks::client       > Proxy for 149.154.167.92:443 is finished (id: 1332126686756355032)
 2020-12-06T16:18:50.229 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (97 bytes were 'lost)
 2020-12-06T16:18:51.412 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (97 bytes were 'lost)
 2020-12-06T16:18:51.990 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (97 bytes were 'lost)
 2020-12-06T16:18:53.099 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (161 bytes were 'lost)
 2020-12-06T16:18:54.891 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (97 bytes were 'lost)
 2020-12-06T16:19:04.550 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (97 bytes were 'lost)
 2020-12-06T16:19:08.999 INFO  nym_socks5_client::socks::client       > Proxy for 149.154.166.120:443 is finished (id: 11312797353054832208)
 2020-12-06T16:19:11.244 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (8 bytes were 'lost)
 2020-12-06T16:19:24.099 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (97 bytes were 'lost)
 2020-12-06T16:19:31.953 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (97 bytes were 'lost)
 2020-12-06T16:19:36.219 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (161 bytes were 'lost)
 2020-12-06T16:19:49.781 ERROR proxy_helpers::connection_controller   > Tried to write to closed connection (8 bytes were 'lost)

with a lot of errors on the server side from the nym-client:

Dec  6 15:20:32 nym nym-client[650]:  2020-12-06T15:20:32.670 WARN  nymsphinx_chunking::reconstruction > duplicate fragment received! - frag - 169 (set id: 310586368)