GET -DELETE fails on 2nd file every time. 550 File doesn't exist

Advertisement

S4M231
Guest

GET -DELETE fails on 2nd file every time. 550 File doesn't exist

Hi!,

I have a weird problem with a simple GET -DELETE * command. It works only for the first file, then i get a 550 File doesn't exist error on the next. If i manually delete the first file in the list and run the script again, the previous failed one will download and delete with no problems, but the next in line will fail again. I've tested on two machines with different versions of WinSCP, and the same problem occurs. I suspect the remote server has some issues, but I can't be sure.

If I don't use the -DELETE switch, the command works flawlessly and gets all the files.

Any help much appreciated! Thanks

. 2017-10-31 12:33:47.877 --------------------------------------------------------------------------
. 2017-10-31 12:33:47.877 WinSCP Version 5.1.3 (Build 2881) (OS 6.0.6002 Service Pack 2)
. 2017-10-31 12:33:47.878 Configuration: c:\program files\winscp\WinSCP.ini
. 2017-10-31 12:33:47.880 Local account: *masked*
. 2017-10-31 12:33:47.880 Working directory: *masked*
. 2017-10-31 12:33:47.880 Command-line: "c:\program files\winscp\WinSCP.exe" /console=513 /consoleinstance=_17832_469 "*masked*" "/command" "GET -DELETE *.xml c:\Inbox\" "/log=c:\winscp.log"
. 2017-10-31 12:33:47.880 Time zone: Current: GMT+1, Standard: GMT+1, DST: GMT+2, DST Start: 3/26/2017, DST End: 10/29/2017
. 2017-10-31 12:33:47.880 Login time: Tuesday, October 31, 2017 12:33:47 PM
. 2017-10-31 12:33:47.880 --------------------------------------------------------------------------
. 2017-10-31 12:33:47.880 Session name: *masked* (Stored session)
. 2017-10-31 12:33:47.880 Host name: *masked* (Port: 21)
. 2017-10-31 12:33:47.880 User name: *masked* (Password: Yes, Key file: No)
. 2017-10-31 12:33:47.880 Tunnel: No
. 2017-10-31 12:33:47.881 Transfer Protocol: FTP
. 2017-10-31 12:33:47.881 Ping type: C, Ping interval: 30 sec; Timeout: 15 sec
. 2017-10-31 12:33:47.881 Proxy: none
. 2017-10-31 12:33:47.881 FTP: FTPS: None; Passive: Yes [Force IP: A]
. 2017-10-31 12:33:47.881 Local directory: *masked*, Remote directory: *masked*, Update: No, Cache: No
. 2017-10-31 12:33:47.881 Cache directory changes: No, Permanent: Yes
. 2017-10-31 12:33:47.881 DST mode: 1
. 2017-10-31 12:33:47.881 --------------------------------------------------------------------------
. 2017-10-31 12:33:47.884 Connecting to *masked* ...
. 2017-10-31 12:33:47.900 Connected with *masked*. Waiting for welcome message...
< 2017-10-31 12:33:47.907 220 Blue Goat 8100-2 FTP Service
> 2017-10-31 12:33:47.907 USER *masked*
< 2017-10-31 12:33:47.984 331 User *masked* logged in, needs password
> 2017-10-31 12:33:47.984 PASS *masked*
< 2017-10-31 12:33:48.035 230 Password ok, FTP server ready
> 2017-10-31 12:33:48.036 SYST
< 2017-10-31 12:33:48.067 215 UNIX Type: L8
> 2017-10-31 12:33:48.067 FEAT
< 2017-10-31 12:33:48.096 211 No features
. 2017-10-31 12:33:48.097 Connected
. 2017-10-31 12:33:48.097 --------------------------------------------------------------------------
. 2017-10-31 12:33:48.097 Using FTP protocol.
. 2017-10-31 12:33:48.097 Doing startup conversation with host.
> 2017-10-31 12:33:48.097 PWD
< 2017-10-31 12:33:48.137 257 "/" PWD Successful.
. 2017-10-31 12:33:48.137 Changing directory to "*masked*".
> 2017-10-31 12:33:48.137 CWD *masked*
< 2017-10-31 12:33:48.171 250 CWD command successful.
. 2017-10-31 12:33:48.171 Getting current directory name.
> 2017-10-31 12:33:48.171 PWD
< 2017-10-31 12:33:48.212 257 "/receive" PWD Successful.
. 2017-10-31 12:33:48.212 Startup conversation with host finished.
< 2017-10-31 12:33:48.213 Script: Active session: [1] *masked*
> 2017-10-31 12:33:48.214 Script: GET -DELETE *.xml C:\Inbox\
. 2017-10-31 12:33:48.214 Retrieving directory listing...
> 2017-10-31 12:33:48.214 TYPE A
< 2017-10-31 12:33:48.244 200 Command okay.
> 2017-10-31 12:33:48.244 PASV
< 2017-10-31 12:33:48.255 227 Entering Passive Mode (10,11,73,235,222,82)
> 2017-10-31 12:33:48.255 LIST -a
< 2017-10-31 12:33:48.330 150 File status okay; about to open data connection.
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 08:37 invoice_300307507_2017-10-31-08-37-09{399d4ed6-3431-48ba-9b67-ae3dff5fab5e}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 08:37 invoice_300307510_2017-10-31-08-37-10{7fd2a437-0286-4807-b817-d54ba1c74293}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 08:37 invoice_300307509_2017-10-31-08-37-10{d280bd76-8fe7-4cf3-a7b9-a089637c53ba}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 08:46 invoice_56612_2017-10-31-08-46-52{413872df-dbda-49cd-ba5b-82a73480a5de}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 08:57 invoice_100032505_2017-10-31-08-57-35{113f40ea-32cd-4764-aa7c-4e91fa326ba5}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 08:57 invoice_100032506_2017-10-31-08-57-36{27ebe978-8d66-49b3-9e35-5a762414a602}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 09:31 invoice_006150_2017-10-31-09-31-34{9f188196-0b17-4b51-a21e-3e18c2716ad0}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 09:33 invoice_006157_2017-10-31-09-33-51{eab8303d-7169-43b4-ada0-4c437eaa191d}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 09:36 invoice_006160_2017-10-31-09-36-02{ed9b07fe-f947-420d-9873-0e28a084d8f1}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 09:38 invoice_006163_2017-10-31-09-38-43{13fa6d44-96b0-4921-b355-462766988ed4}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 09:40 invoice_006164_2017-10-31-09-40-22{37977088-ab7f-4e61-a424-a5b7985b46ed}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 10:09 invoice_787464_2017-10-31-10-09-20{79112cc1-a031-4175-8574-eafeaea55bda}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 10:28 invoice_416408_2017-10-31-10-28-47{9f8dfb6a-441e-4c94-8376-10257bfb47ff}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 10:52 invoice_1817_2017-10-31-10-52-34{c12c6796-29d3-4a9e-bd1e-a4ce88fc6c2c}.xml
. 2017-10-31 12:33:48.429 -rw-r--r-- 1 owner group 1 Oct 31 11:04 invoice_81338424_2017-10-31-11-04-48{3cf787ee-260c-4551-95a1-0e88b1eb0ebf}.xml
< 2017-10-31 12:33:48.523 226 Transfer complete, closing data connection.
. 2017-10-31 12:33:48.523 Directory listing successful
. 2017-10-31 12:33:48.523 File: "/receive/invoice_300307507_2017-10-31-08-37-09{399d4ed6-3431-48ba-9b67-ae3dff5fab5e}.xml"
. 2017-10-31 12:33:48.524 Copying "/receive/invoice_300307507_2017-10-31-08-37-09{399d4ed6-3431-48ba-9b67-ae3dff5fab5e}.xml" to local directory started.
. 2017-10-31 12:33:48.524 Binary transfer mode selected.
. 2017-10-31 12:33:48.530 Starting download of /receive/invoice_300307507_2017-10-31-08-37-09{399d4ed6-3431-48ba-9b67-ae3dff5fab5e}.xml
> 2017-10-31 12:33:48.595 TYPE I
< 2017-10-31 12:33:48.648 200 Command okay.
> 2017-10-31 12:33:48.648 PASV
< 2017-10-31 12:33:48.656 227 Entering Passive Mode (10,11,73,235,220,149)
> 2017-10-31 12:33:48.663 RETR invoice_300307507_2017-10-31-08-37-09{399d4ed6-3431-48ba-9b67-ae3dff5fab5e}.xml
< 2017-10-31 12:33:49.784 150 File status okay; about to open data connection.
< 2017-10-31 12:33:49.993 226 Transfer complete, closing data connection.
. 2017-10-31 12:33:50.005 Download successful
. 2017-10-31 12:33:50.005 Deleting file "/receive/invoice_300307507_2017-10-31-08-37-09{399d4ed6-3431-48ba-9b67-ae3dff5fab5e}.xml".
> 2017-10-31 12:33:50.006 DELE /receive/invoice_300307507_2017-10-31-08-37-09{399d4ed6-3431-48ba-9b67-ae3dff5fab5e}.xml
< 2017-10-31 12:33:50.611 250 File deleted successfully
. 2017-10-31 12:33:50.611 File: "/receive/invoice_300307510_2017-10-31-08-37-10{7fd2a437-0286-4807-b817-d54ba1c74293}.xml"
. 2017-10-31 12:33:50.612 Copying "/receive/invoice_300307510_2017-10-31-08-37-10{7fd2a437-0286-4807-b817-d54ba1c74293}.xml" to local directory started.
. 2017-10-31 12:33:50.612 Binary transfer mode selected.
. 2017-10-31 12:33:50.619 Starting download of /receive/invoice_300307510_2017-10-31-08-37-10{7fd2a437-0286-4807-b817-d54ba1c74293}.xml
> 2017-10-31 12:33:50.661 TYPE I
< 2017-10-31 12:33:50.691 200 Command okay.
> 2017-10-31 12:33:50.691 PASV
< 2017-10-31 12:33:50.697 227 Entering Passive Mode (10,11,73,235,209,32)
> 2017-10-31 12:33:50.705 RETR invoice_300307510_2017-10-31-08-37-10{7fd2a437-0286-4807-b817-d54ba1c74293}.xml
< 2017-10-31 12:33:50.814 550 File doesn't exist
. 2017-10-31 12:33:50.815 Copying files from remote side failed.
* 2017-10-31 12:33:50.815 (ExtException) Copying files from remote side failed.
* 2017-10-31 12:33:50.815 File doesn't exist
. 2017-10-31 12:33:50.815 Asking user:

Reply with quote

Advertisement

martin
Site Admin
martin avatar
Joined:
Posts:
28,285
Location:
Prague, Czechia

Re: GET -DELETE fails on 2nd file every time. 550 File doesn't exist

While you should definitely try to upgrade to the latest version of WinSCP, I actually do not see anything wrong on WinSCP side.

Reply with quote

ravenweb
Guest

I have the same problem running with version 5.11.2 (Build 7781)

I have the same error ... second file is always transfer with size kb 0 and then it stops..

Deleting the 0 byte file from my pc and then start again then the file is transferred but the next one fails..

its only when i use "get -Delete"

Reply with quote

martin
Site Admin
martin avatar
Joined:
Posts:
28,285
Location:
Prague, Czechia

Re: I have the same problem running with version 5.11.2 (Build 7781)

ravenweb wrote:

I have the same error ... second file is always transfer with size kb 0 and then it stops..

Deleting the 0 byte file from my pc and then start again then the file is transferred but the next one fails..

its only when i use "get -Delete"
Please attach a full session log file showing the problem (using the latest version of WinSCP).

To generate the session log file, use /log=path_to_log_file command-line argument. Submit the log with your post as an attachment. 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 can mark the attachment as private.

Reply with quote

Advertisement

martin
Site Admin
martin avatar
Joined:
Posts:
28,285
Location:
Prague, Czechia

Re: Here is the log file

Thanks for the log.
But I seems that on WinSCP side everything works as it should. Do you have any reason to believe that's a problem with WinSCP?

Reply with quote

martin
Site Admin
martin avatar
Joined:
Posts:
28,285
Location:
Prague, Czechia

Re: Regarding error

ravenweb wrote:

So you think that the problem could be the ftp server
Yes, it looks like that.

Reply with quote

Advertisement

You can post new topics in this forum