Hi,
We are getting an error while trying to list a directory with over 400 (could be lower) files when connecting to a SFTP host (Running GlobalScape EFT 5.2.12)
WinSCP returns error:
* 2009-03-04 13:31:46.843 (ESshFatal) No valid incoming packet found
* 2009-03-04 13:31:46.843 Error listing directory '/Tvarbanan/SG/N3/G/db/AUTOGRAF'.
* 2009-03-04 13:31:46.843 Error changing directory to 'AUTOGRAF'.
I've tested the following clients to the same host/directory with the following results:
WinSCP 4.18: Failed
WinSCP 4.21: Failed
WS_FTP old version (very old): Success
PSFTP 0.60: Success
Filezilla 3.2.2.1: Failed
Any ideas? Filezilla source related?
I've found this which could be related:
https://trac.filezilla-project.org/ticket/4205
UPDATE:
Just to be clear. Running WinSCP 4.21 to same host/directory over regular FTP works fine.
/Gustav
Please see log file below:
. 2009-03-04 13:31:17.468 --------------------------------------------------------------------------
. 2009-03-04 13:31:17.468 WinSCP Version 4.2.1 (Build 428) (OS 5.1.2600 Service Pack 3)
. 2009-03-04 13:31:17.468 Login time: den 4 mars 2009 13:31:17
. 2009-03-04 13:31:17.468 --------------------------------------------------------------------------
. 2009-03-04 13:31:17.468 Session name: XXX
. 2009-03-04 13:31:17.468 Host name: XXX (Port: 22)
. 2009-03-04 13:31:17.468 User name: XXX (Password: Yes, Key file: No)
. 2009-03-04 13:31:17.468 Tunnel: No
. 2009-03-04 13:31:17.468 Transfer Protocol: SFTP (SCP)
. 2009-03-04 13:31:17.468 Ping type: -, Ping interval: 30 sec; Timeout: 15 sec
. 2009-03-04 13:31:17.468 Proxy: none
. 2009-03-04 13:31:17.468 SSH protocol version: 2; Compression: No
. 2009-03-04 13:31:17.468 Bypass authentication: No
. 2009-03-04 13:31:17.468 Try agent: Yes; Agent forwarding: No; TIS/CryptoCard: No; KI: Yes; GSSAPI: No
. 2009-03-04 13:31:17.468 Ciphers: blowfish,aes,3des,WARN,arcfour,des; Ssh2DES: No
. 2009-03-04 13:31:17.468 SSH Bugs: -,-,-,-,-,-,-,-,-
. 2009-03-04 13:31:17.468 SFTP Bugs: -,-
. 2009-03-04 13:31:17.468 Return code variable: Autodetect; Lookup user groups: Yes
. 2009-03-04 13:31:17.468 Shell: default, EOL: 0
. 2009-03-04 13:31:17.468 Clear aliases: Yes, Unset nat.vars: Yes, Resolve symlinks: Yes
. 2009-03-04 13:31:17.468 LS: ls -la, Ign LS warn: Yes, Scp1 Comp: No
. 2009-03-04 13:31:17.468 Local directory: default, Remote directory: home, Update: No, Cache: Yes
. 2009-03-04 13:31:17.468 Cache directory changes: Yes, Permanent: Yes
. 2009-03-04 13:31:17.468 DST mode: 1
. 2009-03-04 13:31:17.468 --------------------------------------------------------------------------
. 2009-03-04 13:31:17.562 Looking up host "XXX"
. 2009-03-04 13:31:17.578 Connecting to XXX port 22
. 2009-03-04 13:31:17.578 Selecting events 63 for socket 480
. 2009-03-04 13:31:17.578 Waiting for the server to continue with the initialisation
. 2009-03-04 13:31:17.578 Looking for incoming data
. 2009-03-04 13:31:17.578 Looking for network events
. 2009-03-04 13:31:17.578 Detected network event
. 2009-03-04 13:31:17.578 Enumerating network events for socket 480
. 2009-03-04 13:31:17.578 Enumerated 18 network events making 18 cumulative events for socket 480
. 2009-03-04 13:31:17.578 Handling network write event on socket 480 with error 0
. 2009-03-04 13:31:17.578 Handling network connect event on socket 480 with error 0
. 2009-03-04 13:31:17.578 Looking for network events
. 2009-03-04 13:31:17.578 Detected network event
. 2009-03-04 13:31:17.578 Enumerating network events for socket 480
. 2009-03-04 13:31:17.578 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:17.578 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:17.578 Server version: SSH-2.0-1.36_sshlib GlobalSCAPE
. 2009-03-04 13:31:17.578 We believe remote version ignores SSH-2 maximum packet size
. 2009-03-04 13:31:17.578 Using SSH protocol version 2
. 2009-03-04 13:31:17.578 We claim version: SSH-2.0-WinSCP_release_4.2.1
. 2009-03-04 13:31:17.578 Waiting for the server to continue with the initialisation
. 2009-03-04 13:31:17.578 Looking for incoming data
. 2009-03-04 13:31:17.578 Looking for network events
. 2009-03-04 13:31:17.578 Detected network event
. 2009-03-04 13:31:17.578 Enumerating network events for socket 480
. 2009-03-04 13:31:17.578 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:17.578 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:17.578 Using Diffie-Hellman with standard group "group1"
. 2009-03-04 13:31:17.578 Doing Diffie-Hellman key exchange with hash SHA-1
. 2009-03-04 13:31:17.609 Waiting for the server to continue with the initialisation
. 2009-03-04 13:31:17.609 Looking for incoming data
. 2009-03-04 13:31:17.609 Looking for network events
. 2009-03-04 13:31:17.796 Detected network event
. 2009-03-04 13:31:17.796 Enumerating network events for socket 480
. 2009-03-04 13:31:17.796 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:17.796 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:17.968 Selecting events 63 for socket 480
. 2009-03-04 13:31:17.968 Host key fingerprint is:
. 2009-03-04 13:31:17.968 ssh-dss 2048 e6:ed:09:c1:99:d4:5a:c0:ef:7c:99:36:3e:25:e6:6b
. 2009-03-04 13:31:17.968 Initialised Blowfish-128 CBC client->server encryption
. 2009-03-04 13:31:17.968 Initialised HMAC-SHA1 client->server MAC algorithm
. 2009-03-04 13:31:17.968 Initialised Blowfish-128 CBC server->client encryption
. 2009-03-04 13:31:17.968 Initialised HMAC-SHA1 server->client MAC algorithm
. 2009-03-04 13:31:17.968 Waiting for the server to continue with the initialisation
. 2009-03-04 13:31:17.968 Looking for incoming data
. 2009-03-04 13:31:17.968 Looking for network events
. 2009-03-04 13:31:18.109 Detected network event
. 2009-03-04 13:31:18.109 Enumerating network events for socket 480
. 2009-03-04 13:31:18.109 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:18.109 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:18.109 Pageant is running. Requesting keys.
. 2009-03-04 13:31:18.109 Pageant has 0 SSH-2 keys
! 2009-03-04 13:31:18.109 Using username "XXX".
. 2009-03-04 13:31:18.109 Waiting for the server to continue with the initialisation
. 2009-03-04 13:31:18.109 Looking for incoming data
. 2009-03-04 13:31:18.109 Looking for network events
. 2009-03-04 13:31:18.109 Detected network event
. 2009-03-04 13:31:18.109 Enumerating network events for socket 480
. 2009-03-04 13:31:18.109 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:18.109 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:18.125 Sent password
. 2009-03-04 13:31:18.125 Waiting for the server to continue with the initialisation
. 2009-03-04 13:31:18.125 Looking for incoming data
. 2009-03-04 13:31:18.125 Looking for network events
. 2009-03-04 13:31:18.187 Detected network event
. 2009-03-04 13:31:18.187 Enumerating network events for socket 480
. 2009-03-04 13:31:18.187 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:18.187 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:18.187 Access granted
. 2009-03-04 13:31:18.187 Waiting for the server to continue with the initialisation
. 2009-03-04 13:31:18.187 Looking for incoming data
. 2009-03-04 13:31:18.187 Looking for network events
. 2009-03-04 13:31:18.187 Detected network event
. 2009-03-04 13:31:18.187 Enumerating network events for socket 480
. 2009-03-04 13:31:18.187 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:18.187 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:18.187 Opened channel for session
. 2009-03-04 13:31:18.250 Waiting for the server to continue with the initialisation
. 2009-03-04 13:31:18.250 Looking for incoming data
. 2009-03-04 13:31:18.250 Looking for network events
. 2009-03-04 13:31:18.328 Detected network event
. 2009-03-04 13:31:18.328 Enumerating network events for socket 480
. 2009-03-04 13:31:18.328 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:18.328 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:18.328 Started a shell/command
. 2009-03-04 13:31:18.328 --------------------------------------------------------------------------
. 2009-03-04 13:31:18.328 Using SFTP protocol.
. 2009-03-04 13:31:18.328 Doing startup conversation with host.
> 2009-03-04 13:31:18.343 Type: SSH_FXP_INIT, Size: 5, Number: -1
> 2009-03-04 13:31:18.343 01,00,00,00,05,
. 2009-03-04 13:31:18.343 Sent 9 bytes
. 2009-03-04 13:31:18.343 There are 0 bytes remaining in the send buffer
. 2009-03-04 13:31:18.343 Looking for network events
. 2009-03-04 13:31:18.343 Timeout waiting for network events
. 2009-03-04 13:31:18.343 Waiting for another 4 bytes
. 2009-03-04 13:31:18.343 Looking for incoming data
. 2009-03-04 13:31:18.343 Looking for network events
. 2009-03-04 13:31:18.343 Detected network event
. 2009-03-04 13:31:18.343 Enumerating network events for socket 480
. 2009-03-04 13:31:18.343 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:18.343 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:18.343 Received 9 bytes (0)
. 2009-03-04 13:31:18.343 Read 4 bytes (5 pending)
. 2009-03-04 13:31:18.343 Read 5 bytes (0 pending)
< 2009-03-04 13:31:18.343 Type: SSH_FXP_VERSION, Size: 5, Number: -1
< 2009-03-04 13:31:18.343 02,00,00,00,03,
. 2009-03-04 13:31:18.343 SFTP version 3 negotiated.
. 2009-03-04 13:31:18.343 We believe the server has signed timestamps bug
. 2009-03-04 13:31:18.343 We will use UTF-8 strings for status messages only
. 2009-03-04 13:31:18.343 Getting current directory name.
. 2009-03-04 13:31:18.343 Getting real path for '.'
> 2009-03-04 13:31:18.343 Type: SSH_FXP_REALPATH, Size: 10, Number: 16
> 2009-03-04 13:31:18.343 10,00,00,00,10,00,00,00,01,2E,
. 2009-03-04 13:31:18.343 Sent 14 bytes
. 2009-03-04 13:31:18.343 There are 0 bytes remaining in the send buffer
. 2009-03-04 13:31:18.343 Looking for network events
. 2009-03-04 13:31:18.343 Timeout waiting for network events
. 2009-03-04 13:31:18.343 Waiting for another 4 bytes
. 2009-03-04 13:31:18.343 Looking for incoming data
. 2009-03-04 13:31:18.343 Looking for network events
. 2009-03-04 13:31:18.375 Detected network event
. 2009-03-04 13:31:18.375 Enumerating network events for socket 480
. 2009-03-04 13:31:18.375 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:18.375 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:18.375 Received 27 bytes (0)
. 2009-03-04 13:31:18.375 Read 4 bytes (23 pending)
. 2009-03-04 13:31:18.375 Read 23 bytes (0 pending)
< 2009-03-04 13:31:18.375 Type: SSH_FXP_NAME, Size: 23, Number: 16
< 2009-03-04 13:31:18.375 68,00,00,00,10,00,00,00,01,00,00,00,01,2F,00,00,00,01,2F,00,00,00,00,
. 2009-03-04 13:31:18.375 Real path is '/'
. 2009-03-04 13:31:18.375 Listing directory "/".
> 2009-03-04 13:31:18.390 Type: SSH_FXP_OPENDIR, Size: 10, Number: 267
> 2009-03-04 13:31:18.390 0B,00,00,01,0B,00,00,00,01,2F,
. 2009-03-04 13:31:18.390 Sent 14 bytes
. 2009-03-04 13:31:18.390 There are 0 bytes remaining in the send buffer
. 2009-03-04 13:31:18.390 Looking for network events
. 2009-03-04 13:31:18.390 Timeout waiting for network events
. 2009-03-04 13:31:18.390 Waiting for another 4 bytes
. 2009-03-04 13:31:18.390 Looking for incoming data
. 2009-03-04 13:31:18.390 Looking for network events
. 2009-03-04 13:31:18.390 Detected network event
. 2009-03-04 13:31:18.390 Enumerating network events for socket 480
. 2009-03-04 13:31:18.390 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:18.390 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:18.390 Received 14 bytes (0)
. 2009-03-04 13:31:18.390 Read 4 bytes (10 pending)
. 2009-03-04 13:31:18.390 Read 10 bytes (0 pending)
< 2009-03-04 13:31:18.390 Type: SSH_FXP_HANDLE, Size: 10, Number: 267
< 2009-03-04 13:31:18.390 66,00,00,01,0B,00,00,00,01,31,
> 2009-03-04 13:31:18.390 Type: SSH_FXP_READDIR, Size: 10, Number: 524
> 2009-03-04 13:31:18.390 0C,00,00,02,0C,00,00,00,01,31,
. 2009-03-04 13:31:18.390 Sent 14 bytes
. 2009-03-04 13:31:18.390 There are 0 bytes remaining in the send buffer
. 2009-03-04 13:31:18.390 Looking for network events
. 2009-03-04 13:31:18.390 Timeout waiting for network events
. 2009-03-04 13:31:18.406 Waiting for another 4 bytes
. 2009-03-04 13:31:18.406 Looking for incoming data
. 2009-03-04 13:31:18.406 Looking for network events
. 2009-03-04 13:31:18.406 Detected network event
. 2009-03-04 13:31:18.406 Enumerating network events for socket 480
. 2009-03-04 13:31:18.406 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:18.406 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:18.406 Received 680 bytes (0)
. 2009-03-04 13:31:18.406 Read 4 bytes (676 pending)
[DELETED]
. 2009-03-04 13:31:46.343 Looking for network events
. 2009-03-04 13:31:46.343 Timeout waiting for network events
. 2009-03-04 13:31:46.625 Cached directory change via "AUTOGRAF" to "/Tvarbanan/SG/N3/G/db/AUTOGRAF".
. 2009-03-04 13:31:46.625 Getting current directory name.
. 2009-03-04 13:31:46.625 Listing directory "/Tvarbanan/SG/N3/G/db/AUTOGRAF".
> 2009-03-04 13:31:46.625 Type: SSH_FXP_OPENDIR, Size: 43, Number: 6411
> 2009-03-04 13:31:46.625 0B,00,00,19,0B,00,00,00,22,2F,54,76,61,72,62,61,6E,61,6E,2F,53,47,2F,4E,33,
> 2009-03-04 13:31:46.625 2F,47,2F,64,62,2F,41,55,54,4F,47,52,41,46,2E,44,42,46,
. 2009-03-04 13:31:46.625 Sent 47 bytes
. 2009-03-04 13:31:46.625 There are 0 bytes remaining in the send buffer
. 2009-03-04 13:31:46.625 Looking for network events
. 2009-03-04 13:31:46.625 Timeout waiting for network events
. 2009-03-04 13:31:46.625 Read 4 bytes (21 pending)
. 2009-03-04 13:31:46.625 Read 21 bytes (0 pending)
< 2009-03-04 13:31:46.625 Type: SSH_FXP_STATUS, Size: 21, Number: 6148
< 2009-03-04 13:31:46.625 65,00,00,18,04,00,00,00,00,00,00,00,02,4F,6B,00,00,00,02,65,6E,
. 2009-03-04 13:31:46.625 Discarding reserved response
. 2009-03-04 13:31:46.625 Waiting for another 4 bytes
. 2009-03-04 13:31:46.625 Looking for incoming data
. 2009-03-04 13:31:46.625 Looking for network events
. 2009-03-04 13:31:46.765 Detected network event
. 2009-03-04 13:31:46.765 Enumerating network events for socket 480
. 2009-03-04 13:31:46.765 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:46.765 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:46.765 Received 14 bytes (0)
. 2009-03-04 13:31:46.765 Read 4 bytes (10 pending)
. 2009-03-04 13:31:46.765 Read 10 bytes (0 pending)
< 2009-03-04 13:31:46.765 Type: SSH_FXP_HANDLE, Size: 10, Number: 6411
< 2009-03-04 13:31:46.765 66,00,00,19,0B,00,00,00,01,31,
> 2009-03-04 13:31:46.765 Type: SSH_FXP_READDIR, Size: 10, Number: 6668
> 2009-03-04 13:31:46.765 0C,00,00,1A,0C,00,00,00,01,31,
. 2009-03-04 13:31:46.765 Sent 14 bytes
. 2009-03-04 13:31:46.765 There are 0 bytes remaining in the send buffer
. 2009-03-04 13:31:46.765 Looking for network events
. 2009-03-04 13:31:46.765 Timeout waiting for network events
. 2009-03-04 13:31:46.765 Waiting for another 4 bytes
. 2009-03-04 13:31:46.765 Looking for incoming data
. 2009-03-04 13:31:46.765 Looking for network events
. 2009-03-04 13:31:46.781 Detected network event
. 2009-03-04 13:31:46.781 Enumerating network events for socket 480
. 2009-03-04 13:31:46.781 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:46.781 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:46.781 Waiting for another 4 bytes
. 2009-03-04 13:31:46.781 Looking for incoming data
. 2009-03-04 13:31:46.781 Looking for network events
. 2009-03-04 13:31:46.781 Detected network event
. 2009-03-04 13:31:46.781 Enumerating network events for socket 480
. 2009-03-04 13:31:46.781 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:46.781 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:46.796 Waiting for another 4 bytes
. 2009-03-04 13:31:46.796 Looking for incoming data
. 2009-03-04 13:31:46.796 Looking for network events
. 2009-03-04 13:31:46.796 Detected network event
. 2009-03-04 13:31:46.796 Enumerating network events for socket 480
. 2009-03-04 13:31:46.796 Enumerated 1 network events making 1 cumulative events for socket 480
. 2009-03-04 13:31:46.796 Handling network read event on socket 480 with error 0
. 2009-03-04 13:31:46.812 Selecting events 0 for socket 480
. 2009-03-04 13:31:46.812 No valid incoming packet found
* 2009-03-04 13:31:46.843 (ESshFatal) No valid incoming packet found
* 2009-03-04 13:31:46.843 Error listing directory '/Tvarbanan/SG/N3/G/db/AUTOGRAF'.
* 2009-03-04 13:31:46.843 Error changing directory to 'AUTOGRAF'.