> However the multi-line 226 response looks strange to me: > 18.09.16.171 ! Data Session Connected (Get) > [..] > 18.09.16.203 >|150 Accepted data connection| > [..] > 18.09.16.218 >|226-Options: -a | > [..] > 18.09.16.218 >|226 246 matches total| > > Normal flow would look like this: > 18.09.16.171 ! Data Session Connected (Get) > [..] > 18.09.16.203 >|150 Accepted data connection| > [..] > 18.09.16.218 >|226 Transfer OK| > > Afterwards the server actually doesn't perform the bidirectional > SSL shutdown correctly but drops the line: > 18.09.16.265 033FABF0 Winsock recv( 748, 0x13CED4, 4096, 0) = -1 > [336] > > So you get error "500 Control connection closed - Connection aborted > (#10053)"
Just tested your server several times and it works fine with the test account you sent me. I wonder why your log contains these strange looking responses: > 18.09.16.203 >|150 Accepted data connection| > [..] > 18.09.16.218 >|226-Options: -a | > [..] > 18.09.16.218 >|226 246 matches total| In my tests I got this: 16:11:07:578 >|150-Accepted data connection| [..] 16:11:07:578 >|150 312.6 kbytes to download| [..] 16:11:08:156 >|226-File successfully transferred| [..] 16:11:08:156 >|226 0.554 seconds (measured here), 0.55 Mbytes per second| [..] 16:11:08:343 >|221-Goodbye. You uploaded 0 and downloaded 313 kbytes.| [..] 16:11:08:359 >|221 Logout.| (all multi-line responses) And the server does not drop the control connection but performs the bidirectional SSL shutdown correctly: 16:11:08:359 009D8250 BIO_ctrl_pending(sslbio) = 0 [420] 16:11:08:359 009D8250 SslInternalClose 1824 16:11:08:359 009D8250 TCustomSslWSocket.ShutDown 1 1824 16:11:08:359 009D8250 SslInternalShutdown 1824 16:11:08:359 ICB> SSL3 alert write warning close notify 16:11:08:359 009D8250 BIO_ctrl_pending(nbio) = 37 [421] 16:11:08:359 009D8250 SslShutdownCompleted *0* 1824 16:11:08:359 009D8250 TriggerEvents 1824 SslState: SSL_ST_OK // MayFD_Read=0 MayDoRecv=-1 MayFD_Write=-1 MaySslTryToSend=-1 bSslAllSent=-1 bAllSent=-1 16:11:08:359 009D8250 BIO_ctrl_pending(nbio) = 37 [422] 16:11:08:359 009D8250 TriggerEvent sslFdWrite 1824 16:11:08:359 009D8250 BIO_ctrl_pending(sslbio) = 0 [423] 16:11:08:359 009D8250 BIO_ctrl_get_write_guarantee(nbio) = 4096 [424] 16:11:08:359 009D8250 TCustomSslWSocket.Do_FD_WRITE 1824 16:11:08:359 009D8250 BIO_ctrl_pending(nbio) = 37 [425] 16:11:08:359 009D8250 BIO_read(nbio, 0x13BD6C, 37) = 37 [426] 16:11:08:359 009D8250 my_RealSend (0x720, 1293676, 37) = 37 [427] 16:11:08:359 009D8250 BIO_ctrl_pending(nbio) = 0 [428] 16:11:08:359 009D8250 BIO_ctrl_pending(nbio) = 0 [429] 16:11:08:359 009D8250 BIO_ctrl_pending(nbio) = 0 [430] 16:11:08:359 009D8250 TriggerSslShutDownComplete(0) 1824 16:11:08:359 009D8250 TCustomWSocket.Shutdown 1 1824 16:11:08:359 009D8250 SslShutdownCompleted *1* 1824 16:11:08:359 009D8250 TCustomSslWSocket.Do_FD_CLOSE error #0 1824 16:11:08:359 009D8250 BIO_ctrl_pending(sslbio) = 0 [431] 16:11:08:359 009D8250 Socket data pending: 0 Err: 0 1824 16:11:08:359 009D8250 FCloseInvoked=0 1824 16:11:08:375 ! HighLevelAsync 0 16:11:08:375 ! HighLevelAsync done 16:11:08:375 009D8250 ResetSslSession 1824 16:11:08:375 SslAsyncSelect 1824, 32 FD_CLOSE 16:11:08:375 SslAsyncSelect 1824, 2 FD_WRITE I've no more ideas, sorry. Maybe somebody else? -- Arno Garrels -- To unsubscribe or change your settings for TWSocket mailing list please goto http://lists.elists.org/cgi-bin/mailman/listinfo/twsocket Visit our website at http://www.overbyte.be
