Article delegate-en/3695 (07Apr04) Re: Sub-Process turns to a zombie when using Delegate as an SMTP proxy

Article delegate-en/3695 of [1-4012] on the server localhost:7119
[Top/Up] [oldest] - [Older+chunk] - [Newer+chunk] - [newest + Check]
[Reference:<_A3694@delegate-en.ML_>]
Newsgroups: mail-lists.delegate-en
[DeleGate-En] Re: Sub-Process turns to a zombie when using Delegate as an SMTP proxy
04 Apr 2007 13:19:57 GMT "Petros Skalkos" <pjehabdyi-jmfhzl43iqdw.ml@delegate.org>

Hello Yutaka,

Thank you for the reply

I have downloaded v 9.6.0 pre7

Command Line:
win-dg STLS=-fcl -P25 -vd SERVER=smtp://127.0.0.1:2525 PERMIT=smtp:*:*
ADMIN=peska@mydomain..gr 

I got the log line :
04/04 15:21:51.38 [544] 99+0: NOT ended with .CRLF:
62eJKJMt2GSyBd3tQEi2BANpaAsCRTHNogDWTxpXa4F9EsoSS1Y4/IID+UaHEGVIAJhUANXnmyat
^M

The problem is that the proccess [544] never closes after that. It stays
open forever

Complete log :

04/04 15:20:30.08 [544] 99+0: -- SockHost: [62.38.184.85]
server85.mydomain.gr:25
04/04 15:20:30.08 [544] 99+0: TMPFILE(regGetResolvConf) = (22) C:/Program
Files/DeleGate/tmp/dg544.1.1175689230
04/04 15:20:30.08 [544] 99+0: Close-On-Exec not supported
04/04 15:20:30.08 [544] 99+0: >>>TMPFILE(regGetResolvConf)>>>720500[22]
04/04 15:20:30.08 [544] 99+0: Close-On-Exec not supported
04/04 15:20:30.08 [544] 99+0: Close-On-Exec not supported
04/04 15:20:30.14 [544] 99+0: usedFD():setCloseOnExec(24)
04/04 15:20:30.14 [544] 99+0: Close-On-Exec not supported
04/04 15:20:30.14 [544] 99+0: *** gethostbyaddr(193.92.160.20):
mail.salonic.net / 0.06 secs. has_alias:0
04/04 15:20:30.14 [544] 99+0: HOSTS[5]=mail.salonic.net/193.92.160.20 
04/04 15:20:30.14 [544] 99+0: SPECIALIST: smtp
04/04 15:20:30.14 [544] 99+0: ##DeleGate/6.X: MIMECONV=thru is set by
default. MIMECONV="" will make it compatible with former versions.
04/04 15:20:30.14 [544] 99+0: #### newRoute[CMAP] 0/16
04/04 15:20:30.14 [544] 99+0: [0] CMAP={-o,sslway}FCL{starttls}:{}:{}
04/04 15:20:30.14 [544] 99+0: STLS -> CMAP="-o,sslway:FCL:starttls"
04/04 15:20:30.16 [544] 99+0: dirfopen(C:/Program
Files/DeleGate/log/errors.log,a): 720500 [24]
04/04 15:20:30.16 [544] 99+0: dirfopen(C:/Program
Files/DeleGate/log/abort/25,a): 720520 [25]
04/04 15:20:30.16 [544] 99+0: dirfopen(C:/Program
Files/DeleGate/log/25.smtp,a): 720540 [26]
04/04 15:20:30.16 [544] 99+0: #### newRoute[NOTIFYPLTFM] 0/16
04/04 15:20:30.16 [544] 99+0: [0] NOTIFYPLTFM=://:0-_-{}:{}
04/04 15:20:30.16 [544] 99+0: default netmask 62.38.184.85/. = FFFFFF00
04/04 15:20:30.16 [544] 99+0: #### newRoute[REMITTABLE] 0/16
04/04 15:20:30.16 [544] 99+0: [0] REMITTABLE={}{smtp,smtp-data}:{*}:{*}
04/04 15:20:30.16 [544] 99+0: #### newRoute[PERMIT] 0/16
04/04 15:20:30.16 [544] 99+0: [0] PERMIT={}{smtp}:{*}:{*}
04/04 15:20:30.16 [544] 99+0: #### newRoute[CMAP] 1/16
04/04 15:20:30.16 [544] 99+0: [1]
CMAP={delegate,vhost,nojava}relay{*}:{*}:{.localnet}
04/04 15:20:30.16 [544] 99+0: #### newRoute[CMAP] 2/16
04/04 15:20:30.16 [544] 99+0: [2] CMAP={proxy}relay{*}:{*}:{*}
04/04 15:20:30.16 [544] 99+0: SMTPGATE[0][0]=[ 0:  GATEWAY-TYPE]=[postnews]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[0][1]=[16:  SERVER-PROTO]=[nntp]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[0][2]=[17:   SERVER-HOST]=[localhost]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[0][3]=[ 6:    Newsgroups]=[junk]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[0][4]=[ 7:  Distribution]=[local]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[1][0]=[ 0:  GATEWAY-TYPE]=[sendmail]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[1][1]=[16:  SERVER-PROTO]=[smtp]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[1][2]=[17:   SERVER-HOST]=[localhost]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[2][0]=[ 0:  GATEWAY-TYPE]=[ftpmail]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[2][1]=[16:  SERVER-PROTO]=[ftp]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[2][2]=[17:   SERVER-HOST]=[localhost]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[3][0]=[ 0:  GATEWAY-TYPE]=[httpmail]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[3][1]=[16:  SERVER-PROTO]=[http]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[3][2]=[17:   SERVER-HOST]=[localhost]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[4][0]=[ 0:  GATEWAY-TYPE]=[spooler]
04/04 15:20:30.16 [544] 99+0: SMTPGATE[5][0]=[ 0:  GATEWAY-TYPE]=[smmdgate]
04/04 15:20:30.16 [544] 99+0: Warning: non existent
SMTPGATE=${ETCDIR}/smtpgate [C:/Program Files/DeleGate/etc/smtpgate]
04/04 15:20:30.16 [544] 99+0: ### [0] C:/Program
Files/DeleGate/etc\dglibdgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [1] C:/Program
Files/DeleGate/lib\dglibdgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [2] C:\Program
Files\DeleGate\dglibdgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [3] C:\WINNT\system32\dglibdgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [4] ${HOME}/lib\dglibdgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [5] /usr/local/lib\dglibdgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [6] /usr/lib\dglibdgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [7] /lib\dglibdgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [0] C:/Program
Files/DeleGate/etc\dgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [1] C:/Program
Files/DeleGate/lib\dgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [2] C:\Program Files\DeleGate\dgzlib1.dll
0
04/04 15:20:30.16 [544] 99+0: ### [3] C:\WINNT\system32\dgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [4] ${HOME}/lib\dgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [5] /usr/local/lib\dgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [6] /usr/lib\dgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [7] /lib\dgzlib1.dll 0
04/04 15:20:30.16 [544] 99+0: ### [0] C:/Program Files/DeleGate/etc\dgzlib1
0
04/04 15:20:30.16 [544] 99+0: ### [1] C:/Program Files/DeleGate/lib\dgzlib1
0
04/04 15:20:30.16 [544] 99+0: ### [2] C:\Program Files\DeleGate\dgzlib1 0
04/04 15:20:30.16 [544] 99+0: ### [3] C:\WINNT\system32\dgzlib1 0
04/04 15:20:30.16 [544] 99+0: ### [4] ${HOME}/lib\dgzlib1 0
04/04 15:20:30.16 [544] 99+0: ### [5] /usr/local/lib\dgzlib1 0
04/04 15:20:30.16 [544] 99+0: ### [6] /usr/lib\dgzlib1 0
04/04 15:20:30.16 [544] 99+0: ### [7] /lib\dgzlib1 0
04/04 15:20:30.16 [544] 99+0: ### [0] gzip 0
04/04 15:20:30.16 [544] 99+0: ### [1] C:\Program Files\DeleGate\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [2] C:/Program Files/DeleGate/lib\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [3] win-dg\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [4] C:/Program Files/DeleGate/etc\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [0] C:\Perl\site\bin\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [1] C:\Perl\bin\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [2] C:\WINNT\system32\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [3] C:\WINNT\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [4] C:\WINNT\System32\Wbem\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [5] C:\PROGRA~1\ULTRAE~1\gzip 0
04/04 15:20:30.16 [544] 99+0: ### [0] gzip.exe 0
04/04 15:20:30.16 [544] 99+0: ### [1] C:\Program Files\DeleGate\gzip.exe 0
04/04 15:20:30.17 [820] 99+0: AcceptByMain: start polling(15000)[15]...
04/04 15:20:30.17 [544] 99+0: ### [2] C:/Program Files/DeleGate/lib\gzip.exe
0
04/04 15:20:30.17 [544] 99+0: ### [3] win-dg\gzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [4] C:/Program Files/DeleGate/etc\gzip.exe
0
04/04 15:20:30.17 [544] 99+0: ### [0] C:\Perl\site\bin\gzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [1] C:\Perl\bin\gzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [2] C:\WINNT\system32\gzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [3] C:\WINNT\gzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [4] C:\WINNT\System32\Wbem\gzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [5] C:\PROGRA~1\ULTRAE~1\gzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [0] gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [1] C:\Program Files\DeleGate\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [2] C:/Program Files/DeleGate/lib\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [3] win-dg\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [4] C:/Program Files/DeleGate/etc\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [0] C:\Perl\site\bin\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [1] C:\Perl\bin\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [2] C:\WINNT\system32\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [3] C:\WINNT\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [4] C:\WINNT\System32\Wbem\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [5] C:\PROGRA~1\ULTRAE~1\gunzip 0
04/04 15:20:30.17 [544] 99+0: ### [0] gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [1] C:\Program Files\DeleGate\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [2] C:/Program
Files/DeleGate/lib\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [3] win-dg\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [4] C:/Program
Files/DeleGate/etc\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [0] C:\Perl\site\bin\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [1] C:\Perl\bin\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [2] C:\WINNT\system32\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [3] C:\WINNT\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [4] C:\WINNT\System32\Wbem\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ### [5] C:\PROGRA~1\ULTRAE~1\gunzip.exe 0
04/04 15:20:30.17 [544] 99+0: ## initMapFilter[FCL][-o,sslway]
04/04 15:20:30.17 [544] 99+0: ### [0] C:/Program
Files/DeleGate/etc\dglibssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [1] C:/Program
Files/DeleGate/lib\dglibssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [2] C:\Program Files\DeleGate\dglibssl.dll
0
04/04 15:20:30.17 [544] 99+0: ### [3] C:\WINNT\system32\dglibssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [4] ${HOME}/lib\dglibssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [5] /usr/local/lib\dglibssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [6] /usr/lib\dglibssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [7] /lib\dglibssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [0] C:/Program Files/DeleGate/etc\ssl.dll
0
04/04 15:20:30.17 [544] 99+0: ### [1] C:/Program Files/DeleGate/lib\ssl.dll
0
04/04 15:20:30.17 [544] 99+0: ### [2] C:\Program Files\DeleGate\ssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [3] C:\WINNT\system32\ssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [4] ${HOME}/lib\ssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [5] /usr/local/lib\ssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [6] /usr/lib\ssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [7] /lib\ssl.dll 0
04/04 15:20:30.17 [544] 99+0: ### [0] C:/Program Files/DeleGate/etc\ssl 0
04/04 15:20:30.17 [544] 99+0: ### [1] C:/Program Files/DeleGate/lib\ssl 0
04/04 15:20:30.17 [544] 99+0: ### [2] C:\Program Files\DeleGate\ssl 0
04/04 15:20:30.17 [544] 99+0: ### [3] C:\WINNT\system32\ssl 0
04/04 15:20:30.17 [544] 99+0: ### [4] ${HOME}/lib\ssl 0
04/04 15:20:30.17 [544] 99+0: ### [5] /usr/local/lib\ssl 0
04/04 15:20:30.17 [544] 99+0: ### [6] /usr/lib\ssl 0
04/04 15:20:30.17 [544] 99+0: ### [7] /lib\ssl 0
04/04 15:20:30.17 [544] 99+0: ### [0] server-key.pem 0
04/04 15:20:30.17 [544] 99+0: ### [1] C:\WINNT\system32\server-key.pem 0
04/04 15:20:30.17 [544] 99+0: ### [2] C:/Program
Files/DeleGate/lib\server-key.pem 0
04/04 15:20:30.17 [544] 99+0: ### [3] C:\Program
Files\DeleGate\server-key.pem 0
04/04 15:20:30.17 [544] 99+0: ### [4] C:/Program
Files/DeleGate/etc\server-key.pem 0
04/04 15:20:30.17 [544] 99+0: ### [0] server-cert.pem 0
04/04 15:20:30.17 [544] 99+0: ### [1] C:\WINNT\system32\server-cert.pem 0
04/04 15:20:30.17 [544] 99+0: ### [2] C:/Program
Files/DeleGate/lib\server-cert.pem 0
04/04 15:20:30.17 [544] 99+0: ### [3] C:\Program
Files\DeleGate\server-cert.pem 0
04/04 15:20:30.17 [544] 99+0: ### [4] C:/Program
Files/DeleGate/etc\server-cert.pem 0
04/04 15:20:30.17 [544] 99+0: ## SSLway certfile not found or wrong:
server-cert.pem [at C:\Program Files\DeleGate\work\25]
04/04 15:20:30.17 [544] 99+0: ## SSLway keyfile not found or wrong:
server-key.pem [at C:\Program Files\DeleGate\work\25]
04/04 15:20:30.17 [544] 99+0: ## SSLway key does not match cert:
server-key.pem server-cert.pem
04/04 15:20:30.17 [544] 99+0: ## SSLway -- Using Default Certificate
04/04 15:20:30.17 [544] 99+0: ## SSLway ## 0.000000 connected/accepted
04/04 15:20:30.17 [544] 99+0: ## SSLway initialized ctx #0000000 0 X
04/04 15:20:30.17 [544] 99+0: #### newRoute[USERIDENT] 0/16
04/04 15:20:30.17 [544] 99+0: [0] USERIDENT=://:0-_-{}:{}
04/04 15:20:30.19 [544] 99+0: dirfopen(C:/Program
Files/DeleGate/act/clients/03/193.92.160.20..mail.salonic.net,r+): 720560
[27]
04/04 15:20:30.19 [544] 99+0: #### countUp: nonexistent 2060, C:/Program
Files/DeleGate/act/clients/03/193.92.160.20..mail.salonic.net
04/04 15:20:30.19 [544] 99+0: (0) accepted [21]
-@[193.92.160.20]mail.salonic.net:43803 (0.125s)(1)
04/04 15:20:30.19 [544] 99+0: dirfopen(C:/Program
Files/DeleGate/adm/shutout/193.92.160.20,r): 0 [-1]
04/04 15:20:30.19 [544] 99+0: dirfopen(C:/Program
Files/DeleGate/adm/shutout/193.92.160.20,r): 0 [-1]
04/04 15:20:30.19 [544] 99+0: KeepAlive[21] = 1
04/04 15:20:30.19 [544] 99+0: execGeneralist->execSpecialist
04/04 15:20:30.19 [544] 99+0: PATH:
smtp://127.0.0.1:2525!server85.mydomain.gr:25!mail.salonic.net:43803!anonymo
us@mail.salonic.net;1175689230
04/04 15:20:30.20 [544] 99+0: #### newRoute[RELIABLE] 0/16
04/04 15:20:30.20 [544] 99+0: [0] RELIABLE=://:0-_-{}:{}
04/04 15:20:30.20 [544] 99+0: #### newRoute[REACHABLE] 0/16
04/04 15:20:30.20 [544] 99+0: [0] REACHABLE=://:0-_-{}:{}
04/04 15:20:30.20 [544] 99+0: PERMITTED: smtp://127.0.0.1
04/04 15:20:30.20 [544] 99+0: dirfopen(C:/Program
Files/DeleGate/act/servers/cc/smtp-anonymous-127.0.0.1-2525-0,r+): 0 [-1]
04/04 15:20:30.20 [544] 99+0: ConnectToServer: DFLT=smtp://127.0.0.1:2525
REAL=://:0
04/04 15:20:30.20 [544] 99+0: ConnectToServer connect smtp://127.0.0.1:2525
04/04 15:20:30.20 [544] 99+0: connectTO: assume in non-blocking mode
04/04 15:20:30.20 [544] 99+0: ConnectToServer connected [27] {127.0.0.1:2525
<- 127.0.0.1:2970} [0.000s]
04/04 15:20:30.20 [544] 99+0: KeepAlive[27] = 1
04/04 15:20:30.20 [544] 99+0: willSTLS_SV: ServerFlags=10
04/04 15:20:30.47 [544] 99+0: {R} retrying AAAA [server85.mydomain.gr]
04/04 15:20:30.47 [544] 99+0: SMTP > 220 compaq.mydomain.gr (IMail 8.20
359-1) NT-ESMTP Server X1^M
04/04 15:20:30.47 [544] 99+0: willSTLS_SV: ServerFlags=200010
04/04 15:20:31.09 [544] 99+0: SMTP < EHLO mail.salonic.net^M
04/04 15:20:31.09 [544] 99+0: CALLBACK[193.92.160.20] 1 00.6/00.6 EHLO: 1
<mail.salonic.net> mail.salonic.net 
04/04 15:20:31.09 [544] 99+0: SMTP < EHLO server85.mydomain.gr^M
04/04 15:20:31.09 [544] 99+0: SMTP > 250-compaq.mydomain.gr says hello^M
04/04 15:20:31.09 [544] 99+0: SMTP > 250-SIZE 0^M
04/04 15:20:31.09 [544] 99+0: SMTP > 250-8BITMIME^M
04/04 15:20:31.09 [544] 99+0: SMTP > 250-DSN^M
04/04 15:20:31.09 [544] 99+0: SMTP > 250-ETRN^M
04/04 15:20:31.09 [544] 99+0: SMTP > 250-AUTH LOGIN CRAM-MD5^M
04/04 15:20:31.09 [544] 99+0: SMTP > 250-AUTH LOGIN^M
04/04 15:20:31.09 [544] 99+0: SMTP > 250-AUTH=LOGIN^M
04/04 15:20:31.09 [544] 99+0: SMTP > 250 EXPN^M
04/04 15:20:31.09 [544] 99+0: 250-STARTTLS^M
04/04 15:20:31.09 [544] 99+0: 250-X-GREETING compaq.mydomain.gr says hello^M
250-SIZE 0^M
250-8BITMIME^M
250-DSN^M
250-ETRN^M
250-AUTH LOGIN CRAM-MD5^M
250-AUTH LOGIN^M
250-AUTH=LOGIN^M
250 EXPN^M
04/04 15:20:31.67 [544] 99+0: SMTP < MAIL FROM:<sme-industry@veth..gr>
SIZE=570579^M
04/04 15:20:31.69 [544] 99+0: SMTP > 250 ok^M
04/04 15:20:31.78 [544] 99+0: SMTP < RCPT TO:<info@tripani..gr>^M
04/04 15:20:31.78 [544] 99+0: <info@tripani..gr> => info@..gr
04/04 15:20:31.80 [544] 99+0: SMTP > 250 ok its for <info@tripani..gr>^M
04/04 15:20:34.52 [544] 99+0: SMTP < DATA^M
04/04 15:20:34.52 [544] 99+0: SMTP > 354 ok, send it; end with
<CRLF>.<CRLF>^M
04/04 15:20:34.52 [544] 99+0: TMPFILE(SMTP-DATA-IN) = (28) C:/Program
Files/DeleGate/tmp/dg544.2.1175689234
04/04 15:20:34.52 [544] 99+0: Close-On-Exec not supported
04/04 15:20:34.52 [544] 99+0: >>>TMPFILE(SMTP-DATA-IN)>>>720600[28]

04/04 15:21:51.38 [544] 99+0: ## SMTP unbuffering slow DATA (25320B/77s).
04/04 15:21:51.38 [544] 99+0: NOT ended with .CRLF:
62eJKJMt2GSyBd3tQEi2BANpaAsCRTHNogDWTxpXa4F9EsoSS1Y4/IID+UaHEGVIAJhUANXnmyat
^M


----------------------------------------------------------------------------
-----------------------
EOF message
----------------------------------------------------------------------------
----------------------------Original Message-----
From: Yutaka Sato [mailto:pficabdyi-jmfhzl43iqdw.ml@delegate.org] 
Sent: Wednesday, April 04, 2007 6:04 AM
To: pficabdyi-jmfhzl43iqdw.ml@delegate.org
Cc: peska@cyberarts.gr; pficabdyi-jmfhzl43iqdw.ml@delegate.org
Subject: Re: [DeleGate-En:3683] Sub-Process turns to a zombie when using
Delegate as an SMTP proxy

Hi,

In message <_A3679@delegate-en.ML_> on 03/26/07(21:10:36)
you "Petros Skalkos" <pjehabdyi-jmfhzl43iqdw.ml@delegate.org> wrote:
 |This is a redefinition of my problem with more details and log.
 |
 |I'm using delegate as an SMTP proxy (to handle TLS) on Win 2000 Server
using
 |the  :
 |
 |dg9_5_3 STLS=-fcl -P25 -vd SERVER=smtp://127.0.0.1:2525 PERMIT=smtp:*:*
 |ADMIN=peska@mydomain..gr  
 |
 |As you see it connects to the same server on port 2525 where ASSP
(antispam
 |proxy) listens
 |
 |It works fine, but, some times I have a dg9_5_3 sub-process that never
 |closes.
 |
 |The sub-process works fine until the time it starts receiving the e-mail.
 |From that point,
 |
 |sometimes it stops writing to the log file and stays active for ever.
 |
 |Note that when this happens, the connection is in SSL mode (using
STARTTLS)

Your log shows that it is not in SSL mode.
The STARTTLS capability is announced in the EHLO response, but is not used.

 |Some other times it starts writing the following log entry millions of
times
 |generating huge log file :
 |(WIN) 25:39.921 [1984] -- SOCKET recv(22)=-1 error=10054 [0.000]
 |
 |Do you have any idea what could cause this error and behavior?
...
 |03/26 14:24:28.84 [1904] 23+0: SMTP < DATA^M
 |03/26 14:24:28.84 [1904] 23+0: SMTP > 354 ok, send it; end with
<CRLF>.<CRLF>^M
 |03/26 14:24:28.84 [1904] 23+0: TMPFILE(SMTP-DATA-IN) = (29) C:/Program
Files/DeleGate/tmp/dg1904.2.1174908268
 |03/26 14:24:28.84 [1904] 23+0: Close-On-Exec not supported
 |03/26 14:24:28.84 [1904] 23+0: >>>TMPFILE(SMTP-DATA-IN)>>>71cce0[29]
...
 |* Please note that when this behavior happens, the connection has always
 |been changed to SSL (using STARTTLS)

It is not changed to SSL.
 
 |* After that point in most of the cases, we never hear back from the
session
 |but the session remains open for ever (zombie)
 |
 |* Sometimes the following log line appears in the log file for the session
:
 |03/26 14:27:50.73 [1904] 23+0: ## SMTP unbuffering slow DATA
(34310B/202s).

This can occur when the client disconnected in the middle of DATA command
and the problem is fixed in DeleGate/9.6.0-pre2 (released on March 19,
available as pub/DeleGate/alpha/bin-latest9/win-dg.zip).
You will see "NOT ended with .CRLF" in the logfile with 9.6.0-pre2 or later
on such situation.

 |* And finaly, some other times millions of the following lines appear in
the
 |log for the session :
 |
 |(WIN) 27:13.265 [1480] -- SOCKET recv(22)=-1 error=10054 [0.000]
 |(WIN) 27:13.265 [1480] -- SOCKET recv(22)=-1 error=10054 [0.000]
 |(WIN) 27:13.265 [1480] -- SOCKET recv(22)=-1 error=10054 [0.000]

The log of this process [1480] before it starts this repetition will be
helpful to see what is happening, for example to see what is this file
descriptor 22.  It is likely to be the socket for client or server but
could be of something else.

Cheers,
Yutaka
--
  9 9   Yutaka Sato <pfqcabdyi-jmfhzl43iqdw.ml@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
[Top/Up] [oldest] - [Older+chunk] - [Newer+chunk] - [newest + Check]