Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Large file transfer stopped #279

Closed
bodemann opened this issue Oct 1, 2020 · 7 comments
Closed

Large file transfer stopped #279

bodemann opened this issue Oct 1, 2020 · 7 comments

Comments

@bodemann
Copy link

bodemann commented Oct 1, 2020

Problem while transfering a 500 MB file (.zip) from Win10 to Manjaro (Arch) Linux.

Manjaro Version: croc version v8.3.1-f2af0b7
Win10 Version was just downloaded via scoop

The transfer stopped multiple times (3-4x). The 1st around 25% worked without problems. After I noticed I killed the connection on the receiving side (Linux) and re-connected. The re-connect worked without problems.

The connection was stable since I was using VNC over ssh at the same time.

One way of getting around would be an auto reconnect as described in #151

BTW: croc is a very nice program. Well done!
@schollz
Copy link
Owner

schollz commented Oct 2, 2020

Is this consistent? Could you use --debug and share the output?

@bodemann
Copy link
Author

bodemann commented Oct 3, 2020

It seems to be consistent:

This is the receiver log, followed by the sender log.

�[0;36m[debug] �[0m07:52:02 cli.go:126: debug mode on
�[0;36m[debug] �[0m07:52:02 croc.go:155: options: {IsSender:false SharedSecret:pulse-future-freedom Debug:true RelayAddress:142.93.177.120:9009 RelayAddress6:[2604:a880:800:c1::14c:1]:9009 RelayPorts:[] RelayPassword:pass123 Stdout:false NoPrompt:false NoMultiplexing:false DisableLocal:false Ask:false SendingText:false NoCompress:false}
�[0;36m[debug] �[0m07:52:02 croc.go:475: attempt to discover peers
�[0;36m[debug] �[0m07:52:03 croc.go:533: discoveries: []
�[0;36m[debug] �[0m07:52:03 croc.go:534: establishing connection
�[0;36m[debug] �[0m07:52:03 croc.go:549: got host '2604:a880:800:c1::14c:1' and port '9009'
�[0;36m[debug] �[0m07:52:03 croc.go:551: trying connection to [2604:a880:800:c1::14c:1]:9009
�[0;36m[debug] �[0m07:52:03 croc.go:557: could not establish '[2604:a880:800:c1::14c:1]:9009'
�[0;36m[debug] �[0m07:52:03 croc.go:549: got host '142.93.177.120' and port '9009'
�[0;36m[debug] �[0m07:52:03 croc.go:551: trying connection to 142.93.177.120:9009
�[0;36m[debug] �[0m07:52:03 comm.go:32: connected to '142.93.177.120:9009'
�[0;36m[debug] �[0m07:52:03 tcp.go:412: strong key: c19bca3c9a9c0ec00758af54277931cb6a475b4666cd066c7930c17472274dda
�[0;36m[debug] �[0m07:52:03 tcp.go:421: sending password
�[0;36m[debug] �[0m07:52:03 tcp.go:430: waiting for first ok
�[0;36m[debug] �[0m07:52:03 tcp.go:445: sending room
�[0;36m[debug] �[0m07:52:03 tcp.go:454: waiting for room confirmation
�[0;36m[debug] �[0m07:52:03 tcp.go:467: all set
�[0;36m[debug] �[0m07:52:03 croc.go:564: receiver connection established: &{connection:0xc00032e010}
�[0;36m[debug] �[0m07:52:03 croc.go:565: banner: 9010,9011,9012,9013
�[0;36m[debug] �[0m07:52:03 croc.go:570: sending ips?
�[0;36m[debug] �[0m07:52:03 croc.go:579: ips data: ["","192.168.192.15","192.168.136.1","192.168.56.1"]
�[0;36m[debug] �[0m07:52:03 croc.go:589: ipv4Add4: 192.168.192.15, ipv4Net: 192.168.192.0/24, err:
�[0;36m[debug] �[0m07:52:03 croc.go:607: could not connect to 192.168.192.15:
�[0;36m[debug] �[0m07:52:03 croc.go:589: ipv4Add4: 192.168.136.1, ipv4Net: 192.168.136.0/24, err:
�[0;36m[debug] �[0m07:52:03 croc.go:600: 192.168.136.1 is not a local IP, skipping
�[0;36m[debug] �[0m07:52:03 croc.go:589: ipv4Add4: 192.168.56.1, ipv4Net: 192.168.56.0/24, err:
�[0;36m[debug] �[0m07:52:03 croc.go:600: 192.168.56.1 is not a local IP, skipping
�[0;36m[debug] �[0m07:52:03 croc.go:632: exchanged header message
�[0;36m[debug] �[0m07:52:03 croc.go:644: ready
�[0;36m[debug] �[0m07:52:03 message.go:46: writing pake message
�[0;36m[debug] �[0m07:52:03 croc.go:769: received pake payload
�[0;36m[debug] �[0m07:52:03 message.go:46: writing pake message
�[0;36m[debug] �[0m07:52:03 croc.go:807: port: [9010]
�[0;36m[debug] �[0m07:52:03 croc.go:807: port: [9011]
�[0;36m[debug] �[0m07:52:03 croc.go:807: port: [9012]
�[0;36m[debug] �[0m07:52:03 croc.go:807: port: [9013]
�[0;36m[debug] �[0m07:52:03 croc.go:821: connecting to 142.93.177.120:9013
�[0;36m[debug] �[0m07:52:03 croc.go:821: connecting to 142.93.177.120:9011
�[0;36m[debug] �[0m07:52:03 croc.go:821: connecting to 142.93.177.120:9010
�[0;36m[debug] �[0m07:52:03 croc.go:821: connecting to 142.93.177.120:9012
�[0;36m[debug] �[0m07:52:04 comm.go:32: connected to '142.93.177.120:9012'
�[0;36m[debug] �[0m07:52:04 comm.go:32: connected to '142.93.177.120:9010'
�[0;36m[debug] �[0m07:52:04 comm.go:32: connected to '142.93.177.120:9011'
�[0;36m[debug] �[0m07:52:04 comm.go:32: connected to '142.93.177.120:9013'
�[0;36m[debug] �[0m07:52:04 tcp.go:412: strong key: 760fc9dacd2d5a1d65ba23d425945d25261812e56bf6ac2f615ff8e509251197
�[0;36m[debug] �[0m07:52:04 tcp.go:421: sending password
�[0;36m[debug] �[0m07:52:04 tcp.go:430: waiting for first ok
�[0;36m[debug] �[0m07:52:04 tcp.go:412: strong key: c26db09f7f5c8cc192c041d6e2e419a24325d6059e1e5fe9d93face1146d2132
�[0;36m[debug] �[0m07:52:04 tcp.go:421: sending password
�[0;36m[debug] �[0m07:52:04 tcp.go:430: waiting for first ok
�[0;36m[debug] �[0m07:52:04 tcp.go:412: strong key: 94694ecb454af55562a8a70eb332f75ddb9e3f99436a495fdd5465c376dbaefc
�[0;36m[debug] �[0m07:52:04 tcp.go:421: sending password
�[0;36m[debug] �[0m07:52:04 tcp.go:430: waiting for first ok
�[0;36m[debug] �[0m07:52:04 tcp.go:412: strong key: 434b8acc837b8ce5efc5ae624fb53a8a819b1eec2e5ee87c753ba093c8488df4
�[0;36m[debug] �[0m07:52:04 tcp.go:421: sending password
�[0;36m[debug] �[0m07:52:04 tcp.go:430: waiting for first ok
�[0;36m[debug] �[0m07:52:04 tcp.go:445: sending room
�[0;36m[debug] �[0m07:52:04 tcp.go:454: waiting for room confirmation
�[0;36m[debug] �[0m07:52:04 tcp.go:445: sending room
�[0;36m[debug] �[0m07:52:04 tcp.go:454: waiting for room confirmation
�[0;36m[debug] �[0m07:52:04 tcp.go:445: sending room
�[0;36m[debug] �[0m07:52:04 tcp.go:454: waiting for room confirmation
�[0;36m[debug] �[0m07:52:04 tcp.go:445: sending room
�[0;36m[debug] �[0m07:52:04 tcp.go:454: waiting for room confirmation
�[0;36m[debug] �[0m07:52:04 tcp.go:467: all set
�[0;36m[debug] �[0m07:52:04 croc.go:830: connected to 142.93.177.120:9012
�[0;36m[debug] �[0m07:52:04 croc.go:1295: 2 receiving data
�[0;36m[debug] �[0m07:52:04 croc.go:1302: got ping
�[0;36m[debug] �[0m07:52:04 tcp.go:467: all set
�[0;36m[debug] �[0m07:52:04 croc.go:830: connected to 142.93.177.120:9010
�[0;36m[debug] �[0m07:52:04 croc.go:1295: 0 receiving data
�[0;36m[debug] �[0m07:52:04 croc.go:1302: got ping
�[0;36m[debug] �[0m07:52:04 tcp.go:467: all set
�[0;36m[debug] �[0m07:52:04 croc.go:830: connected to 142.93.177.120:9013
�[0;36m[debug] �[0m07:52:04 croc.go:1295: 3 receiving data
�[0;36m[debug] �[0m07:52:04 tcp.go:467: all set
�[0;36m[debug] �[0m07:52:04 croc.go:830: connected to 142.93.177.120:9011
�[0;36m[debug] �[0m07:52:04 croc.go:1295: 1 receiving data
�[0;36m[debug] �[0m07:52:04 croc.go:842: received salt
�[0;36m[debug] �[0m07:52:04 croc.go:844: sending salt back
�[0;36m[debug] �[0m07:52:04 croc.go:1302: got ping
�[0;36m[debug] �[0m07:52:04 message.go:46: writing salt message
�[0;36m[debug] �[0m07:52:04 croc.go:850: session key is verified, generating encryption with salt: b579c77a83b327ba
�[0;36m[debug] �[0m07:52:04 croc.go:859: key = 1586c1de140f27475f75aba58334a2185bfda5b4532233bc5713de9c338ff309
�[0;36m[debug] �[0m07:52:04 croc.go:1302: got ping
�[0;36m[debug] �[0m07:52:04 croc.go:872: received external IP: {"t":"externalip","m":"85.212.212.253:50584","b":"tXnHeoOzJ7o="}
�[0;36m[debug] �[0m07:52:04 message.go:43: writing externalip message (encrypted)
�[0;36m[debug] �[0m07:52:04 croc.go:886: connected as 79.216.1.159:37306 -> 85.212.212.253:50584
�[0;36m[debug] �[0m07:52:06 croc.go:763: [{Sage50.zip . D:\ [199 205 229 238 1 179 65 73 10 209 29 161 161 162 174 194] 500786887 2020-09-30 19:49:01.169199 +0200 CEST false false }]
�[0;36m[debug] �[0m07:52:06 croc.go:1166: checking {Name:Sage50.zip FolderRemote:. FolderSource:D:\ Hash:[199 205 229 238 1 179 65 73 10 209 29 161 161 162 174 194] Size:500786887 ModTime:2020-09-30 19:49:01.169199 +0200 CEST IsCompressed:false IsEncrypted:false Symlink:}
�[0;36m[debug] �[0m07:52:06 croc.go:1178: Sage50.zip 00000000000000000000000000000000 c7cde5ee01b341490ad11da1a1a2aec2 open Sage50.zip: no such file or directory
�[0;36m[debug] �[0m07:52:06 croc.go:1180: hashes are not equal 00000000000000000000000000000000 != c7cde5ee01b341490ad11da1a1a2aec2
�[0;36m[debug] �[0m07:52:06 croc.go:1186: open Sage50.zip: no such file or directory
�[0;36m[debug] �[0m07:52:06 croc.go:1009: working on file 0
�[0;36m[debug] �[0m07:52:06 croc.go:1088: converting to chunk range
�[0;36m[debug] �[0m07:52:06 croc.go:1096: sending recipient ready with 0 chunks
�[0;36m[debug] �[0m07:52:06 message.go:43: writing recipientready message (encrypted)
�[0;36m[debug] �[0m07:52:39 comm.go:132: consecutive read error: read tcp 192.168.192.171:57730->142.93.177.120:9013: i/o timeout
�[0;36m[debug] �[0m08:01:38 comm.go:132: consecutive read error: read tcp 192.168.192.171:47324->142.93.177.120:9010: i/o timeout

I started the sender like this: croc --debug Sage50.zip > croc-debug.txt

[debug] 07:51:19 cli.go:123: debug mode on
[debug] 07:51:20 croc.go:155: options: {IsSender:true SharedSecret:pulse-future-freedom Debug:true RelayAddress:142.93.177.120:9009 RelayAddress6:[2604:a880:800:c1::14c:1]:9009 RelayPorts:[] RelayPassword:pass123 Stdout:false NoPrompt:false NoMultiplexing:false DisableLocal:false Ask:false SendingText:false NoCompress:false}
[debug] 07:51:20 croc.go:247: file 0 info: {Name:Sage50.zip FolderRemote:. FolderSource:D:\ Hash:[199 205 229 238 1 179 65 73 10 209 29 161 161 162 174 194] Size:500786887 ModTime:2020-09-30 19:49:01.169199 +0200 CEST IsCompressed:false IsEncrypted:false Symlink:}
[debug] 07:51:20 croc.go:249: longestFilename: 10
[debug] 07:51:20 croc.go:375: host: '2604:a880:800:c1::14c:1', port: '9009'
[debug] 07:51:20 croc.go:381: got host '2604:a880:800:c1::14c:1' and port '9009'
[debug] 07:51:20 croc.go:383: trying connection to [2604:a880:800:c1::14c:1]:9009
[debug] 07:51:20 tcp.go:55: starting with password 'pass123'
[info] 2020/10/03 07:51:20 starting TCP server on
[debug] 07:51:20 croc.go:389: could not establish '[2604:a880:800:c1::14c:1]:9009'
[debug] 07:51:20 croc.go:375: host: '142.93.177.120', port: '9009'
[debug] 07:51:20 croc.go:381: got host '142.93.177.120' and port '9009'
[debug] 07:51:20 croc.go:383: trying connection to 142.93.177.120:9009
[debug] 07:51:20 comm.go:32: connected to '142.93.177.120:9009'
[debug] 07:51:20 tcp.go:412: strong key: dcbe5763757695872efea750b5f5f909fe86d49d76ef1e8bdc06cfcd6dc1c2b3
[debug] 07:51:20 tcp.go:421: sending password
[debug] 07:51:20 tcp.go:430: waiting for first ok
[debug] 07:51:20 croc.go:303: establishing connection
[debug] 07:51:20 croc.go:306: banner:
[debug] 07:51:20 croc.go:309: could not connect to localhost:: comm.NewConnection failed: dial tcp [::1]:0: connectex: Die angeforderte Adresse ist in diesem Kontext ung+?ltig.
[debug] 07:51:20 tcp.go:445: sending room
[debug] 07:51:20 tcp.go:454: waiting for room confirmation
[debug] 07:51:20 tcp.go:467: all set
[debug] 07:51:20 croc.go:400: banner: 9010,9011,9012,9013
[debug] 07:51:20 croc.go:401: connection established: &{connection:0xc0000a0000}
[debug] 07:51:20 croc.go:403: waiting for bytes
[debug] 07:51:20 croc.go:428: got ping
[debug] 07:51:20 croc.go:403: waiting for bytes
[debug] 07:51:21 croc.go:428: got ping
[debug] 07:51:21 croc.go:403: waiting for bytes
[debug] 07:51:22 croc.go:428: got ping
[debug] 07:51:22 croc.go:403: waiting for bytes
[debug] 07:51:23 croc.go:428: got ping
[debug] 07:51:23 croc.go:403: waiting for bytes
[debug] 07:51:24 croc.go:428: got ping
[debug] 07:51:24 croc.go:403: waiting for bytes
[debug] 07:51:25 croc.go:428: got ping
[debug] 07:51:25 croc.go:403: waiting for bytes
[debug] 07:51:26 croc.go:428: got ping
[debug] 07:51:26 croc.go:403: waiting for bytes
[debug] 07:51:27 croc.go:428: got ping
[debug] 07:51:27 croc.go:403: waiting for bytes
[debug] 07:51:28 croc.go:428: got ping
[debug] 07:51:28 croc.go:403: waiting for bytes
[debug] 07:51:29 croc.go:428: got ping
[debug] 07:51:29 croc.go:403: waiting for bytes
[debug] 07:51:30 croc.go:428: got ping
[debug] 07:51:30 croc.go:403: waiting for bytes
[debug] 07:51:31 croc.go:428: got ping
[debug] 07:51:31 croc.go:403: waiting for bytes
[debug] 07:51:32 croc.go:428: got ping
[debug] 07:51:32 croc.go:403: waiting for bytes
[debug] 07:51:33 croc.go:428: got ping
[debug] 07:51:33 croc.go:403: waiting for bytes
[debug] 07:51:34 croc.go:428: got ping
[debug] 07:51:34 croc.go:403: waiting for bytes
[debug] 07:51:35 croc.go:428: got ping
[debug] 07:51:35 croc.go:403: waiting for bytes
[debug] 07:51:36 croc.go:428: got ping
[debug] 07:51:36 croc.go:403: waiting for bytes
[debug] 07:51:37 croc.go:428: got ping
[debug] 07:51:37 croc.go:403: waiting for bytes
[debug] 07:51:38 croc.go:428: got ping
[debug] 07:51:38 croc.go:403: waiting for bytes
[debug] 07:51:39 croc.go:428: got ping
[debug] 07:51:39 croc.go:403: waiting for bytes
[debug] 07:51:40 croc.go:428: got ping
[debug] 07:51:40 croc.go:403: waiting for bytes
[debug] 07:51:41 croc.go:428: got ping
[debug] 07:51:41 croc.go:403: waiting for bytes
[debug] 07:51:42 croc.go:428: got ping
[debug] 07:51:42 croc.go:403: waiting for bytes
[debug] 07:51:43 croc.go:428: got ping
[debug] 07:51:43 croc.go:403: waiting for bytes
[debug] 07:51:44 croc.go:428: got ping
[debug] 07:51:44 croc.go:403: waiting for bytes
[debug] 07:51:45 croc.go:428: got ping
[debug] 07:51:45 croc.go:403: waiting for bytes
[debug] 07:51:46 croc.go:428: got ping
[debug] 07:51:46 croc.go:403: waiting for bytes
[debug] 07:51:47 croc.go:428: got ping
[debug] 07:51:47 croc.go:403: waiting for bytes
[debug] 07:51:48 croc.go:428: got ping
[debug] 07:51:48 croc.go:403: waiting for bytes
[debug] 07:51:49 croc.go:428: got ping
[debug] 07:51:49 croc.go:403: waiting for bytes
[debug] 07:51:50 croc.go:294: discoveries: []
[debug] 07:51:50 croc.go:294: discoveries: []
[debug] 07:51:50 croc.go:428: got ping
[debug] 07:51:50 croc.go:403: waiting for bytes
[debug] 07:51:51 croc.go:428: got ping
[debug] 07:51:51 croc.go:403: waiting for bytes
[debug] 07:51:52 croc.go:428: got ping
[debug] 07:51:52 croc.go:403: waiting for bytes
[debug] 07:51:53 croc.go:428: got ping
[debug] 07:51:53 croc.go:403: waiting for bytes
[debug] 07:51:54 croc.go:428: got ping
[debug] 07:51:54 croc.go:403: waiting for bytes
[debug] 07:51:55 croc.go:428: got ping
[debug] 07:51:55 croc.go:403: waiting for bytes
[debug] 07:51:56 croc.go:428: got ping
[debug] 07:51:56 croc.go:403: waiting for bytes
[debug] 07:51:57 croc.go:428: got ping
[debug] 07:51:57 croc.go:403: waiting for bytes
[debug] 07:51:58 croc.go:428: got ping
[debug] 07:51:58 croc.go:403: waiting for bytes
[debug] 07:51:59 croc.go:428: got ping
[debug] 07:51:59 croc.go:403: waiting for bytes
[debug] 07:52:00 croc.go:428: got ping
[debug] 07:52:00 croc.go:403: waiting for bytes
[debug] 07:52:01 croc.go:428: got ping
[debug] 07:52:01 croc.go:403: waiting for bytes
[debug] 07:52:02 croc.go:428: got ping
[debug] 07:52:02 croc.go:403: waiting for bytes
[debug] 07:52:03 croc.go:428: got ping
[debug] 07:52:03 croc.go:403: waiting for bytes
[debug] 07:52:03 croc.go:403: waiting for bytes
[debug] 07:52:04 croc.go:445: exchanged header message
[debug] 07:52:04 croc.go:644: ready
[debug] 07:52:04 croc.go:773: received pake payload
[debug] 07:52:04 message.go:46: writing pake message
[debug] 07:52:04 croc.go:773: received pake payload
[debug] 07:52:04 croc.go:792: generating salt
[debug] 07:52:04 message.go:46: writing salt message
[debug] 07:52:04 croc.go:811: port: [9010]
[debug] 07:52:04 croc.go:811: port: [9011]
[debug] 07:52:04 croc.go:811: port: [9012]
[debug] 07:52:04 croc.go:811: port: [9013]
[debug] 07:52:04 croc.go:825: connecting to 142.93.177.120:9013
[debug] 07:52:04 croc.go:825: connecting to 142.93.177.120:9010
[debug] 07:52:04 croc.go:825: connecting to 142.93.177.120:9011
[debug] 07:52:04 croc.go:825: connecting to 142.93.177.120:9012
[debug] 07:52:04 comm.go:32: connected to '142.93.177.120:9013'
[debug] 07:52:04 comm.go:32: connected to '142.93.177.120:9010'
[debug] 07:52:04 comm.go:32: connected to '142.93.177.120:9012'
[debug] 07:52:04 comm.go:32: connected to '142.93.177.120:9011'
[debug] 07:52:04 tcp.go:412: strong key: 602301f9598ad78e77f2cf6cdd173eb3b1db478b2a0f8f9feecd9cff37694b83
[debug] 07:52:04 tcp.go:421: sending password
[debug] 07:52:04 tcp.go:430: waiting for first ok
[debug] 07:52:04 tcp.go:412: strong key: 6617ae00b0d63172af2a87ecd1931ef843af9c387cd7b0e16ccc661a040931ea
[debug] 07:52:04 tcp.go:421: sending password
[debug] 07:52:04 tcp.go:430: waiting for first ok
[debug] 07:52:04 tcp.go:412: strong key: cf42a3610cda7c919ad221e4fafef6628d2663e80cbe8c338f3895d130ef2ceb
[debug] 07:52:04 tcp.go:421: sending password
[debug] 07:52:04 tcp.go:430: waiting for first ok
[debug] 07:52:04 tcp.go:412: strong key: 11cba8a101fbe6fba073a165eca6f4d3cfd30be5901c956b32158ad639223ccc
[debug] 07:52:04 tcp.go:421: sending password
[debug] 07:52:04 tcp.go:430: waiting for first ok
[debug] 07:52:04 tcp.go:445: sending room
[debug] 07:52:04 tcp.go:454: waiting for room confirmation
[debug] 07:52:04 tcp.go:445: sending room
[debug] 07:52:04 tcp.go:454: waiting for room confirmation
[debug] 07:52:04 tcp.go:445: sending room
[debug] 07:52:04 tcp.go:454: waiting for room confirmation
[debug] 07:52:04 tcp.go:445: sending room
[debug] 07:52:04 tcp.go:454: waiting for room confirmation
[debug] 07:52:04 tcp.go:467: all set
[debug] 07:52:04 croc.go:834: connected to 142.93.177.120:9010
[debug] 07:52:04 tcp.go:467: all set
[debug] 07:52:04 croc.go:834: connected to 142.93.177.120:9013
[debug] 07:52:04 tcp.go:467: all set
[debug] 07:52:04 croc.go:834: connected to 142.93.177.120:9012
[debug] 07:52:04 tcp.go:467: all set
[debug] 07:52:04 croc.go:834: connected to 142.93.177.120:9011
[debug] 07:52:04 croc.go:846: received salt
[debug] 07:52:04 croc.go:854: session key is verified, generating encryption with salt: b579c77a83b327ba
[debug] 07:52:04 croc.go:863: key = 1586c1de140f27475f75aba58334a2185bfda5b4532233bc5713de9c338ff309
[debug] 07:52:04 croc.go:865: sending external IP
[debug] 07:52:04 message.go:43: writing externalip message (encrypted)
[debug] 07:52:05 croc.go:876: received external IP: {"t":"externalip","m":"79.216.1.159:37306"}
[debug] 07:52:05 croc.go:890: connected as 85.212.212.253:50584 -> 79.216.1.159:37306
[debug] 07:52:05 message.go:43: writing fileinfo message (encrypted)
[debug] 07:52:06 croc.go:937: current file chunks: []
[debug] 07:52:06 croc.go:1215: start sending data!
[debug] 07:52:06 croc.go:1248: beginning sending comms
[debug] 07:52:06 croc.go:1260: starting sending over comm 0
[debug] 07:52:06 croc.go:1260: starting sending over comm 1
[debug] 07:52:06 croc.go:1260: starting sending over comm 2
[debug] 07:52:06 croc.go:1260: starting sending over comm 3
[debug] 08:49:17 croc.go:1364: finished with 1
[debug] 08:49:47 croc.go:1364: finished with 2
[debug] 09:08:02 comm.go:97: initial read error: EOF
[debug] 09:08:02 croc.go:661: got error receiving: EOF
[debug] 09:08:02 croc.go:454: error from errchan: EOF
EOF

@schollz
Copy link
Owner

schollz commented Oct 4, 2020

Is your large file being written by another program while it is being read (i.e. like alog file)?

@bodemann
Copy link
Author

bodemann commented Oct 4, 2020

Is your large file being written by another program while it is being read (i.e. like alog file)?

No, it is a .zip file and the same file I had the problem with I reported 1st.

@schollz
Copy link
Owner

schollz commented Oct 5, 2020

Is this problem bidirectional?

@bodemann
Copy link
Author

bodemann commented Oct 7, 2020

I can reproduce the problem only by sending from Win10 to Linux. That never goes through in one go. Sending from Linux to Win10 was no problem. I thought it might be a problem with the Win10 disk drive or filesystem. So I made a test from a new USB connected drive. Same problem. Again all the time both systems were connected by a ssh tunnel, so I assume the connection was stable.

I had to ^c on the Linux side. This resulted in (on the Win10 = sending side):

Sage50.zip 17% |¦¦¦ | (86/478 MB, 86.370 kB/s) [22m45s:1h17m28s]panic: wanted to write 32814 but wrote 0: write tcp 192.168.192.15:53566->142.93.177.120:9010: wsasend: Eine vorhandene Verbindung wurde vom Remotehost geschlossen.

goroutine 15 [running]:
github.com/schollz/croc/v8/src/croc.(*Client).sendData(0xc000047860, 0x0)
/home/zns/go/src/github.com/schollz/croc/src/croc/croc.go:1423 +0x7d3
created by github.com/schollz/croc/v8/src/croc.(*Client).updateState
/home/zns/go/src/github.com/schollz/croc/src/croc/croc.go:1261 +0x36d

The tail of the Linux side logfiles:

[debug] 08:41:45 message.go:43: writing recipientready message (encrypted)
[debug] 08:43:40 comm.go:132: consecutive read error: read tcp 192.168.192.171:55248->142.93.177.120:9012: i/o timeout
[debug] 08:44:01 comm.go:132: consecutive read error: read tcp 192.168.192.171:52370->142.93.177.120:9010: i/o timeout
[debug] 08:45:41 comm.go:132: consecutive read error: read tcp 192.168.192.171:37188->142.93.177.120:9013: i/o timeout
[debug] 09:04:02 comm.go:132: consecutive read error: read tcp 192.168.192.171:41218->142.93.177.120:9011: i/o timeout

@m2acgi
Copy link

m2acgi commented Sep 24, 2021

Same issue, not only when sending large files, but also when sending small files.

@schollz schollz closed this as completed Sep 24, 2021
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@bodemann @schollz @m2acgi