. 2019-09-03 11:19:01.860 --------------------------------------------------------------------------
. 2019-09-03 11:19:01.860 WinSCP Version 5.15.2 (Build 9590) (OS 6.3.9600 - Windows Server 2012 R2 Standard)
. 2019-09-03 11:19:01.860 Configuration: nul
. 2019-09-03 11:19:01.860 Log level: Debug 2
. 2019-09-03 11:19:01.860 Local account: <some vm name>
. 2019-09-03 11:19:01.860 Working directory: <some working directory>
. 2019-09-03 11:19:01.876 Process ID: 13936
. 2019-09-03 11:19:01.876 Command-line: "<some directory>\winscp.exe" /xmllog="C:\Windows\TEMP\wscp1688.0303FF1B.tmp" /xmlgroups /xmllogrequired /nointeractiveinput /dotnet=5.15.2  /ini=nul /log="some directory\49a4873a-e080-4b5e-983a-430dc608131e.txt" /loglevel=2  /console /consoleinstance=_5768_30570979_69
. 2019-09-03 11:19:01.876 Switch:    /xmllog=C:\Windows\TEMP\wscp1688.0303FF1B.tmp
. 2019-09-03 11:19:01.876 Switch:    /xmlgroups
. 2019-09-03 11:19:01.876 Switch:    /xmllogrequired
. 2019-09-03 11:19:01.876 Switch:    /nointeractiveinput
. 2019-09-03 11:19:01.876 Switch:    /dotnet=5.15.2
. 2019-09-03 11:19:01.876 Switch:    /ini=nul
. 2019-09-03 11:19:01.876 Switch:    /log=some directory\49a4873a-e080-4b5e-983a-430dc608131e.txt
. 2019-09-03 11:19:01.876 Switch:    /loglevel=2
. 2019-09-03 11:19:01.876 Switch:    /console
. 2019-09-03 11:19:01.876 Switch:    /consoleinstance=_5768_30570979_69
. 2019-09-03 11:19:01.876 Time zone: Current: GMT+3 (Russia TZ 2 Standard Time), No DST
. 2019-09-03 11:19:01.876 Login time: 3 Сентябрь 2019 г. 11:19:01
. 2019-09-03 11:19:01.876 --------------------------------------------------------------------------
. 2019-09-03 11:19:01.876 Script: Retrospectively logging previous script records:
> 2019-09-03 11:19:01.876 Script: option batch on
> 2019-09-03 11:19:01.876 Script: Parameter: batch
> 2019-09-03 11:19:01.876 Script: Parameter: on
< 2019-09-03 11:19:01.876 Script: batch           on        
< 2019-09-03 11:19:01.876 Script: reconnecttime   120       
> 2019-09-03 11:19:01.876 Script: option confirm off
> 2019-09-03 11:19:01.876 Script: Parameter: confirm
> 2019-09-03 11:19:01.876 Script: Parameter: off
< 2019-09-03 11:19:01.876 Script: confirm         off       
> 2019-09-03 11:19:01.876 Script: option reconnecttime 120
> 2019-09-03 11:19:01.876 Script: Parameter: reconnecttime
> 2019-09-03 11:19:01.876 Script: Parameter: 120
< 2019-09-03 11:19:01.876 Script: reconnecttime   120       
> 2019-09-03 11:19:01.876 Script: open ftp://some_login:***@some_domain:21 -passive=1 -timeout=15
> 2019-09-03 11:19:01.876 Script: Parameter: ftp://some_login:***@some_domain:21
> 2019-09-03 11:19:01.876 Script: Switch:    -passive=1
> 2019-09-03 11:19:01.876 Script: Switch:    -timeout=15
. 2019-09-03 11:19:01.876 --------------------------------------------------------------------------
. 2019-09-03 11:19:01.876 Session name: some_login@some_domain (Ad-Hoc site)
. 2019-09-03 11:19:01.876 Host name: some_domain (Port: 21)
. 2019-09-03 11:19:01.876 User name: some_login (Password: Yes, Key file: No, Passphrase: No)
. 2019-09-03 11:19:01.876 Transfer Protocol: FTP
. 2019-09-03 11:19:01.876 Ping type: Dummy, Ping interval: 30 sec; Timeout: 15 sec
. 2019-09-03 11:19:01.876 Disable Nagle: No
. 2019-09-03 11:19:01.876 Proxy: None
. 2019-09-03 11:19:01.876 Send buffer: 262144
. 2019-09-03 11:19:01.876 UTF: Auto
. 2019-09-03 11:19:01.876 FTPS: None [Client certificate: No]
. 2019-09-03 11:19:01.876 FTP: Passive: Yes [Force IP: Auto]; MLSD: Auto [List all: Auto]; HOST: Auto
. 2019-09-03 11:19:01.876 Local directory: default, Remote directory: home, Update: Yes, Cache: Yes
. 2019-09-03 11:19:01.876 Cache directory changes: Yes, Permanent: Yes
. 2019-09-03 11:19:01.876 Recycle bin: Delete to: No, Overwritten to: No, Bin path: 
. 2019-09-03 11:19:01.876 Timezone offset: 0h 0m
. 2019-09-03 11:19:01.876 --------------------------------------------------------------------------
. 2019-09-03 11:19:01.876 Connecting to some_domain ...
. 2019-09-03 11:19:01.954 Connected with some_domain. Waiting for welcome message...
< 2019-09-03 11:19:02.002 220 Welcome
> 2019-09-03 11:19:02.002 USER some_login
< 2019-09-03 11:19:02.063 331 OK
> 2019-09-03 11:19:02.063 PASS ******
< 2019-09-03 11:19:02.126 230 Password ok, continue
> 2019-09-03 11:19:02.126 SYST
< 2019-09-03 11:19:02.188 215 UNIX TYPE: L8
> 2019-09-03 11:19:02.188 FEAT
< 2019-09-03 11:19:02.235 211- Features:
< 2019-09-03 11:19:02.235   SIZE
< 2019-09-03 11:19:02.235   MDTM
< 2019-09-03 11:19:02.267   REST STREAM
< 2019-09-03 11:19:02.267   PASV
< 2019-09-03 11:19:02.267   AUTH TLS
< 2019-09-03 11:19:02.267   MLSD modify*;size*;type*;unique*;
< 2019-09-03 11:19:02.267 211 end
. 2019-09-03 11:19:02.267 Connected
. 2019-09-03 11:19:02.267 Got reply 1 to the command 1
. 2019-09-03 11:19:02.267 --------------------------------------------------------------------------
. 2019-09-03 11:19:02.267 Using FTP protocol.
. 2019-09-03 11:19:02.267 Doing startup conversation with host.
> 2019-09-03 11:19:02.267 PWD
< 2019-09-03 11:19:02.313 257 "/" is the current directory.
. 2019-09-03 11:19:02.313 Got reply 1 to the command 16
. 2019-09-03 11:19:02.329 Getting current directory name.
. 2019-09-03 11:19:02.329 Startup conversation with host finished.
< 2019-09-03 11:19:02.329 Script: Active session: [1] some_login@some_domain
. 2019-09-03 11:19:02.329 Session upkeep
> 2019-09-03 11:19:02.657 Script: pwd
< 2019-09-03 11:19:02.657 Script: /
. 2019-09-03 11:19:02.657 Session upkeep
> 2019-09-03 11:19:02.720 Script: ls -- "/inbox/"
> 2019-09-03 11:19:02.720 Script: Parameter: /inbox/
. 2019-09-03 11:19:02.720 Retrieving directory listing...
> 2019-09-03 11:19:02.720 CWD /inbox
< 2019-09-03 11:19:02.767 250 "/inbox/" selected
> 2019-09-03 11:19:02.767 PWD
< 2019-09-03 11:19:02.829 257 "/inbox/" is the current directory.
> 2019-09-03 11:19:02.829 TYPE A
< 2019-09-03 11:19:02.892 200 OK
> 2019-09-03 11:19:02.892 PASV
< 2019-09-03 11:19:02.954 227 Entering Passive Mode (185,146,2,142,164,32)
> 2019-09-03 11:19:02.954 LIST -a
. 2019-09-03 11:19:02.954 Connecting to 185.146.2.142:42016 ...
. 2019-09-03 11:19:03.017 Data connection opened
. 2019-09-03 11:19:03.079 Data connection closed
. 2019-09-03 11:19:03.079 -rwxrwxrwx   1 ftp        ftp        5728 Sep 3 10:21 first_file.xml
. 2019-09-03 11:19:03.079 -rwxrwxrwx   1 ftp        ftp        4835 Sep 3 10:22 second_file.xml
. 2019-09-03 11:19:03.079 -rwxrwxrwx   1 ftp        ftp        10601 Sep 3 11:14 third_file.xml
< 2019-09-03 11:19:03.079 150 Opening
< 2019-09-03 11:19:03.079 226 Complete.
. 2019-09-03 11:19:03.079 Directory listing successful
. 2019-09-03 11:19:03.079 Got reply 1 to the command 2
. 2019-09-03 11:19:03.079 Detecting timezone difference...
. 2019-09-03 11:19:03.079 Retrieving file information...
> 2019-09-03 11:19:03.079 PWD
< 2019-09-03 11:19:03.142 257 "/inbox/" is the current directory.
> 2019-09-03 11:19:03.142 CWD /inbox/first_file.xml
< 2019-09-03 11:19:03.188 550 No such file or directory
> 2019-09-03 11:19:03.188 TYPE I
< 2019-09-03 11:19:03.251 200 OK
> 2019-09-03 11:19:03.251 SIZE /inbox/first_file.xml
< 2019-09-03 11:19:03.313 213 5728
> 2019-09-03 11:19:03.313 MDTM /inbox/first_file.xml
< 2019-09-03 11:19:03.376 213 1567495272
. 2019-09-03 11:19:03.376 Could not retrieve file information
. 2019-09-03 11:19:03.376 Got reply 4 to the command 1024
. 2019-09-03 11:19:03.376 Failed to retrieve file /inbox/first_file.xml attributes to detect timezone difference
. 2019-09-03 11:19:03.376 ..;D;0;1899-12-30T03:00:00.000Z;0;"" [0];"" [0];---------;0
. 2019-09-03 11:19:03.376 first_file.xml;-;5728;2019-09-03T07:21:00.000Z;1;"ftp" [0];"ftp" [0];rwxrwxrwx;1
. 2019-09-03 11:19:03.376 second_file.xml;-;4835;2019-09-03T07:22:00.000Z;1;"ftp" [0];"ftp" [0];rwxrwxrwx;1
. 2019-09-03 11:19:03.376 third_file.xml;-;10601;2019-09-03T08:14:00.000Z;1;"ftp" [0];"ftp" [0];rwxrwxrwx;1
< 2019-09-03 11:19:03.376 Script: D---------   0                           0              ..
< 2019-09-03 11:19:03.376 Script: -rwxrwxrwx   0 ftp      ftp           5728 Sep  3 10:21 first_file.xml
< 2019-09-03 11:19:03.376 Script: -rwxrwxrwx   0 ftp      ftp           4835 Sep  3 10:22 second_file.xml
< 2019-09-03 11:19:03.376 Script: -rwxrwxrwx   0 ftp      ftp          10601 Sep  3 11:14 third_file.xml
. 2019-09-03 11:19:03.376 Session upkeep
> 2019-09-03 11:19:03.563 Script: get  -nopermissions -preservetime -transfer="binary" -- "/inbox/first_file.xml" ".\8bf8c8f1-c2bb-434f-82f1-ed4d49a7a462\"
> 2019-09-03 11:19:03.563 Script: Switch:    -nopermissions
> 2019-09-03 11:19:03.563 Script: Switch:    -preservetime
> 2019-09-03 11:19:03.563 Script: Switch:    -transfer=binary
> 2019-09-03 11:19:03.563 Script: Parameter: /inbox/first_file.xml
> 2019-09-03 11:19:03.563 Script: Parameter: .\8bf8c8f1-c2bb-434f-82f1-ed4d49a7a462\
. 2019-09-03 11:19:03.563 Listing file "/inbox/first_file.xml".
. 2019-09-03 11:19:03.563 Retrieving file information...
> 2019-09-03 11:19:03.563 PWD
< 2019-09-03 11:19:03.626 257 "/inbox/" is the current directory.
> 2019-09-03 11:19:03.626 CWD /inbox/first_file.xml
< 2019-09-03 11:19:03.673 550 No such file or directory
> 2019-09-03 11:19:03.673 TYPE I
< 2019-09-03 11:19:03.735 200 OK
> 2019-09-03 11:19:03.735 SIZE /inbox/first_file.xml
< 2019-09-03 11:19:03.798 213 5728
> 2019-09-03 11:19:03.798 MDTM /inbox/first_file.xml
< 2019-09-03 11:19:03.860 213 1567495272
. 2019-09-03 11:19:03.860 Could not retrieve file information
. 2019-09-03 11:19:03.860 Got reply 4 to the command 1024
< 2019-09-03 11:19:03.860 Script: Can't get attributes of file '/inbox/first_file.xml'.
< 2019-09-03 11:19:03.860 Could not retrieve file information
. 2019-09-03 11:19:03.860 Script: Failed
. 2019-09-03 11:19:03.860 Session upkeep
> 2019-09-03 11:19:04.001 Script: exit
. 2019-09-03 11:19:04.001 Session upkeep
. 2019-09-03 11:19:04.001 Script: Exit code: 1
. 2019-09-03 11:19:04.001 Script: Max roundtrip: 329
. 2019-09-03 11:19:04.001 Got reply 1004 to the command 1024
. 2019-09-03 11:19:04.001 Disconnected from server