[milters] Archive

Lists Index Date Thread Search

Article: 1961
From: Michael K
Date: 2009-02-28 08:50:33 -0500
Subject: Re: milter-error crash

Removal...........: milters-request@milter.info?subject=remove
More information..: http://www.milter.info/#Support
--------------------------------------------------------

Hi,

I've tried to integrate milter-error in our email system again, but
without success. It still crashes. Here's one of the stacks:

Program received signal SIGSEGV, Segmentation fault.
[Switching to Thread -1220326496 (LWP 2874)]
0x00942b6b in strlen () from /lib/tls/libc.so.6
(gdb) where
#0  0x00942b6b in strlen () from /lib/tls/libc.so.6
#1  0x00916741 in vfprintf () from /lib/tls/libc.so.6
#2  0x009a0974 in vsyslog () from /lib/tls/libc.so.6
#3  0x0804e972 in smfLog (category=2,
    fmt=0x80b4414 "%05d %s: cliet %s [%s] white listed") at smf.c:170
#4  0x0804b18a in filterOpen (ctx=0x8f51f70,
    client_name=0x8f52188 "localhost.localdomain",
raw_client_addr=0xb7434270)
    at milter-error.c:386
#5  0x08064f02 in st_connectinfo ()
#6  0x080646dd in mi_engine ()
#7  0x0806246c in mi_handle_session ()
#8  0x08061a7a in mi_thread_handle_wrapper ()
#9  0x00c3e3cc in start_thread () from /lib/tls/libpthread.so.0
#10 0x009a496e in clone () from /lib/tls/libc.so.6


There's nothing in the mail log about PID 2874, the last lines before
the crash are:

Feb 28 07:31:52 nicad sendmail[2863]: n1SDVpT3002863:
from=owner-monitor@mydomain.com, size=1703, class=0, nrcpts=1,
msgid=<01c999b1$47d25e80$b488393e@sdyggvrtw>, relay=majordomo@localhost
Feb 28 07:31:52 nicad sendmail[2814]: n1SDVpHe002814:
to="|/usr/local/bin/stripmime.pl |/etc/smrsh/wrapper resend -l monitor
monitor-list", ctladdr=<monitor@mydomain.com> (8/0), delay=00:00:06,
xdelay=00:00:01, mailer=prog, pri=121423, dsn=2.0.0, stat=Sent
Feb 28 07:31:52 nicad sendmail[2873]: n1SDVqLY002873: Milter
(milter-error): init success to negotiate
Feb 28 07:31:52 nicad sendmail[2873]: n1SDVqLY002873: Milter: connect to
filters
Feb 28 07:31:52 nicad milter-error[2705]: 00001 NOQUEUE: host
localhost.localdomain [127.0.0.1] OK

<!-- here sendmail stalls waiting for the gdb session -->
<!-- I quit gdb and sendmail resumes with errors -->

Feb 28 07:32:03 nicad sendmail[2873]: n1SDVqLY002873:
milter_sys_read(milter-error): cmd read returned 0, expecting 5
Feb 28 07:32:03 nicad sendmail[2883]: n1SDVvGl002883: Milter
(milter-error): read returned -1: Connection reset by ads.rcgroups.com
Feb 28 07:32:03 nicad sendmail[2873]: n1SDVqLY002873: Milter
(milter-error): to error state
Feb 28 07:32:03 nicad sendmail[2883]: n1SDVvGl002883: Milter
(milter-error): to error state
Feb 28 07:32:03 nicad sendmail[2883]: n1SDVvGl002883: Milter
(milter-error): init failed to open
Feb 28 07:32:03 nicad sendmail[2883]: n1SDVvGl002883: Milter
(milter-error): to error state
Feb 28 07:32:03 nicad sendmail[2883]: n1SDVvGl002883: Milter: connect to
filters
Feb 28 07:32:03 nicad sendmail[2875]: n1SDVrIm002875: Milter
(milter-error): read returned -1: Connection reset by
net94.78.95-103.nchel.ru
Feb 28 07:32:03 nicad sendmail[2875]: n1SDVrIm002875: Milter
(milter-error): to error state
Feb 28 07:32:03 nicad sendmail[2875]: n1SDVrIm002875: Milter
(milter-error): init failed to open
Feb 28 07:32:03 nicad sendmail[2875]: n1SDVrIm002875: Milter
(milter-error): to error state
Feb 28 07:32:03 nicad sendmail[2875]: n1SDVrIm002875: Milter: connect to
filters
Feb 28 07:32:03 nicad sendmail[2873]: STARTTLS=server,
relay=localhost.localdomain [127.0.0.1], version=TLSv1/SSLv3,
verify=NOT, cipher=DHE-RSA-AES256-SHA, bits=256/256
Feb 28 07:32:03 nicad sendmail[2872]: STARTTLS=client,
relay=[127.0.0.1], version=TLSv1/SSLv3, verify=FAIL,
cipher=DHE-RSA-AES256-SHA, bits=256/256
Feb 28 07:32:03 nicad sendmail[2873]: n1SDVqLZ002873:
from=<owner-monitor@mydomain.com>, size=1855, class=0, nrcpts=1,
msgid=<01c999b1$47d25e80$b488393e@sdyggvrtw>, bodytype=8BITMIME,
proto=ESMTP, daemon=MTA, relay=localhost.localdomain [127.0.0.1]
Feb 28 07:32:03 nicad sendmail[2873]: n1SDVqLZ002873: Milter accept: message
Feb 28 07:32:03 nicad sendmail[2872]: n1SDVpT3002863: to=monitor-list,
delay=00:00:12, xdelay=00:00:11, mailer=relay, pri=121703,
relay=[127.0.0.1] [127.0.0.1],
 dsn=2.0.0, stat=Sent (n1SDVqLZ002873 Message accepted for delivery)
Feb 28 07:32:03 nicad sendmail[2884]: n1SDW33d002884: Milter
(milter-error): open /var/run/milter/milter-error.socket failed:
Connection refused by /var/run/milter/milter-error.socket

So it looks like milter-error is crashing on the email resending from
Majordomo. Email to monitor@mydomain.com is handled thusly in /etc/aliases:

monitor: "|/usr/local/bin/stripmime.pl |/etc/smrsh/wrapper resend -l
monitor monitor-list"

Is there anything that could be done to fix this crash? If there is any
more information needed from me, I'll happily provide it.



Mike Kol wrote:
> 
> Hello,
> 
> I'm trying to get milter-error running on RHEL4 32bit system with quite
> high email activity. It's running for less than a minute, then crashes.
> I've recompiled libsnert & milter-error with debug info, here are two 
> crash stacks:
> 
> #0 0x00942b6b in strlen () from /lib/tls/libc.so.6
> #1 0x00916741 in vfprintf () from /lib/tls/libc.so.6
> #2 0x009a0974 in vsyslog () from /lib/tls/libc.so.6
> #3 0x0804e972 in smfLog (category=2,
>     fmt=0x80b4414 "%05d %s: cliet %s [%s] white listed") at smf.c:170
> #4 0x0804b18a in filterOpen (ctx=0x8723100,
>     client_name=0x8722ff8 "localhost.localdomain",
> raw_client_addr=0xb6a62270)
>     at milter-error.c:386
> #5 0x08064f02 in st_connectinfo ()
> #6 0x080646dd in mi_engine ()
> #7 0x0806246c in mi_handle_session ()
> #8 0x08061a7a in mi_thread_handle_wrapper ()
> #9 0x00c3e3cc in start_thread () from /lib/tls/libpthread.so.0
> #10 0x009a496e in clone () from /lib/tls/libc.so.6
> 
> 
> #0 0x00942b6b in strlen () from /lib/tls/libc.so.6
> #1 0x00916741 in vfprintf () from /lib/tls/libc.so.6
> #2 0x009a0974 in vsyslog () from /lib/tls/libc.so.6
> #3 0x0804e972 in smfLog (category=2,
>     fmt=0x80b4414 "%05d %s: cliet %s [%s] white listed") at smf.c:170
> #4 0x0804b18a in filterOpen (ctx=0x97715d8,
>     client_name=0x9770170 "ads.rcgroups.com",
> raw_client_addr=0xb6a15270)
>     at milter-error.c:386
> #5 0x08064f02 in st_connectinfo ()
> #6 0x080646dd in mi_engine ()
> #7 0x0806246c in mi_handle_session ()
> #8 0x08061a7a in mi_thread_handle_wrapper ()
> #9 0x00c3e3cc in start_thread () from /lib/tls/libpthread.so.0
> #10 0x009a496e in clone () from /lib/tls/libc.so.6
> 
> Looks like it's crashing while processing the access file. The
> relevant whitelist entries are:
> 
> localhost.localdomain RELAY
> localhost RELAY
> 127.0.0.1 RELAY
> 
> Connect:127.0.0.1 OK
> Connect: 208.101.25.36 OK
> Connect: 208.101.25.35 OK
> 
> GreetPause:localhost 0
> GreetPause:localhost.localdomain 0
> GreetPause:127.0.0.1 0
> 
> I can do further debugging if needed.
> 
> 


Lists Index Date Thread Search