Ticket #7837: ftp-log-working.txt

File ftp-log-working.txt, 12.2 KB (added by Ben Timby, 9 years ago)

Log file from Ubuntu client.

Line 
107:24:50 Status: Resolving address of beta.smartfile.com
207:24:50 Status: Connecting to 208.88.252.38:21...
307:24:50 Status: Connection established, waiting for welcome message...
407:24:50 Trace: CFtpControlSocket::OnReceive()
507:24:50 Response: 220 SmartFile FTP Server Ready.
607:24:50 Trace: CFtpControlSocket::SendNextCommand()
707:24:50 Command: AUTH TLS
807:24:50 Trace: CFtpControlSocket::OnReceive()
907:24:50 Response: 234 AUTH TLS successful.
1007:24:50 Status: Initializing TLS...
1107:24:50 Trace: CTlsSocket::Handshake()
1207:24:50 Trace: CTlsSocket::ContinueHandshake()
1307:24:50 Trace: CTlsSocket::OnSend()
1407:24:50 Trace: CTlsSocket::OnRead()
1507:24:50 Trace: CTlsSocket::ContinueHandshake()
1607:24:50 Trace: CTlsSocket::OnRead()
1707:24:50 Trace: CTlsSocket::ContinueHandshake()
1807:24:50 Trace: Handshake successful
1907:24:50 Trace: Cipher: AES-256-CBC, MAC: SHA1
2007:24:50 Status: Verifying certificate...
2107:24:50 Trace: CFtpControlSocket::SendNextCommand()
2207:24:50 Command: USER btimby
2307:24:50 Status: TLS/SSL connection established.
2407:24:50 Trace: CTlsSocket::OnRead()
2507:24:50 Trace: CFtpControlSocket::OnReceive()
2607:24:50 Response: 331 Username ok, send password.
2707:24:50 Trace: CFtpControlSocket::SendNextCommand()
2807:24:50 Command: PASS ******
2907:24:51 Trace: CTlsSocket::OnRead()
3007:24:51 Trace: CFtpControlSocket::OnReceive()
3107:24:51 Response: 230 Login successful.
3207:24:51 Trace: CFtpControlSocket::SendNextCommand()
3307:24:51 Command: OPTS UTF8 ON
3407:24:51 Trace: CTlsSocket::OnRead()
3507:24:51 Trace: CFtpControlSocket::OnReceive()
3607:24:51 Response: 501 Invalid argument.
3707:24:51 Trace: CFtpControlSocket::SendNextCommand()
3807:24:51 Command: PBSZ 0
3907:24:51 Trace: CTlsSocket::OnRead()
4007:24:51 Trace: CFtpControlSocket::OnReceive()
4107:24:51 Response: 200 PBSZ=0 successful.
4207:24:51 Trace: CFtpControlSocket::SendNextCommand()
4307:24:51 Command: PROT P
4407:24:51 Trace: CTlsSocket::OnRead()
4507:24:51 Trace: CFtpControlSocket::OnReceive()
4607:24:51 Response: 200 Protection set to Private
4707:24:51 Trace: CFtpControlSocket::SendNextCommand()
4807:24:51 Command: OPTS MLST type;perm;size;modify;unix.mode;unix.uid;unix.gid;
4907:24:51 Trace: CTlsSocket::OnRead()
5007:24:51 Trace: CFtpControlSocket::OnReceive()
5107:24:51 Response: 200 MLST OPTS type;perm;size;modify;unix.mode;unix.uid;unix.gid;
5207:24:51 Status: Connected
5307:24:51 Trace: CFtpControlSocket::ResetOperation(0)
5407:24:51 Trace: CControlSocket::ResetOperation(0)
5507:24:51 Trace: CFileZillaEnginePrivate::ResetOperation(0)
5607:24:51 Status: Retrieving directory listing...
5707:24:51 Trace: CFtpControlSocket::SendNextCommand()
5807:24:51 Trace: CFtpControlSocket::ChangeDirSend()
5907:24:51 Command: CWD /
6007:24:51 Trace: CTlsSocket::OnRead()
6107:24:51 Trace: CFtpControlSocket::OnReceive()
6207:24:51 Response: 250 "/" is the current directory.
6307:24:51 Trace: CFtpControlSocket::ResetOperation(0)
6407:24:51 Trace: CControlSocket::ResetOperation(0)
6507:24:51 Trace: CFtpControlSocket::ParseSubcommandResult(0)
6607:24:51 Trace: CFtpControlSocket::ListSubcommandResult()
6707:24:51 Trace: state = 1
6807:24:51 Trace: CFtpControlSocket::SendNextCommand()
6907:24:51 Trace: CFtpControlSocket::TransferSend()
7007:24:51 Trace: state = 1
7107:24:51 Command: TYPE I
7207:24:51 Trace: CTlsSocket::OnRead()
7307:24:51 Trace: CFtpControlSocket::OnReceive()
7407:24:51 Response: 200 Type set to: Binary.
7507:24:51 Trace: CFtpControlSocket::TransferParseResponse()
7607:24:51 Trace: code = 2
7707:24:51 Trace: state = 1
7807:24:51 Trace: CFtpControlSocket::SendNextCommand()
7907:24:51 Trace: CFtpControlSocket::TransferSend()
8007:24:51 Trace: state = 2
8107:24:51 Command: PASV
8207:24:51 Trace: CTlsSocket::OnRead()
8307:24:51 Trace: CFtpControlSocket::OnReceive()
8407:24:51 Response: 227 Entering passive mode (208,88,252,38,11,250).
8507:24:51 Trace: CFtpControlSocket::TransferParseResponse()
8607:24:51 Trace: code = 2
8707:24:51 Trace: state = 2
8807:24:51 Trace: CFtpControlSocket::SendNextCommand()
8907:24:51 Trace: CFtpControlSocket::TransferSend()
9007:24:51 Trace: state = 4
9107:24:51 Command: MLSD
9207:24:51 Trace: CTransferSocket::OnConnect
9307:24:51 Trace: CTlsSocket::Handshake()
9407:24:51 Trace: CTlsSocket::ContinueHandshake()
9507:24:51 Trace: CTlsSocket::OnSend()
9607:24:51 Trace: CTlsSocket::OnSend()
9707:24:51 Trace: CTlsSocket::OnRead()
9807:24:51 Trace: CFtpControlSocket::OnReceive()
9907:24:51 Response: 150 File status okay. About to open data connection.
10007:24:51 Trace: CFtpControlSocket::TransferParseResponse()
10107:24:51 Trace: code = 1
10207:24:51 Trace: state = 4
10307:24:51 Trace: CFtpControlSocket::SendNextCommand()
10407:24:51 Trace: CFtpControlSocket::TransferSend()
10507:24:51 Trace: state = 5
10607:24:51 Trace: CTlsSocket::OnRead()
10707:24:51 Trace: CTlsSocket::ContinueHandshake()
10807:24:51 Trace: Handshake successful
10907:24:51 Trace: Session resumed
11007:24:51 Trace: Cipher: AES-256-CBC, MAC: SHA1
11107:24:51 Trace: CTransferSocket::OnConnect
11207:24:51 Trace: CTlsSocket::OnRead()
11307:24:51 Trace: CTransferSocket::OnReceive(), m_transferMode=0
11407:24:51 Trace: CTransferSocket::TransferEnd(1)
11507:24:51 Trace: CTlsSocket::OnRead()
11607:24:51 Trace: CFtpControlSocket::OnReceive()
11707:24:51 Response: 226 Transfer complete.
11807:24:51 Trace: CFtpControlSocket::TransferParseResponse()
11907:24:51 Trace: code = 2
12007:24:51 Trace: state = 5
12107:24:51 Trace: CFtpControlSocket::SendNextCommand()
12207:24:51 Trace: CFtpControlSocket::TransferSend()
12307:24:51 Trace: state = 8
12407:24:51 Trace: CFtpControlSocket::TransferEnd()
12507:24:51 Trace: CFtpControlSocket::ResetOperation(0)
12607:24:51 Trace: CControlSocket::ResetOperation(0)
12707:24:51 Trace: CFtpControlSocket::ParseSubcommandResult(0)
12807:24:51 Trace: CFtpControlSocket::ListSubcommandResult()
12907:24:51 Trace: state = 3
13007:24:51 Trace: CFtpControlSocket::ResetOperation(0)
13107:24:51 Trace: CControlSocket::ResetOperation(0)
13207:24:51 Status: Directory listing successful
13307:24:51 Trace: CFileZillaEnginePrivate::ResetOperation(0)
13407:24:53 Status: Resolving address of beta.smartfile.com
13507:24:53 Status: Connecting to 208.88.252.38:21...
13607:24:53 Status: Connection established, waiting for welcome message...
13707:24:53 Trace: CFtpControlSocket::OnReceive()
13807:24:53 Response: 220 SmartFile FTP Server Ready.
13907:24:53 Trace: CFtpControlSocket::SendNextCommand()
14007:24:53 Command: AUTH TLS
14107:24:53 Trace: CFtpControlSocket::OnReceive()
14207:24:53 Response: 234 AUTH TLS successful.
14307:24:53 Status: Initializing TLS...
14407:24:53 Trace: CTlsSocket::Handshake()
14507:24:53 Trace: CTlsSocket::ContinueHandshake()
14607:24:53 Trace: CTlsSocket::OnSend()
14707:24:53 Trace: CTlsSocket::OnRead()
14807:24:53 Trace: CTlsSocket::ContinueHandshake()
14907:24:53 Trace: CTlsSocket::OnRead()
15007:24:53 Trace: CTlsSocket::ContinueHandshake()
15107:24:53 Trace: Handshake successful
15207:24:53 Trace: Cipher: AES-256-CBC, MAC: SHA1
15307:24:53 Status: Verifying certificate...
15407:24:53 Trace: CFtpControlSocket::SendNextCommand()
15507:24:53 Command: USER btimby
15607:24:53 Status: TLS/SSL connection established.
15707:24:53 Trace: CTlsSocket::OnRead()
15807:24:53 Trace: CFtpControlSocket::OnReceive()
15907:24:53 Response: 331 Username ok, send password.
16007:24:53 Trace: CFtpControlSocket::SendNextCommand()
16107:24:53 Command: PASS ******
16207:24:53 Trace: CTlsSocket::OnRead()
16307:24:53 Trace: CFtpControlSocket::OnReceive()
16407:24:53 Response: 230 Login successful.
16507:24:53 Trace: CFtpControlSocket::SendNextCommand()
16607:24:53 Command: OPTS UTF8 ON
16707:24:53 Trace: CTlsSocket::OnRead()
16807:24:53 Trace: CFtpControlSocket::OnReceive()
16907:24:53 Response: 501 Invalid argument.
17007:24:53 Trace: CFtpControlSocket::SendNextCommand()
17107:24:53 Command: PBSZ 0
17207:24:53 Trace: CTlsSocket::OnRead()
17307:24:53 Trace: CFtpControlSocket::OnReceive()
17407:24:53 Response: 200 PBSZ=0 successful.
17507:24:53 Trace: CFtpControlSocket::SendNextCommand()
17607:24:53 Command: PROT P
17707:24:53 Trace: CTlsSocket::OnRead()
17807:24:53 Trace: CFtpControlSocket::OnReceive()
17907:24:53 Response: 200 Protection set to Private
18007:24:53 Trace: CFtpControlSocket::SendNextCommand()
18107:24:53 Command: OPTS MLST type;perm;size;modify;unix.mode;unix.uid;unix.gid;
18207:24:53 Trace: CTlsSocket::OnRead()
18307:24:53 Trace: CFtpControlSocket::OnReceive()
18407:24:53 Response: 200 MLST OPTS type;perm;size;modify;unix.mode;unix.uid;unix.gid;
18507:24:53 Status: Connected
18607:24:53 Trace: CFtpControlSocket::ResetOperation(0)
18707:24:53 Trace: CControlSocket::ResetOperation(0)
18807:24:53 Trace: CFileZillaEnginePrivate::ResetOperation(0)
18907:24:53 Trace: CFtpControlSocket::FileTransfer()
19007:24:53 Status: Starting upload of /mnt/data/btimby/VirtualBox/NewHardDisk01.vdi
19107:24:53 Trace: CFtpControlSocket::SendNextCommand()
19207:24:53 Trace: CFtpControlSocket::ChangeDirSend()
19307:24:53 Command: CWD /
19407:24:53 Trace: CTlsSocket::OnRead()
19507:24:53 Trace: CFtpControlSocket::OnReceive()
19607:24:53 Response: 250 "/" is the current directory.
19707:24:53 Trace: CFtpControlSocket::ResetOperation(0)
19807:24:53 Trace: CControlSocket::ResetOperation(0)
19907:24:53 Trace: CFtpControlSocket::ParseSubcommandResult(0)
20007:24:53 Trace: FileTransferSubcommandResult()
20107:24:55 Trace: CFtpControlSocket::SendNextCommand()
20207:24:55 Trace: FileTransferSend()
20307:24:55 Trace: CFtpControlSocket::SendNextCommand()
20407:24:55 Trace: CFtpControlSocket::TransferSend()
20507:24:55 Trace: state = 1
20607:24:55 Command: TYPE I
20707:24:55 Trace: CTlsSocket::OnRead()
20807:24:55 Trace: CFtpControlSocket::OnReceive()
20907:24:55 Response: 200 Type set to: Binary.
21007:24:55 Trace: CFtpControlSocket::TransferParseResponse()
21107:24:55 Trace: code = 2
21207:24:55 Trace: state = 1
21307:24:55 Trace: CFtpControlSocket::SendNextCommand()
21407:24:55 Trace: CFtpControlSocket::TransferSend()
21507:24:55 Trace: state = 2
21607:24:55 Command: PASV
21707:24:55 Trace: CTlsSocket::OnRead()
21807:24:55 Trace: CFtpControlSocket::OnReceive()
21907:24:55 Response: 227 Entering passive mode (208,88,252,38,8,77).
22007:24:55 Trace: CFtpControlSocket::TransferParseResponse()
22107:24:55 Trace: code = 2
22207:24:55 Trace: state = 2
22307:24:55 Trace: CFtpControlSocket::SendNextCommand()
22407:24:55 Trace: CFtpControlSocket::TransferSend()
22507:24:55 Trace: state = 4
22607:24:55 Command: STOR NewHardDisk01.vdi
22707:24:55 Trace: CTransferSocket::OnConnect
22807:24:55 Trace: CTlsSocket::Handshake()
22907:24:55 Trace: CTlsSocket::ContinueHandshake()
23007:24:55 Trace: CTlsSocket::OnSend()
23107:24:55 Trace: CTlsSocket::OnSend()
23207:24:55 Trace: CTlsSocket::OnRead()
23307:24:55 Trace: CFtpControlSocket::OnReceive()
23407:24:55 Response: 150 File status okay. About to open data connection.
23507:24:55 Trace: CFtpControlSocket::TransferParseResponse()
23607:24:55 Trace: code = 1
23707:24:55 Trace: state = 4
23807:24:55 Trace: CFtpControlSocket::SendNextCommand()
23907:24:55 Trace: CFtpControlSocket::TransferSend()
24007:24:55 Trace: state = 5
24107:24:55 Trace: CTlsSocket::OnRead()
24207:24:55 Trace: CTlsSocket::ContinueHandshake()
24307:24:55 Trace: Handshake successful
24407:24:55 Trace: Session resumed
24507:24:55 Trace: Cipher: AES-256-CBC, MAC: SHA1
24607:24:55 Trace: CTransferSocket::OnConnect
24707:24:55 Trace: First EAGAIN in CTransferSocket::OnSend()
24807:24:55 Trace: CTlsSocket::OnSend()
24907:24:55 Trace: Made progress in CTransferSocket::OnSend()
25007:24:56 Trace: CTlsSocket::OnSend()
25107:24:56 Trace: CTlsSocket::OnSend()
25207:24:57 Trace: CTlsSocket::OnSend()
25307:24:58 Trace: CTlsSocket::OnSend()
25407:24:58 Trace: CTlsSocket::OnSend()
25507:24:59 Trace: CTlsSocket::OnSend()
25607:25:00 Trace: CTlsSocket::OnSend()
25707:25:00 Trace: CTlsSocket::OnSend()
25807:25:01 Trace: CTlsSocket::OnSend()
25907:25:02 Trace: CTlsSocket::OnSend()
26007:25:02 Trace: CTlsSocket::OnSend()
26107:25:03 Trace: CTlsSocket::OnSend()
26207:25:04 Trace: CFtpControlSocket::ResetOperation(10)
26307:25:04 Trace: CControlSocket::ResetOperation(10)
26407:25:04 Trace: CFtpControlSocket::ResetOperation(10)
26507:25:04 Trace: CControlSocket::ResetOperation(10)
26607:25:04 Error: File transfer aborted by user after transferring 1.8 MB in 9 seconds
26707:25:04 Trace: CFileZillaEnginePrivate::ResetOperation(10)
26807:25:05 Trace: CTlsSocket::OnRead()
26907:25:05 Trace: CFtpControlSocket::OnReceive()
27007:25:05 Response: 226 Transfer complete.
27107:25:05 Trace: Skipping reply after cancelled operation or keepalive command.
27207:25:06 Status: Disconnected from server
27307:25:06 Trace: CControlSocket::DoClose(64)
27407:25:06 Trace: CFtpControlSocket::ResetOperation(66)
27507:25:06 Trace: CControlSocket::ResetOperation(66)
27607:25:06 Trace: CFileZillaEnginePrivate::ResetOperation(66)
27707:25:06 Trace: CControlSocket::DoClose(64)
27807:25:06 Trace: CControlSocket::DoClose(64)
27907:25:06 Trace: CFileZillaEnginePrivate::ResetOperation(0)