SCP Download Problem :: Support Forum

Made Guest

SCP Download Problem

2010-08-12 11:01

Hi,
since a while it's not possible to download a file which is bigger than 10MB while using a scp connection. tried on different servers. sftp works great, but i need scp for doing some remote commands.

don't remeber the version when it started, but in older versions it worked whithout problems.

right now i'm using 4.2.8

Reply with quote

Made Guest

2010-08-12 11:03

forgot to mention, the error message looks like this

Copying file 'testfile_11mb.zip' fatally failed. Copying files from remote side failed.

[/quote]

Reply with quote

martin◆ Site Admin
Joined:: 2002-12-10
Posts:: 41,518
Location:: Prague, Czechia

Re: SCP Download Problem

2010-08-14

Please post a full log file showing the problem.

To generate log file, enable logging, log in to your server and do the operation and only the operation that causes the error. For posting extensive logs you may use pastebin or similar application. Note that passwords and passphrases not stored in the log. You may want to remove other data you consider sensitive though, such as host names, IP addresses, account names or file names (unless they are relevant to the problem). If you do not want to post the log publicly, you may email it to me. You will find my address (if you log in) in my forum profile. Please include link back to this topic in your email. Also note in this topic that you have emailed the log.

Reply with quote

Made Guest

2010-09-24 13:51

Sorry for the delay, here is the log:

. 2010-09-24 13:09:06.281 --------------------------------------------------------------------------
. 2010-09-24 13:09:06.281 WinSCP Version 4.2.9 (Build 938) (OS 5.1.2600 Service Pack 3)
. 2010-09-24 13:09:06.281 Login time: Freitag, 24. September 2010 13:09:06
. 2010-09-24 13:09:06.281 --------------------------------------------------------------------------
. 2010-09-24 13:09:06.281 Session name: Dedicated
. 2010-09-24 13:09:06.281 Host name: 123.123.123.123 (Port: 22)
. 2010-09-24 13:09:06.281 User name: root (Password: Yes, Key file: No)
. 2010-09-24 13:09:06.281 Tunnel: No
. 2010-09-24 13:09:06.281 Transfer Protocol: SCP
. 2010-09-24 13:09:06.281 Ping type: -, Ping interval: 30 sec; Timeout: 15 sec
. 2010-09-24 13:09:06.281 Proxy: none
. 2010-09-24 13:09:06.281 SSH protocol version: 2; Compression: No
. 2010-09-24 13:09:06.281 Bypass authentication: No
. 2010-09-24 13:09:06.281 Try agent: Yes; Agent forwarding: No; TIS/CryptoCard: No; KI: Yes; GSSAPI: No
. 2010-09-24 13:09:06.281 Ciphers: aes,blowfish,3des,WARN,arcfour,des; Ssh2DES: No
. 2010-09-24 13:09:06.281 SSH Bugs: -,-,-,-,-,-,-,-,-
. 2010-09-24 13:09:06.281 SFTP Bugs: -,-
. 2010-09-24 13:09:06.281 Return code variable: Autodetect; Lookup user groups: Yes
. 2010-09-24 13:09:06.281 Shell: default
. 2010-09-24 13:09:06.281 EOL: 0, UTF: 2
. 2010-09-24 13:09:06.281 Clear aliases: Yes, Unset nat.vars: Yes, Resolve symlinks: Yes
. 2010-09-24 13:09:06.281 LS: ls -la, Ign LS warn: Yes, Scp1 Comp: No
. 2010-09-24 13:09:06.281 Local directory: C:\path\to\local\file, Remote directory: /path/to/remote/file, Update: Yes, Cache: Yes
. 2010-09-24 13:09:06.281 Cache directory changes: Yes, Permanent: Yes
. 2010-09-24 13:09:06.281 DST mode: 1
. 2010-09-24 13:09:06.281 --------------------------------------------------------------------------
. 2010-09-24 13:09:06.390 Looking up host "123.123.123.123"
. 2010-09-24 13:09:06.390 Connecting to 123.123.123.123 port 22
. 2010-09-24 13:09:07.000 Server version: SSH-2.0-OpenSSH_3.8.1p1 Debian-8.sarge.4
. 2010-09-24 13:09:07.000 We believe remote version has SSH-2 ignore bug
. 2010-09-24 13:09:07.000 Using SSH protocol version 2
. 2010-09-24 13:09:07.000 We claim version: SSH-2.0-WinSCP_release_4.2.9
. 2010-09-24 13:09:07.046 Doing Diffie-Hellman group exchange
. 2010-09-24 13:09:07.203 Doing Diffie-Hellman key exchange with hash SHA-1
. 2010-09-24 13:09:07.437 Host key fingerprint is:
. 2010-09-24 13:09:07.437 ssh-rsa 1024 67:ec:b8:69:52:d7:15:b3:ad:4c:32:81:41:e2:bd:13
. 2010-09-24 13:09:07.437 Initialised AES-256 SDCTR client->server encryption
. 2010-09-24 13:09:07.437 Initialised HMAC-SHA1 client->server MAC algorithm
. 2010-09-24 13:09:07.437 Initialised AES-256 SDCTR server->client encryption
. 2010-09-24 13:09:07.437 Initialised HMAC-SHA1 server->client MAC algorithm
! 2010-09-24 13:09:07.562 Using username "root".
. 2010-09-24 13:09:07.671 Prompt (5, SSH server authentication, Using keyboard-interactive authentication., Password: )
. 2010-09-24 13:09:07.671 Using stored password.
. 2010-09-24 13:09:07.718 Prompt (5, SSH server authentication, , <no prompt>)
. 2010-09-24 13:09:07.718 Ignoring empty SSH server authentication request
. 2010-09-24 13:09:07.781 Access granted
. 2010-09-24 13:09:07.828 Opened channel for session
. 2010-09-24 13:09:07.968 Started a shell/command
. 2010-09-24 13:09:07.968 --------------------------------------------------------------------------
. 2010-09-24 13:09:07.968 Using SCP protocol.
. 2010-09-24 13:09:07.968 Doing startup conversation with host.
. 2010-09-24 13:09:07.968 Skipping host startup message (if any).
> 2010-09-24 13:09:07.968 echo "WinSCP: this is end-of-file:0"
! 2010-09-24 13:09:08.031 stdin: is not a tty
< 2010-09-24 13:09:08.078 WinSCP: this is end-of-file:0
. 2010-09-24 13:09:08.078 Detecting variable containing return code of last command.
. 2010-09-24 13:09:08.078 Trying "$status".
> 2010-09-24 13:09:08.078 echo "$status" ; echo "WinSCP: this is end-of-file:0"
< 2010-09-24 13:09:08.218 WinSCP: this is end-of-file:0
. 2010-09-24 13:09:08.218 The response is not numerical exit code
. 2010-09-24 13:09:08.218 Trying "$?".
> 2010-09-24 13:09:08.218 echo "$?" ; echo "WinSCP: this is end-of-file:0"
< 2010-09-24 13:09:08.343 0
< 2010-09-24 13:09:08.343 WinSCP: this is end-of-file:0
. 2010-09-24 13:09:08.343 Return code variable "$?" selected.
. 2010-09-24 13:09:08.343 Clearing all aliases.
> 2010-09-24 13:09:08.343 unalias "ls" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:08.484 -bash: line 4: unalias: ls: not found
< 2010-09-24 13:09:08.484 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:08.484 unalias "echo" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:08.625 -bash: line 5: unalias: echo: not found
< 2010-09-24 13:09:08.625 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:08.625 unalias "pwd" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:08.750 -bash: line 6: unalias: pwd: not found
< 2010-09-24 13:09:08.750 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:08.750 unalias "cd" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:08.890 -bash: line 7: unalias: cd: not found
< 2010-09-24 13:09:08.890 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:08.890 unalias "groups" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:09.031 -bash: line 8: unalias: groups: not found
< 2010-09-24 13:09:09.031 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:09.031 unalias "scp" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:09.156 -bash: line 9: unalias: scp: not found
< 2010-09-24 13:09:09.156 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:09.171 unalias "rm" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:09.296 -bash: line 10: unalias: rm: not found
< 2010-09-24 13:09:09.296 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:09.296 unalias "mv" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:09.437 -bash: line 11: unalias: mv: not found
< 2010-09-24 13:09:09.437 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:09.437 unalias "mkdir" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:09.578 -bash: line 12: unalias: mkdir: not found
< 2010-09-24 13:09:09.578 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:09.578 unalias "chmod" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:09.703 -bash: line 13: unalias: chmod: not found
< 2010-09-24 13:09:09.703 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:09.703 unalias "chgrp" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:09.843 -bash: line 14: unalias: chgrp: not found
< 2010-09-24 13:09:09.843 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:09.843 unalias "chown" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:09.984 -bash: line 15: unalias: chown: not found
< 2010-09-24 13:09:09.984 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:09.984 unalias "unset" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:10.109 -bash: line 16: unalias: unset: not found
< 2010-09-24 13:09:10.109 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:10.109 unalias "unalias" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:10.250 -bash: line 17: unalias: unalias: not found
< 2010-09-24 13:09:10.250 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:10.250 unalias "ln" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:10.390 -bash: line 18: unalias: ln: not found
< 2010-09-24 13:09:10.390 WinSCP: this is end-of-file:1
> 2010-09-24 13:09:10.390 unalias "cp" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:10.531 -bash: line 19: unalias: cp: not found
< 2010-09-24 13:09:10.531 WinSCP: this is end-of-file:1
. 2010-09-24 13:09:10.531 Clearing national user variables.
> 2010-09-24 13:09:10.531 unset "LANG" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:10.656 WinSCP: this is end-of-file:0
> 2010-09-24 13:09:10.656 unset "LANGUAGE" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:10.796 WinSCP: this is end-of-file:0
> 2010-09-24 13:09:10.796 unset "LC_CTYPE" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:10.937 WinSCP: this is end-of-file:0
> 2010-09-24 13:09:10.937 unset "LC_COLLATE" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:11.078 WinSCP: this is end-of-file:0
> 2010-09-24 13:09:11.078 unset "LC_MONETARY" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:11.203 WinSCP: this is end-of-file:0
> 2010-09-24 13:09:11.203 unset "LC_NUMERIC" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:11.343 WinSCP: this is end-of-file:0
> 2010-09-24 13:09:11.343 unset "LC_TIME" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:11.484 WinSCP: this is end-of-file:0
> 2010-09-24 13:09:11.484 unset "LC_MESSAGES" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:11.609 WinSCP: this is end-of-file:0
> 2010-09-24 13:09:11.609 unset "LC_ALL" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:11.750 WinSCP: this is end-of-file:0
> 2010-09-24 13:09:11.750 unset "HUMAN_BLOCKS" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:11.890 WinSCP: this is end-of-file:0
. 2010-09-24 13:09:11.890 Looking up groups and users.
> 2010-09-24 13:09:11.890 groups ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:12.031 root
< 2010-09-24 13:09:12.218 WinSCP: this is end-of-file:0
. 2010-09-24 13:09:12.218 Following groups found:
. 2010-09-24 13:09:12.218   "root" [0]
. 2010-09-24 13:09:12.218 Following membership found:
. 2010-09-24 13:09:12.218   "root" [0]
. 2010-09-24 13:09:12.218 Following users found:
. 2010-09-24 13:09:12.218   "root" [0]
. 2010-09-24 13:09:12.218 Changing directory to "/path/to/remote/file".
> 2010-09-24 13:09:12.218 cd "/path/to/remote/file" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:12.359 WinSCP: this is end-of-file:0
. 2010-09-24 13:09:12.359 Getting current directory name.
> 2010-09-24 13:09:12.359 pwd ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:12.484 /path/to/remote/file
< 2010-09-24 13:09:12.484 WinSCP: this is end-of-file:0
. 2010-09-24 13:09:12.484 Listing current directory.
> 2010-09-24 13:09:12.484 ls -la --full-time ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:12.625 total 10416
< 2010-09-24 13:09:12.625 drwxr-sr-x 2 web2 web2     4096 2010-09-24 12:53:02.000000000 +0200 .
< 2010-09-24 13:09:12.625 drwsrwsrwx 5 web2 web2     4096 2010-09-22 13:21:07.000000000 +0200 ..
< 2010-09-24 13:09:12.625 -rw-r--r-- 1 web2 web2 10639424 2010-09-24 12:55:43.000000000 +0200 app.zip
< 2010-09-24 13:09:12.812 WinSCP: this is end-of-file:0
. 2010-09-24 13:09:12.812 Directory listing with --full-time succeed, next time all errors during directory listing will be displayed immediatelly.
. 2010-09-24 13:09:12.828 Startup conversation with host finished.
. 2010-09-24 13:09:22.812 [Background 1] Looking up host "123.123.123.123"
. 2010-09-24 13:09:22.812 [Background 1] Connecting to 123.123.123.123 port 22
. 2010-09-24 13:09:22.906 [Background 1] Server version: SSH-2.0-OpenSSH_3.8.1p1 Debian-8.sarge.4
. 2010-09-24 13:09:22.906 [Background 1] We believe remote version has SSH-2 ignore bug
. 2010-09-24 13:09:22.906 [Background 1] Using SSH protocol version 2
. 2010-09-24 13:09:22.906 [Background 1] We claim version: SSH-2.0-WinSCP_release_4.2.9
. 2010-09-24 13:09:22.953 [Background 1] Doing Diffie-Hellman group exchange
. 2010-09-24 13:09:23.093 [Background 1] Doing Diffie-Hellman key exchange with hash SHA-1
. 2010-09-24 13:09:23.296 [Background 1] Host key fingerprint is:
. 2010-09-24 13:09:23.296 [Background 1] ssh-rsa 1024 67:ec:b8:69:52:d7:15:b3:ad:4c:32:81:41:e2:bd:13
. 2010-09-24 13:09:23.296 [Background 1] Initialised AES-256 SDCTR client->server encryption
. 2010-09-24 13:09:23.296 [Background 1] Initialised HMAC-SHA1 client->server MAC algorithm
. 2010-09-24 13:09:23.296 [Background 1] Initialised AES-256 SDCTR server->client encryption
. 2010-09-24 13:09:23.296 [Background 1] Initialised HMAC-SHA1 server->client MAC algorithm
! 2010-09-24 13:09:23.437 [Background 1] Using username "root".
. 2010-09-24 13:09:23.531 [Background 1] Prompt (5, SSH server authentication, Using keyboard-interactive authentication., Password: )
. 2010-09-24 13:09:23.531 [Background 1] Using stored password.
. 2010-09-24 13:09:23.578 [Background 1] Prompt (5, SSH server authentication, , <no prompt>)
. 2010-09-24 13:09:23.578 [Background 1] Ignoring empty SSH server authentication request
. 2010-09-24 13:09:23.625 [Background 1] Access granted
. 2010-09-24 13:09:23.687 [Background 1] Opened channel for session
. 2010-09-24 13:09:23.812 [Background 1] Started a shell/command
. 2010-09-24 13:09:23.812 [Background 1] --------------------------------------------------------------------------
. 2010-09-24 13:09:23.812 [Background 1] Using SCP protocol.
. 2010-09-24 13:09:23.812 [Background 1] Doing startup conversation with host.
. 2010-09-24 13:09:23.812 [Background 1] Skipping host startup message (if any).
> 2010-09-24 13:09:23.828 [Background 1] echo "WinSCP: this is end-of-file:0"
! 2010-09-24 13:09:23.875 [Background 1] stdin: is not a tty
< 2010-09-24 13:09:23.921 [Background 1] WinSCP: this is end-of-file:0
. 2010-09-24 13:09:23.921 [Background 1] Detecting variable containing return code of last command.
. 2010-09-24 13:09:23.921 [Background 1] Trying "$status".
> 2010-09-24 13:09:23.921 [Background 1] echo "$status" ; echo "WinSCP: this is end-of-file:0"
< 2010-09-24 13:09:24.046 [Background 1] WinSCP: this is end-of-file:0
. 2010-09-24 13:09:24.046 [Background 1] The response is not numerical exit code
. 2010-09-24 13:09:24.046 [Background 1] Trying "$?".
> 2010-09-24 13:09:24.046 [Background 1] echo "$?" ; echo "WinSCP: this is end-of-file:0"
< 2010-09-24 13:09:24.187 [Background 1] 0
< 2010-09-24 13:09:24.187 [Background 1] WinSCP: this is end-of-file:0
. 2010-09-24 13:09:24.187 [Background 1] Return code variable "$?" selected.
. 2010-09-24 13:09:24.187 [Background 1] Clearing all aliases.
> 2010-09-24 13:09:24.187 [Background 1] unalias "ls" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:24.328 [Background 1] -bash: line 4: unalias: ls: not found
< 2010-09-24 13:09:24.328 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:24.328 [Background 1] unalias "echo" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:24.453 [Background 1] -bash: line 5: unalias: echo: not found
< 2010-09-24 13:09:24.453 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:24.453 [Background 1] unalias "pwd" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:24.593 [Background 1] -bash: line 6: unalias: pwd: not found
< 2010-09-24 13:09:24.593 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:24.593 [Background 1] unalias "cd" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:24.734 [Background 1] -bash: line 7: unalias: cd: not found
< 2010-09-24 13:09:24.734 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:24.734 [Background 1] unalias "groups" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:24.875 [Background 1] -bash: line 8: unalias: groups: not found
< 2010-09-24 13:09:24.875 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:24.875 [Background 1] unalias "scp" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:25.000 [Background 1] -bash: line 9: unalias: scp: not found
< 2010-09-24 13:09:25.000 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:25.000 [Background 1] unalias "rm" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:25.140 [Background 1] -bash: line 10: unalias: rm: not found
< 2010-09-24 13:09:25.140 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:25.140 [Background 1] unalias "mv" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:25.281 [Background 1] -bash: line 11: unalias: mv: not found
< 2010-09-24 13:09:25.281 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:25.281 [Background 1] unalias "mkdir" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:25.406 [Background 1] -bash: line 12: unalias: mkdir: not found
< 2010-09-24 13:09:25.406 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:25.406 [Background 1] unalias "chmod" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:25.546 [Background 1] -bash: line 13: unalias: chmod: not found
< 2010-09-24 13:09:25.546 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:25.546 [Background 1] unalias "chgrp" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:25.687 [Background 1] -bash: line 14: unalias: chgrp: not found
< 2010-09-24 13:09:25.687 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:25.687 [Background 1] unalias "chown" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:25.812 [Background 1] -bash: line 15: unalias: chown: not found
< 2010-09-24 13:09:25.812 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:25.828 [Background 1] unalias "unset" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:25.953 [Background 1] -bash: line 16: unalias: unset: not found
< 2010-09-24 13:09:25.953 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:25.953 [Background 1] unalias "unalias" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:26.093 [Background 1] -bash: line 17: unalias: unalias: not found
< 2010-09-24 13:09:26.093 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:26.093 [Background 1] unalias "ln" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:26.234 [Background 1] -bash: line 18: unalias: ln: not found
< 2010-09-24 13:09:26.234 [Background 1] WinSCP: this is end-of-file:1
> 2010-09-24 13:09:26.234 [Background 1] unalias "cp" ; echo "WinSCP: this is end-of-file:$?"
! 2010-09-24 13:09:26.359 [Background 1] -bash: line 19: unalias: cp: not found
< 2010-09-24 13:09:26.359 [Background 1] WinSCP: this is end-of-file:1
. 2010-09-24 13:09:26.359 [Background 1] Clearing national user variables.
> 2010-09-24 13:09:26.359 [Background 1] unset "LANG" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:26.500 [Background 1] WinSCP: this is end-of-file:0
> 2010-09-24 13:09:26.500 [Background 1] unset "LANGUAGE" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:26.640 [Background 1] WinSCP: this is end-of-file:0
> 2010-09-24 13:09:26.640 [Background 1] unset "LC_CTYPE" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:26.765 [Background 1] WinSCP: this is end-of-file:0
> 2010-09-24 13:09:26.765 [Background 1] unset "LC_COLLATE" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:26.906 [Background 1] WinSCP: this is end-of-file:0
> 2010-09-24 13:09:26.906 [Background 1] unset "LC_MONETARY" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:27.046 [Background 1] WinSCP: this is end-of-file:0
> 2010-09-24 13:09:27.046 [Background 1] unset "LC_NUMERIC" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:27.187 [Background 1] WinSCP: this is end-of-file:0
> 2010-09-24 13:09:27.187 [Background 1] unset "LC_TIME" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:27.312 [Background 1] WinSCP: this is end-of-file:0
> 2010-09-24 13:09:27.312 [Background 1] unset "LC_MESSAGES" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:27.453 [Background 1] WinSCP: this is end-of-file:0
> 2010-09-24 13:09:27.453 [Background 1] unset "LC_ALL" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:27.593 [Background 1] WinSCP: this is end-of-file:0
> 2010-09-24 13:09:27.593 [Background 1] unset "HUMAN_BLOCKS" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:27.718 [Background 1] WinSCP: this is end-of-file:0
. 2010-09-24 13:09:27.718 [Background 1] Looking up groups and users.
> 2010-09-24 13:09:27.718 [Background 1] groups ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:27.859 [Background 1] root
< 2010-09-24 13:09:28.109 [Background 1] WinSCP: this is end-of-file:0
. 2010-09-24 13:09:28.109 [Background 1] Following groups found:
. 2010-09-24 13:09:28.109 [Background 1]   "root" [0]
. 2010-09-24 13:09:28.109 [Background 1] Following membership found:
. 2010-09-24 13:09:28.109 [Background 1]   "root" [0]
. 2010-09-24 13:09:28.109 [Background 1] Following users found:
. 2010-09-24 13:09:28.109 [Background 1]   "root" [0]
. 2010-09-24 13:09:28.109 [Background 1] Changing directory to "/path/to/remote/file".
> 2010-09-24 13:09:28.109 [Background 1] cd "/path/to/remote/file" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:28.250 [Background 1] WinSCP: this is end-of-file:0
. 2010-09-24 13:09:28.250 [Background 1] Getting current directory name.
> 2010-09-24 13:09:28.250 [Background 1] pwd ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:28.375 [Background 1] /path/to/remote/file
< 2010-09-24 13:09:28.375 [Background 1] WinSCP: this is end-of-file:0
. 2010-09-24 13:09:28.375 [Background 1] Listing current directory.
> 2010-09-24 13:09:28.375 [Background 1] ls -la --full-time ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:28.531 [Background 1] total 10416
< 2010-09-24 13:09:28.531 [Background 1] drwxr-sr-x 2 web2 web2     4096 2010-09-24 12:53:02.000000000 +0200 .
< 2010-09-24 13:09:28.531 [Background 1] drwsrwsrwx 5 web2 web2     4096 2010-09-22 13:21:07.000000000 +0200 ..
< 2010-09-24 13:09:28.531 [Background 1] -rw-r--r-- 1 web2 web2 10639424 2010-09-24 12:55:43.000000000 +0200 app.zip
< 2010-09-24 13:09:28.718 [Background 1] WinSCP: this is end-of-file:0
. 2010-09-24 13:09:28.718 [Background 1] Directory listing with --full-time succeed, next time all errors during directory listing will be displayed immediatelly.
. 2010-09-24 13:09:28.718 [Background 1] Startup conversation with host finished.
. 2010-09-24 13:09:28.718 [Background 1] Copying 1 files/directories to local directory "C:\path\to\local\file\"
. 2010-09-24 13:09:28.718 [Background 1]   PrTime: Yes; PrRO: Yes; Rght: rw-r--r--; PrR: No (No); FnCs: N; RIC: 01; Resume: S (102400); CalcS: No; Mask: *.*
. 2010-09-24 13:09:28.718 [Background 1]   TM: M; ClAr: No; CPS: 0; ExclM(No): 
. 2010-09-24 13:09:28.718 [Background 1]   AscM: *.*html; *.htm; *.txt; *.php*; *.cgi; *.c; *.cpp; *.h; *.pas; *.bas; *.tex; *.pl; .htaccess; *.xtml; *.css; *.cfg; *.ini; *.sh; *.xml
> 2010-09-24 13:09:28.718 [Background 1] echo "WinSCP: this is begin-of-file" ; scp -r -p -d -f "app.zip" ; echo "WinSCP: this is end-of-file:$?"
< 2010-09-24 13:09:28.843 [Background 1] WinSCP: this is begin-of-file
. 2010-09-24 13:09:28.843 [Background 1] Sending NULL.
< 2010-09-24 13:09:28.906 [Background 1] T1285325743 0 1285326320 0
. 2010-09-24 13:09:28.906 [Background 1] Sending NULL.
< 2010-09-24 13:09:28.953 [Background 1] C0644 10639424 app.zip
. 2010-09-24 13:09:29.000 [Background 1] Sending NULL.
. 2010-09-24 13:09:29.000 [Background 1] Binary transfer mode selected.
. 2010-09-24 13:09:29.156 [Background 1] Server unexpectedly closed network connection
. 2010-09-24 13:09:29.156 [Background 1] Asking user:
. 2010-09-24 13:09:29.156 [Background 1] Die Netzwerkverbindung wurde vom entfernten Rechner unerwartet geschlossen ("Kopieren der Datei 'app.zip' schlug fehl (aber richtig!).","Kopieren von Dateien vom entfernten Rechner schlug fehl.")
. 2010-09-24 13:09:37.093 Closing connection.
. 2010-09-24 13:09:37.093 Sending special code: 12
. 2010-09-24 13:09:37.093 Sent EOF message

Reply with quote

martin◆ Site Admin

2010-09-27

As you can see, the server closed the connection. Can you see in the server's log file, what is wrong.

Reply with quote

unpatented
Joined:: 2010-11-09
Posts:: 2

2010-11-09 05:33

I'm also running into this bug. It seems to be an ssh bug, but is triggered by the client program.

Here is the information requested from the previous poster that should be enough to track this down. Another poster in another thread mentioned that the last working version was 4.1.9. I can't confirm the exact version number yet, but in the past I have transferred large files from my server, using winscp with no problem. So this does seem to be something that was changed in recent versions of winscp.

I'm using Redhat Enterprise Linux 3, with the latest available openssh for this platform, which is 3.6.1p2 with their backported fixes.

Also was using WinSCP 4.2.7 on Windows XP, upgraded to version 4.3 beta with same results.

this is the info on this error from my server's logfile, /var/log/secure:
Nov 8 19:21:00 server sshd[3621]: fatal: buffer_append_space: alloc 10514432 not supported
Nov 8 19:26:52 server sshd[4080]: fatal: buffer_append_space: alloc 10522624 not supported
Nov 8 19:28:43 server sshd[4363]: fatal: buffer_append_space: alloc 10522624 not supported

Here is some info on the bug that may be helpful for making a workaround:
https://bugzilla.redhat.com/show_bug.cgi?id=184357

https://bugzilla.mindrot.org/show_bug.cgi?id=896

let me know if you need anything further, thanks.

Reply with quote