Error listing directory on directory with >400 files

Advertisement

Gnutte
Joined:
Posts:
2
Location:
Stockholm, Sweden

Error listing directory on directory with >400 files

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'.

Reply with quote

Advertisement

Gnutte
Joined:
Posts:
2
Location:
Stockholm, Sweden

Please be aware that Globalscape released a new version of their server as of yeasterday(!).

The new server version holds an updated SSH library and I've now tested this against a trail version of their server (EFT version 6.0). And there are no issues when listing a directory with >2000 files on either FileZilla or WinSCP.

So probably more of an incompability bug between the outdated SSH Library that existed in GlobalScapes server before. Strangly though thet it worked with PSFTP.

This probably also aids the old SSH window size issue.

Reply with quote

Advertisement

You can post new topics in this forum