"file already exists" on non-existant files :: Support Forum

Firewave
Joined:: 2009-05-21
Posts:: 8

"file already exists" on non-existant files

2009-07-01 10:05

Since updating to 4.2.2 I am getting "file already exists" dialogs, although the file doesn't exist at all. It shows of size of 0 and a date in 1899.

It happens with a test system I am reinstalling very often (it's a VMware) with files I always copy to the /root folder after a fresh installation. Feels a bit like a caching issue to me.

I also had a problem, that a remote folder was treated like a symbolic link, which wasn't a link at all on that system, but on a different one I was accessing earlier.

Reply with quote

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

Re: "file already exists" on non-existant files

2009-07-03

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

Firewave
Joined:: 2009-05-21
Posts:: 8

log of the issue

2009-07-03 10:20

. 2009-07-03 11:16:58.562 --------------------------------------------------------------------------
. 2009-07-03 11:16:58.562 WinSCP Version 4.2.2 (Build 480) (OS 5.1.2600 Service Pack 3)
. 2009-07-03 11:16:58.562 Login time: Freitag, 3. Juli 2009 11:16:58
. 2009-07-03 11:16:58.562 --------------------------------------------------------------------------
. 2009-07-03 11:16:58.562 Session name: root@192.168.56.150
. 2009-07-03 11:16:58.562 Host name: 192.168.56.150 (Port: 22)
. 2009-07-03 11:16:58.562 User name: root (Password: Yes, Key file: No)
. 2009-07-03 11:16:58.562 Tunnel: No
. 2009-07-03 11:16:58.562 Transfer Protocol: SFTP (SCP)
. 2009-07-03 11:16:58.562 Ping type: -, Ping interval: 30 sec; Timeout: 15 sec
. 2009-07-03 11:16:58.562 Proxy: none
. 2009-07-03 11:16:58.562 SSH protocol version: 2; Compression: No
. 2009-07-03 11:16:58.562 Bypass authentication: No
. 2009-07-03 11:16:58.562 Try agent: Yes; Agent forwarding: No; TIS/CryptoCard: No; KI: Yes; GSSAPI: No
. 2009-07-03 11:16:58.562 Ciphers: aes,blowfish,3des,WARN,arcfour,des; Ssh2DES: No
. 2009-07-03 11:16:58.562 SSH Bugs: -,-,-,-,-,-,-,-,-
. 2009-07-03 11:16:58.562 SFTP Bugs: -,-
. 2009-07-03 11:16:58.562 Return code variable: Autodetect; Lookup user groups: Yes
. 2009-07-03 11:16:58.562 Shell: default, EOL: 0
. 2009-07-03 11:16:58.562 Clear aliases: Yes, Unset nat.vars: Yes, Resolve symlinks: Yes
. 2009-07-03 11:16:58.562 LS: ls -la, Ign LS warn: Yes, Scp1 Comp: No
. 2009-07-03 11:16:58.562 Local directory: default, Remote directory: home, Update: No, Cache: Yes
. 2009-07-03 11:16:58.562 Cache directory changes: Yes, Permanent: Yes
. 2009-07-03 11:16:58.562 DST mode: 1
. 2009-07-03 11:16:58.562 --------------------------------------------------------------------------
. 2009-07-03 11:16:58.593 Looking up host "192.168.56.150"
. 2009-07-03 11:16:58.593 Connecting to 192.168.56.150 port 22
. 2009-07-03 11:16:58.609 Server version: SSH-2.0-OpenSSH_4.2
. 2009-07-03 11:16:58.609 Using SSH protocol version 2
. 2009-07-03 11:16:58.609 We claim version: SSH-2.0-WinSCP_release_4.2.2
. 2009-07-03 11:16:58.609 Doing Diffie-Hellman group exchange
. 2009-07-03 11:16:58.609 Doing Diffie-Hellman key exchange with hash SHA-1
. 2009-07-03 11:16:58.843 Host key fingerprint is:
. 2009-07-03 11:16:58.843 ssh-rsa 1024 55:ab:52:40:27:65:49:5c:c6:dd:e8:6f:89:2c:82:2a
. 2009-07-03 11:16:58.843 Initialised AES-256 SDCTR client->server encryption
. 2009-07-03 11:16:58.843 Initialised HMAC-SHA1 client->server MAC algorithm
. 2009-07-03 11:16:58.843 Initialised AES-256 SDCTR server->client encryption
. 2009-07-03 11:16:58.843 Initialised HMAC-SHA1 server->client MAC algorithm
! 2009-07-03 11:16:58.843 Using username "root".
. 2009-07-03 11:16:58.859 Prompt (5, SSH server authentication, Using keyboard-interactive authentication., Password: )
. 2009-07-03 11:16:58.859 Using stored password.
. 2009-07-03 11:16:59.046 Prompt (5, SSH server authentication, , <no prompt>)
. 2009-07-03 11:16:59.593 Access granted
. 2009-07-03 11:16:59.593 Opened channel for session
. 2009-07-03 11:16:59.609 Started a shell/command
. 2009-07-03 11:16:59.609 --------------------------------------------------------------------------
. 2009-07-03 11:16:59.609 Using SFTP protocol.
. 2009-07-03 11:16:59.609 Doing startup conversation with host.
> 2009-07-03 11:16:59.609 Type: SSH_FXP_INIT, Size: 5, Number: -1
< 2009-07-03 11:16:59.843 Type: SSH_FXP_VERSION, Size: 5, Number: -1
. 2009-07-03 11:16:59.843 SFTP version 3 negotiated.
. 2009-07-03 11:16:59.843 We believe the server has signed timestamps bug
. 2009-07-03 11:16:59.843 We will use UTF-8 strings for status messages only
. 2009-07-03 11:16:59.843 Limiting packet size to OpenSSH sftp-server limit of 262148 bytes
. 2009-07-03 11:16:59.843 Getting current directory name.
. 2009-07-03 11:16:59.843 Getting real path for '.'
> 2009-07-03 11:16:59.843 Type: SSH_FXP_REALPATH, Size: 10, Number: 16
< 2009-07-03 11:16:59.843 Type: SSH_FXP_NAME, Size: 31, Number: 16
. 2009-07-03 11:16:59.843 Real path is '/root'
. 2009-07-03 11:16:59.843 Listing directory "/root".
> 2009-07-03 11:16:59.843 Type: SSH_FXP_OPENDIR, Size: 14, Number: 267
< 2009-07-03 11:16:59.859 Type: SSH_FXP_HANDLE, Size: 13, Number: 267
> 2009-07-03 11:16:59.859 Type: SSH_FXP_READDIR, Size: 13, Number: 524
< 2009-07-03 11:16:59.859 Type: SSH_FXP_NAME, Size: 3665, Number: 524
> 2009-07-03 11:16:59.859 Type: SSH_FXP_READDIR, Size: 13, Number: 780
< 2009-07-03 11:16:59.859 Type: SSH_FXP_STATUS, Size: 28, Number: 780
< 2009-07-03 11:16:59.859 Status/error code: 1
> 2009-07-03 11:16:59.859 Type: SSH_FXP_CLOSE, Size: 13, Number: 1028
. 2009-07-03 11:16:59.859 Startup conversation with host finished.
. 2009-07-03 11:17:05.203 Copying 1 files/directories to remote directory "/root/"
. 2009-07-03 11:17:05.203 PrTime: Yes; PrRO: Yes; Rght: rw-r--r--; PrR: No (No); FnCs: N; RIC: 01; Resume: S (102400); CalcS: Yes; Mask: *.*
. 2009-07-03 11:17:05.203 TM: M; ClAr: No; CPS: 0; ExclM(No):
. 2009-07-03 11:17:05.203 AscM: *.*html; *.htm; *.txt; *.php*; *.cgi; *.c; *.cpp; *.h; *.pas; *.bas; *.tex; *.pl; .htaccess; *.xtml; *.css; *.cfg; *.ini; *.sh; *.xml
. 2009-07-03 11:17:05.203 File: "D:\bin.gz"
. 2009-07-03 11:17:05.203 Copying "D:\bin.gz" to remote directory started.
. 2009-07-03 11:17:05.203 Binary transfer mode selected.
. 2009-07-03 11:17:05.203 Checking existence of file.
> 2009-07-03 11:17:05.203 Type: SSH_FXP_LSTAT, Size: 21, Number: 1287
< 2009-07-03 11:17:05.203 Type: SSH_FXP_STATUS, Size: 24, Number: 1028
. 2009-07-03 11:17:05.203 Discarding reserved response
< 2009-07-03 11:17:05.203 Type: SSH_FXP_STATUS, Size: 29, Number: 1287
< 2009-07-03 11:17:05.203 Status/error code: 2
. 2009-07-03 11:17:05.203 Checking existence of partially transfered file.
> 2009-07-03 11:17:05.203 Type: SSH_FXP_LSTAT, Size: 30, Number: 1543
< 2009-07-03 11:17:05.203 Type: SSH_FXP_STATUS, Size: 29, Number: 1543
< 2009-07-03 11:17:05.203 Status/error code: 2
. 2009-07-03 11:17:05.203 Asking user:
. 2009-07-03 11:17:05.203 Remote file 'bin.gz' already exists. Overwrite?
. 2009-07-03 11:17:05.203
. 2009-07-03 11:17:05.203 New: 34180107 bytes, 01.07.2009 13:20:04
. 2009-07-03 11:17:05.203 Existing: 0 bytes, 30.12.1899 00:00:00 ()
. 2009-07-03 11:17:06.062 Opening remote file.
> 2009-07-03 11:17:06.062 Type: SSH_FXP_OPEN, Size: 46, Number: 1795
< 2009-07-03 11:17:06.062 Type: SSH_FXP_HANDLE, Size: 13, Number: 1795
> 2009-07-03 11:17:06.062 Type: SSH_FXP_WRITE, Size: 4121, Number: 2310
. 2009-07-03 11:17:48.703 2105 skipped SSH_FXP_WRITE, SSH_FXP_READ, SSH_FXP_DATA and SSH_FXP_STATUS packets.
> 2009-07-03 11:17:48.703 Type: SSH_FXP_CLOSE, Size: 13, Number: 272132
< 2009-07-03 11:17:48.718 Type: SSH_FXP_STATUS, Size: 24, Number: 271622
< 2009-07-03 11:17:48.718 Type: SSH_FXP_STATUS, Size: 24, Number: 271878
< 2009-07-03 11:17:48.718 Type: SSH_FXP_STATUS, Size: 24, Number: 272132
< 2009-07-03 11:17:48.718 Status/error code: 0
> 2009-07-03 11:17:48.718 Type: SSH_FXP_RENAME, Size: 46, Number: 272402
< 2009-07-03 11:17:48.718 Type: SSH_FXP_STATUS, Size: 24, Number: 272402
< 2009-07-03 11:17:48.718 Status/error code: 0
> 2009-07-03 11:17:48.718 Type: SSH_FXP_SETSTAT, Size: 33, Number: 2057
< 2009-07-03 11:17:48.718 Type: SSH_FXP_STATUS, Size: 24, Number: 2057
< 2009-07-03 11:17:48.718 Status/error code: 0
. 2009-07-03 11:17:48.718 Listing directory "/root".
> 2009-07-03 11:17:48.718 Type: SSH_FXP_OPENDIR, Size: 14, Number: 272651
< 2009-07-03 11:17:48.718 Type: SSH_FXP_HANDLE, Size: 13, Number: 272651
> 2009-07-03 11:17:48.718 Type: SSH_FXP_READDIR, Size: 13, Number: 272908
< 2009-07-03 11:17:48.718 Type: SSH_FXP_NAME, Size: 3773, Number: 272908
> 2009-07-03 11:17:48.718 Type: SSH_FXP_READDIR, Size: 13, Number: 273164
< 2009-07-03 11:17:48.718 Type: SSH_FXP_STATUS, Size: 28, Number: 273164
< 2009-07-03 11:17:48.718 Status/error code: 1
> 2009-07-03 11:17:48.718 Type: SSH_FXP_CLOSE, Size: 13, Number: 273412
. 2009-07-03 11:17:50.265 Closing connection.
. 2009-07-03 11:17:50.265 Sending special code: 12
. 2009-07-03 11:17:50.265 Sent EOF message

Reply with quote