Article delegate-en <_A4482@delegate-en.ML_>
  upper oldest olders older1 this newer1 newers latest
search
[Top/Up] [oldest] - [Older+chunk] - [Newer+chunk] - [newest + Check]
[delegate-en/4482]
Newsgroups: mail-lists.delegate-en

[DeleGate-En] Re: FTP client to implicit FTPS server
03 Jun 2009 18:50:56 GMT Marvin <pn4iqbdyi.ml@ml.delegate.org>



Below the logging of a failed active connection:

06/03 20:46:08.50 [7541] 1+0: -- Fork(OnetimeServer): 7522 -> 7541
06/03 20:46:08.52 [7541] 1+0: (0) accepted [48]
-@[10.235.108.74]eupdwsappb308.acme.corp:4667 (0.015s)(1)
06/03 20:46:08.52 [7541] 1+0: PATH:
ftp://-:21!eusdvlprx003.acme.corp:21!eupdwsappb308.acme.corp:4667!anonymous@
eupdwsappb308.acme.corp;1244054768
06/03 20:46:08.53 [7541] 1+0: FTP server ftp://-:21/
06/03 20:46:08.53 [7541] 1+0: *** / => file://localhost/-stab-/ ***
06/03 20:46:08.53 [7541] 1+0: MOUNTED-TO-STAB: file://localhost/-stab-/
06/03 20:46:08.54 [7541] 1+0: -- putBuiltinHTML: empty
ftp-banner-postfix.dhtml
06/03 20:46:08.54 [7541] 1+0: bind_insock(23,10.235.253.21,0) = 0, errno=0
06/03 20:46:09.53 [7541] 1+0: ## connect[23] TIMEOUT(1000)
06/03 20:46:09.53 [7541] 1+0: ### IDENT CONNECT(eupdwsappb308.acme.corp:113)
TIMEOUT(1000ms) (110)
06/03 20:46:09.53 [7541] 1+0: #### no authorization required
06/03 20:46:09.54 [7541] 1+0/1: FTP LOGIN FROM eupdwsappb308.acme.corp TO
user@bla..
06/03 20:46:09.54 [7541] 1+0/1: rewritten to: CWD //user@bla..^M
06/03 20:46:09.67 [7541] 1+0/2: FTP LOGIN FROM eupdwsappb308.acme.corp TO
user@bla..
06/03 20:46:09.67 [7541] 1+0/2: PATH:
ftp://ftp3.bla.com:21!eusdvlprx003.acme.corp:21!eupdwsappb308.acme.corp:4667
!anonymous@eupdwsappb308.acme.corp;1244054768
06/03 20:46:09.69 [7541] 1+0/2: FTP server ftp://ftp3.bla.com:21/
06/03 20:46:09.69 [7541] 1+0/2: FTPHOPS: 1 [11/48 - -1/-1]
06/03 20:46:09.69 [7541] 1+0/2: ConnectToServer: DFLT=ftp://ftp3.bla.com:21
REAL=://:0
06/03 20:46:09.71 [7541] 1+0/2: ConnectToServer connected [25]
{123.12.122.51:21 <- 107.112.114.21:33496} [0.027s]
06/03 20:46:09.72 [7541] 1+0/2: {R} SOA got
[114.107.194.in-addr.arpa][eupdvwdc001.acme.corp][hostmaster.acme.corp] 17
900 600 00000 000X
06/03 20:46:09.72 [7541] 1+0/2: willSTLS_SV: ServerFlags=70
06/03 20:46:09.72 [7541] 1+0/2: inherited AsProxy: 10000
06/03 20:46:09.79 [7541] 1+0/2: willSTLS_SV: ServerFlags=70
06/03 20:46:10.18 [7541] 1+0/2: willSTLS_SV: ServerFlags=70
06/03 20:46:10.18 [7541] 1+0/2: [:][ftp:ftp3.bla.com]<-[starttls/]
06/03 20:46:10.26 [7541] 1+0/2: ## SSLway ## 0.079057 connected/accepted
06/03 20:46:10.26 [7541] 1+0/2: ## SSLway server's cert. =
**subject<</C=UK/O=BLA/OU=BLA FTP Server/CN=FTP3.bla.com>>
**issuer<</C=UK/O=BLA/OU=BLA FTP Server/CN=FTP3.bla.com>>
06/03 20:46:10.42 [7541] 1+0/2: LoginPWD: "/ftp/user"
06/03 20:46:10.73 [7541] 1+0/5/3: ## viaCFI [mkPASV]: fileno(ts)=25 ToSX=26
06/03 20:46:10.75 [7541] 1+0/5/3: ## viaCFI [mkPASV]: fileno(ts)=25 ToSX=26
06/03 20:46:10.76 [7541] 1+0/5/3: {R} SOA got
[10.in-addr.arpa][localhost][root] 1 604800 86400 2419200 604800
06/03 20:46:20.76 [7541] 1+0/5/3: ## connect[27] TIMEOUT(10000)
06/03 20:46:20.76 [7541] 1+0/5/3: *** CON_TIMEOUT: 10.00/10s ->
10.202.5.6:1498
06/03 20:46:20.76 [7541] 1+0/5/3: ftp_conndata: connection refused
107.112.114.21:33495->10.202.5.6/10.202.5.6:1498, errno=110
06/03 20:46:20.76 [7541] 1+0/5/3: ftp_conndata: retry without port# (33495)
06/03 20:46:30.77 [7541] 1+0/5/3: ## connect[27] TIMEOUT(10000)
06/03 20:46:30.77 [7541] 1+0/5/3: *** CON_TIMEOUT: 10.00/10s ->
10.202.5.6:1498
06/03 20:46:30.77 [7541] 1+0/5/3: ftp_conndata: connection refused
107.112.114.21:57720->10.202.5.6/10.202.5.6:1498, errno=110
06/03 20:46:30.77 [7541] 1+0/5/3: ## viaCFI [mkPORT]: fileno(ts)=25 ToSX=26
06/03 20:46:30.77 [7541] 1+0/5/3: FTP-control-remote: 123.12.122.51:21 [26]
06/03 20:46:30.77 [7541] 1+0/5/3: FTP-data-local[27]: 107.112.114.21:39365
06/03 20:46:30.79 [7541] 1+0/5/3: PORT [10,235,108,74,49,34] >> 200 Port
request OK.^M



> From: Yutaka Sato <feedback@delegate.org>
> Organization: The DeleGate Project
> Reply-To: <feedback@delegate.org>
> Date: Thu,  4 Jun 2009 03:32:02 +0900 (JST)
> To: <feedback@delegate.org>
> Cc: Marvin Tapessur <pn4iqbdyi.ml@ml.delegate.org>
> Subject: Re: [DeleGate-En] FTP client to implicit FTPS server
> 
> Hi,
> 
> In message <_A4478@delegate-en.ML_> on 06/04/09(01:06:15)
> you Marvin Tapessur <pn4iqbdyi.ml@ml.delegate.org> wrote:
>  |The STLS="-fsv,im=0.5" breaks 'normal' ftp connections using PORT. PASV
>  |connections work just fine. Any thought?
> 
> It should be "im0.5", not "im=0.5".
> And I can't reproduce the problem with the following test.
> 
>  delegated -P9999 SERVER=ftp STLS=-fsv,im=0.5 -fv -vd CACHE=no
> FTPCONF=nopasv:sv
>  ----
>  06/04 03:26:44.67 [9801] 1+0: (0) accepted [35] -@[127.0.0.1]localhost:54675
> (0.012s)(2)
> ...
>  06/04 03:26:53.47 [9801] 1+0/1: CLIENT-SAYS: USER ftp@microsoft..^M
>  06/04 03:26:53.47 [9801] 1+0/1: PERMITTED: ftp://ftp.microsoft.com
>  06/04 03:26:53.47 [9801] 1+0/1: FTP LOGIN FROM localhost TO
> ftp@microsoft..
>  06/04 03:26:53.47 [9801] 1+0/1: rewritten to: CWD //ftp@microsoft..^M
>  06/04 03:26:53.48 [9801] 1+0/1: [4] MOUNT ASIS: //
>  06/04 03:26:53.48 [9801] 1+0/1: [2] MOUNT ASIS: /-
>  06/04 03:26:57.29 [9801] 1+0/2: CLIENT-SAYS: PASS ysato@delegate.org^M
>  06/04 03:26:57.30 [9801] 1+0/2: gethostbyname(ftp.microsoft.com).
>  06/04 03:26:57.30 [9801] 1+0/2: *** gethostbyname(ftp.microsoft.com):
> ftp.microsoft.com / 0.00 secs. has_alias:0
>  06/04 03:26:57.30 [9801] 1+0/2: HOSTS[5]=ftp.microsoft.com/207.46.236.102
>  06/04 03:26:57.30 [9801] 1+0/2: CWD
> //[ftp:ysato@delegate.org]@ftp.microsoft.com:21
>  06/04 03:26:57.31 [9801] 1+0/2: PERMITTED: ftp://ftp.microsoft.com
>  06/04 03:26:57.31 [9801] 1+0/2: FTP LOGIN FROM localhost TO
> ftp@microsoft..
>  06/04 03:26:57.31 [9801] 1+0/2: PATH:
> ftp://ftp.microsoft.com:21!localhost:9999!localhost:54675!anonymous@localhost;
> 1244053604
>  06/04 03:26:57.33 [9801] 1+0/2: FTP server ftp://ftp.microsoft.com:21/
>  06/04 03:26:57.33 [9801] 1+0/2: FTPHOPS: 1 [10/35 - -1/-1]
>  06/04 03:26:57.33 [9801] 1+0/2: PERMITTED: ftp://ftp.microsoft.com
>  06/04 03:26:57.34 [9801] 1+0/2:
> dirfopen(/Users/yutaka/delegate/act/servers/cc/ftp-anonymous-ftp.microsoft.com
> -21-0,r+): 0 [-1]
>  06/04 03:26:57.34 [9801] 1+0/2: ConnectToServer:
> DFLT=ftp://ftp.microsoft.com:21 REAL=://:0
>  06/04 03:26:57.34 [9801] 1+0/2: ConnectToServer connect
> ftp://ftp.microsoft.com:21
>  06/04 03:26:57.69 [9801] 1+0/2: connect[24] ready=1, err=0
>  06/04 03:26:57.70 [9801] 1+0/2: ConnectToServer connected [24]
> {207.46.236.102:21 <- 192.168.1.xx:54679} [0.352s]
>  06/04 03:26:57.70 [9801] 1+0/2: KeepAlive[24] = 8
>  06/04 03:26:57.70 [9801] 1+0/2: willSTLS_SV: ServerFlags=70
>  06/04 03:26:57.70 [9801] 1+0/2: inherited AsProxy: 10000
>  06/04 03:26:57.71 [9801] 1+0/2: FTP-SERVER-SAYS: 220 Microsoft FTP Service^M
>  06/04 03:26:57.71 [9801] 1+0/2: willSTLS_SV: ServerFlags=70
>  06/04 03:26:57.99 [9801] 1+0/2: proxyLogin(ftp,ysato@delegate.org,,)
>  06/04 03:26:57.99 [9801] 1+0/2: I-SAY: USER ftp^M
>  06/04 03:26:58.25 [9801] 1+0/2: FTP-SERVER-SAYS: 331 Anonymous access
> allowed, send identity (e-mail name) as password.^M
>  06/04 03:26:58.25 [9801] 1+0/2: I-SAY: PASS ysato@delegate.org^M
>  06/04 03:26:58.38 [9801] 1+0/2: FTP-SERVER-SAYS: 230-Welcome to
> FTP.MICROSOFT.COM. Also visit http://www.microsoft.com/downloads.^M
>  06/04 03:26:58.53 [9801] 1+0/2: FTP-SERVER-SAYS: 257 "/" is current
> directory.^M
>  06/04 03:26:58.54 [9801] 1+0/2: LoginPWD: "/"
>  06/04 03:26:58.54 [9801] 1+0/2: service_ftp: start PollIns=[24,14]
>  06/04 03:26:58.57 [9801] 1+0/3: #### SYST^M
>  06/04 03:26:58.85 [9801] 1+0/3/1: I-SAY: SYST^M
>  06/04 03:26:59.02 [9801] 1+0/3/1: FTP-SERVER-SAYS: 215 Windows_NT^M
>  06/04 03:26:59.02 [9801] 1+0/3/1: service_ftp: start PollIns=[24,14]
>  06/04 03:26:59.02 [9801] 1+0/4/1: #### FEAT^M
>  06/04 03:26:59.02 [9801] 1+0/4/2: I-SAY: FEAT^M
>  06/04 03:26:59.24 [9801] 1+0/4/2: FTP-SERVER-SAYS: 211-Extended features
> supported:^M
>  06/04 03:26:59.24 [9801] 1+0/4/2: service_ftp: start PollIns=[24,14]
>  06/04 03:26:59.24 [9801] 1+0/5/2: #### PWD^M
>  06/04 03:26:59.24 [9801] 1+0/5/3: I-SAY: PWD^M
>  06/04 03:26:59.50 [9801] 1+0/5/3: FTP-SERVER-SAYS: 257 "/" is current
> directory.^M
>  06/04 03:26:59.51 [9801] 1+0/5/3: service_ftp: start PollIns=[24,14]
>  06/04 03:26:59.53 [9801] 1+0/6/3: #### EPSV^M
>  06/04 03:26:59.53 [9801] 1+0/6/4: FTP-control-remote: 127.0.0.1:9999 [35]
>  06/04 03:26:59.53 [9801] 1+0/6/4: ##NOT ViaSocks-B## 127.0.0.1:0
>  06/04 03:26:59.57 [9801] 1+0/6/4: listen(25,1) OK.
>  06/04 03:26:59.57 [9801] 1+0/6/4: FTP-data-local[25]: 127.0.0.1:54680
>  06/04 03:26:59.57 [9801] 1+0/6/4: --FTPdata reuse port# 54680
> [127,0,0,1,213,152]
>  06/04 03:26:59.57 [9801] 1+0/6/4: ## [EPSV] restored (|||54680|)
>  06/04 03:26:59.58 [9801] 1+0/6/4: FTP-control-remote: 207.46.236.102:21 [24]
>  06/04 03:26:59.58 [9801] 1+0/6/4: listen(26,1) OK.
>  06/04 03:26:59.58 [9801] 1+0/6/4: FTP-data-local[26]: 192.168.1.xx:54681
>  06/04 03:26:59.59 [9801] 1+0/6/4: I-SAY: PORT 192,168,1.xx,213,153^M
>  06/04 03:26:59.88 [9801] 1+0/6/4: FTP-SERVER-SAYS: 200 PORT command
> successful.^M
>  06/04 03:26:59.88 [9801] 1+0/6/4: PASV [C][|||54680|] >> 229 Entering
> Extended Passive Mode (|||54680|)^M
>  06/04 03:26:59.88 [9801] 1+0/6/4: service_ftp: start PollIns=[24,14]
>  06/04 03:26:59.88 [9799] 1+0: AcceptByMain: TIMEOUT(children=1, timeout=15)
>  06/04 03:26:59.88 [9801] 1+0/7/4: #### LIST^M
>  06/04 03:26:59.88 [9801] 1+0/7/5: I-SAY: LIST^M
>  06/04 03:26:59.89 [9799] 1+0:
> dirfopen(/Users/yutaka/delegate/act/restart/_9999_,r): 0 [-1]
>  06/04 03:26:59.89 [9799] 1+0: AcceptByMain: start polling(100)[14]...
>  06/04 03:26:59.99 [9799] 1+0: AcceptByMain: start polling(15000)[14]...
>  06/04 03:27:00.04 [9801] 1+0/7/5: FTP-SERVER-SAYS: 125 Data connection
> already open; Transfer starting.^M
>  06/04 03:27:00.26 [9801] 1+0/7/5: Start accept on port for PORT from
> server[26]
>  06/04 03:27:00.26 [9801] 1+0/7/5: ## accept([26]:54681)=27
>  06/04 03:27:00.26 [9801] 1+0/7/5: Accepted the data port:
> ftp.microsoft.com:20
>  06/04 03:27:00.26 [9801] 1+0/7/5: Start accept on port of PASV for client
>  06/04 03:27:00.26 [9801] 1+0/7/5: ## accept([25]:54680)=28
>  06/04 03:27:00.26 [9801] 1+0/7/5: PORTforPASV: accept[26][25] data[27][28]
>  06/04 03:27:00.26 [9801] 1+0/7/5: FTP data-relay(27,28): bufsize=32768
>  06/04 03:27:00.26 [9801] 1+0/7/5: DATA 207.46.236.102:20 ->
> 192.168.1.xx:54681 .. 127.0.0.1:54680 -> 127.0.0.1:54682
>  06/04 03:27:00.26 [9801] 1+0/7/5: NBIO[FTP-DATA][27] 0 -> 1
>  06/04 03:27:00.27 [9801] 1+0/7/5: NBIO[FTP-DATA][28] 0 -> 1
>  06/04 03:27:00.27 [9801] 1+0/7/5: FTP data-relay([27]10468b -> [28]13efcb)
> 569b / 1/ (11) 0.00s (read-EOF)
>  06/04 03:27:00.27 [9801] 1+0/7/5: LINGER: [28] 30 8{128,30}
>  06/04 03:27:00.27 [9801] 1+0/7/5: NBIO[FTP-DATA][27] 1 -> 0
>  06/04 03:27:00.27 [9801] 1+0/7/5: NBIO[FTP-DATA][28] 1 -> 0
>  06/04 03:27:00.31 [9801] 1+0/7/5: PASVrelay(27,28): 569
>  06/04 03:27:00.31 [9801] 1+0/7/5: FTP-SERVER-SAYS: 226 Transfer complete.^M
> 
> Cheers,
> Yutaka
> --
>   9 9   Yutaka Sato <y.sato@delegate.org> http://delegate.org/y.sato/
>  ( ~ )  National Institute of Advanced Industrial Science and Technology
> _<   >_ 1-1-4 Umezono, Tsukuba, Ibaraki, 305-8568 Japan
> Do the more with the less -- B. Fuller



  admin search upper oldest olders older1 this newer1 newers latest
[Top/Up] [oldest] - [Older+chunk] - [Newer+chunk] - [newest + Check]
@_@V