croc icon indicating copy to clipboard operation
croc copied to clipboard
Published 3 weeks ago • verified publisher icon schollz

File stopped sending at 91% from for three times

Open taylorzhancher opened this issue 2 years ago • 6 comments

Describe the bug

The transmission stopped at the same file at the same percentage three times.

To Reproduce

Being unsure of the cause and being a file on my server it cannot be reproduced easily. I do however have the debug information. the entire log is too long for github tickets would allow me to send, so here is at least the part about the file that failed to send out.

[debug]	23:03:19 croc.go:1751: finished with 0
[debug]	23:03:19 croc.go:1751: finished with 1
[debug]	23:03:19 croc.go:1751: finished with 2
[debug]	23:03:19 croc.go:1754: closing file
[debug]	23:03:19 message.go:78: read close-sender message (encrypted)
                                                                                     [debug]	23:03:19 croc.go:1287: close-sender received...
[debug]	23:03:19 croc.go:1290: sending close-recipient
[debug]	23:03:19 message.go:58: writing close-recipient message (encrypted)
[debug]	23:03:20 tcp.go:143: checking connection of room 466 for &{connection:0xc000012030}
[debug]	23:03:20 tcp.go:151: room: {first:0xc000164020 second:<nil> opened:{wall:13910838960856432488 ext:581710647 loc:0xa316a0} full:false}
[debug]	23:03:20 croc.go:496: got ping
[debug]	23:03:20 message.go:78: read recipientready message (encrypted)
[debug]	23:03:20 croc.go:1264: current file chunks: []
[debug]	23:03:20 croc.go:1595: start sending data!
auth.log                                0% |                    | ( 0 B/3.5 MB) [0s:0s][debug]	23:03:20 croc.go:1630: beginning sending comms
[debug]	23:03:20 croc.go:1641: starting sending over comm 0
[debug]	23:03:20 croc.go:1641: starting sending over comm 1
[debug]	23:03:20 croc.go:1641: starting sending over comm 2
[debug]	23:03:20 croc.go:1641: starting sending over comm 3
                                                                                     auth.log                               27% |█████               | (992 kB/3.5 MB, 9.6                                                                                     auth.log                               51% |██████████          | (1.8/3.5 MB, 6.9 MB/s) [0s:0s][debug]	23:03:20 croc.go:1751: finished with 2
[debug]	23:03:20 croc.go:1751: finished with 3
                                                                                     auth.log                               91% |██████████████████  | (3.2/3.5 MB, 8.9 MB/s) [0s:0s][debug]	23:03:20 croc.go:1751: finished with 0
[debug]	23:03:20 croc.go:1751: finished with 1
[debug]	23:03:20 croc.go:1754: closing file
[debug]	23:03:21 tcp.go:143: checking connection of room 466 for &{connection:0xc000012030}
[debug]	23:03:21 tcp.go:151: room: {first:0xc000164020 second:<nil> opened:{wall:13910838960856432488 ext:581710647 loc:0xa316a0} full:false}
[debug]	23:03:21 croc.go:496: got ping
[debug]	23:03:22 tcp.go:143: checking connection of room 466 for &{connection:0xc000012030}
[debug]	23:03:22 tcp.go:151: room: {first:0xc000164020 second:<nil> opened:{wall:13910838960856432488 ext:581710647 loc:0xa316a0} full:false}
[debug]	23:03:22 croc.go:496: got ping
[debug]	23:03:23 tcp.go:143: checking connection of room 466 for &{connection:0xc000012030}
[debug]	23:03:23 tcp.go:151: room: {first:0xc000164020 second:<nil> opened:{wall:13910838960856432488 ext:581710647 loc:0xa316a0} full:false}
[debug]	23:03:23 croc.go:496: got ping
[debug]	23:03:24 tcp.go:143: checking connection of room 466 for &{connection:0xc000012030}
[debug]	23:03:24 tcp.go:151: room: {first:0xc000164020 second:<nil> opened:{wall:13910838960856432488 ext:581710647 loc:0xa316a0} full:false}
[debug]	23:03:24 croc.go:496: got ping
[debug]	23:03:25 tcp.go:143: checking connection of room 466 for &{connection:0xc000012030}
[debug]	23:03:25 tcp.go:151: room: {first:0xc000164020 second:<nil> opened:{wall:13910838960856432488 ext:581710647 loc:0xa316a0} full:false}
[debug]	23:03:25 croc.go:496: got ping
[debug]	23:03:26 tcp.go:143: checking connection of room 466 for &{connection:0xc000012030}
[debug]	23:03:26 tcp.go:151: room: {first:0xc000164020 second:<nil> opened:{wall:13910838960856432488 ext:581710647 loc:0xa316a0} full:false}
[debug]	23:03:26 croc.go:496: got ping
[debug]	23:03:27 tcp.go:143: checking connection of room 466 for &{connection:0xc000012030}

Expected behaviour

being able to successfully send the file

Version

croc version v9.6.2-3b81934

Additional context

sent from a debian server.

taylorzhancher avatar May 05 '23 03:05 taylorzhancher

Looks like this is not the only file that ended up failing midway.....I'm trying to send them over manually and ended up having the same problem over multiple occasions.

taylorzhancher avatar May 05 '23 03:05 taylorzhancher

Can you try the latest version of croc?

schollz avatar May 05 '23 04:05 schollz

@schollz sorry I didn't realize this wasn't the latest version. I installed it with curl https://getcroc.schollz.com | bash this morning and got croc version v9.6.2-3b81934. I just reinstalled and it's still the same version.

taylorzhancher avatar May 05 '23 04:05 taylorzhancher

Thanks for catching that, it should be up to date, can you try again with the latest version?

schollz avatar May 05 '23 15:05 schollz

Thanks for the update. I'm now running v9.6.4-1fce28e on both machines. Here's the new log. auth.log doesn't always pause now but can sometimes be transferred, and I found other files (mail.info) that also stops midways.

[debug]	23:20:00 croc.go:1761: finished with 2
[debug]	23:20:00 croc.go:1764: closing file
[debug]	23:20:01 message.go:78: read close-sender message (encrypted)
                                                                                [debug]	23:20:01 croc.go:1293: close-sender received...
[debug]	23:20:01 croc.go:1296: sending close-recipient
[debug]	23:20:01 message.go:58: writing close-recipient message (encrypted)
[debug]	23:20:01 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:01 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:01 croc.go:497: got ping
[debug]	23:20:01 message.go:78: read recipientready message (encrypted)
[debug]	23:20:01 croc.go:1270: current file chunks: []
[debug]	23:20:01 croc.go:1605: start sending data!
mail.warn                               0% |                    | ( 0 B/2.0 MB) [0s:0s][debug]	23:20:01 croc.go:1640: beginning sending comms
[debug]	23:20:01 croc.go:1651: starting sending over comm 0
[debug]	23:20:01 croc.go:1651: starting sending over comm 1
[debug]	23:20:01 croc.go:1651: starting sending over comm 2
[debug]	23:20:01 croc.go:1651: starting sending over comm 3
[debug]	23:20:01 croc.go:1761: finished with 3
[debug]	23:20:01 croc.go:1761: finished with 1
[debug]	23:20:01 croc.go:1761: finished with 2
[debug]	23:20:01 croc.go:1761: finished with 0
[debug]	23:20:01 croc.go:1764: closing file
[debug]	23:20:02 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:02 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:02 croc.go:497: got ping
[debug]	23:20:03 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:03 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:03 croc.go:497: got ping
[debug]	23:20:04 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:04 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:04 croc.go:497: got ping
[debug]	23:20:05 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:05 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:05 croc.go:497: got ping
[debug]	23:20:06 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:06 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:06 croc.go:497: got ping
[debug]	23:20:07 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:07 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:07 croc.go:497: got ping
[debug]	23:20:08 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:08 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:08 croc.go:497: got ping
[debug]	23:20:09 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:09 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:09 croc.go:497: got ping
[debug]	23:20:10 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:10 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:10 croc.go:497: got ping
[debug]	23:20:11 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}
[debug]	23:20:11 tcp.go:151: room: {first:0xc00027e890 second:<nil> opened:{wall:13910932758695019426 ext:603499348 loc:0xa2c0c0} full:false}
[debug]	23:20:11 croc.go:497: got ping
[debug]	23:20:12 tcp.go:143: checking connection of room 600 for &{connection:0xc000012070}

[debug]	23:21:37 croc.go:1651: starting sending over comm 2
[debug]	23:21:37 croc.go:1651: starting sending over comm 3
                                                                                auth.log                               15% |███                 | (768 kB/4.7 MB                                                                                auth.log                               33% |██████              | (1.6/4.7 MB, 7                                                                                auth.log                               74% |██████████████      | (3.5/4.7 MB, 12 MB/s) [0s:0s][debug]	23:21:37 croc.go:1761: finished with 1
[debug]	23:21:37 croc.go:1761: finished with 0
[debug]	23:21:37 croc.go:1761: finished with 3
[debug]	23:21:37 croc.go:1761: finished with 2
[debug]	23:21:37 croc.go:1764: closing file
[debug]	23:21:37 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:37 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:37 croc.go:497: got ping
[debug]	23:21:38 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:38 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:38 croc.go:497: got ping
[debug]	23:21:39 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:39 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:39 croc.go:497: got ping
[debug]	23:21:40 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:40 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:40 croc.go:497: got ping
[debug]	23:21:41 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:41 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:41 croc.go:497: got ping
[debug]	23:21:42 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:42 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:42 croc.go:497: got ping
[debug]	23:21:43 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:43 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:43 croc.go:497: got ping
[debug]	23:21:44 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:44 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:44 croc.go:497: got ping
[debug]	23:21:45 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:45 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:45 croc.go:497: got ping
[debug]	23:21:46 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:46 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:46 croc.go:497: got ping
[debug]	23:21:47 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:47 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:47 croc.go:497: got ping
[debug]	23:21:48 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:48 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:48 croc.go:497: got ping
[debug]	23:21:49 croc.go:472: discoveries: []
[debug]	23:21:49 croc.go:472: discoveries: []
[debug]	23:21:49 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:49 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:49 croc.go:497: got ping
[debug]	23:21:50 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:50 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:50 croc.go:497: got ping
[debug]	23:21:51 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:51 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:51 croc.go:497: got ping
[debug]	23:21:52 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:52 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:52 croc.go:497: got ping
[debug]	23:21:53 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:53 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:53 croc.go:497: got ping
[debug]	23:21:54 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:54 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:54 croc.go:497: got ping
[debug]	23:21:55 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:55 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:55 croc.go:497: got ping
[debug]	23:21:56 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:56 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:56 croc.go:497: got ping
[debug]	23:21:57 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:57 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:57 croc.go:497: got ping
[debug]	23:21:58 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:58 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:58 croc.go:497: got ping
[debug]	23:21:59 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:21:59 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:21:59 croc.go:497: got ping
[debug]	23:22:00 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:22:00 tcp.go:151: room: {first:0xc00027e4b0 second:<nil> opened:{wall:13910932930142421178 ext:588317244 loc:0xa2c0c0} full:false}
[debug]	23:22:00 croc.go:497: got ping
[debug]	23:22:01 tcp.go:143: checking connection of room 306 for &{connection:0xc000012068}
[debug]	23:22:01 tcp.go:151: room: {first:0xc00027e4b0 second:

taylorzhancher avatar May 06 '23 03:05 taylorzhancher

Stale issue message

github-actions[bot] avatar Feb 17 '24 12:02 github-actions[bot]