List Info

Thread: AMAVIS Dying




AMAVIS Dying
user name
2007-04-23 09:10:04
Hi, list, I've got a recurrent problem, and I think I've
been able to track
it down to its cause, but I would like to have some opinions
from more
experienced people.

Every sunday AMAVIS dies, and a lot of mail gets queued
until I restart the
service. It appears to happen when some cron jobs run.
Currently, my crontab
looks like this:

# m h dom mon dow user  command
17 *    * * *   root    run-parts --report /etc/cron.hourly
25 6    * * *   root    test -x /usr/sbin/anacron ||
run-parts --report
/etc/cron.daily
47 6    * * 7   root    test -x /usr/sbin/anacron ||
run-parts --report
/etc/cron.weekly
52 6    1 * *   root    test -x /usr/sbin/anacron ||
run-parts --report
/etc/cron.monthly

Here is what I have in /etc/cron.weekly:

-rwxr-xr-x   1 root root  708 Feb 10  2005 htdig
-rwxr-xr-x   1 root root  520 Jan  5  2005 man-db
-rwxr-xr-x   1 root root 1092 May 25  2005 sysklogd
-rwxr-xr-x   1 root root  240 Aug  9  2006
trim-sql-awl-weekly

ok, and here is the message I've found in the mail log:

Apr 22 06:27:02 dalton amavis[15226]: Net::Server:
2007/04/22-06:27:02
Server closing!
Apr 22 06:27:02 dalton amavis[15226]: Net::Server:
2007/04/22-06:27:02
HUP'ing server

Since the htdig, man, and trim-sql-awl-weekly scripts are
fairly light, I
suspect from the sysklogd script, which rotates the logs.
All of them are
standard Debian scripts, with the exception of the
"trim sql" script, which
I took from http://www200.pa
ir.com/mecham/spam/. I've also upgraded the
Debian standard AMAVIS to version 2.4.4 following the guide
of that site.
Currently I'm running Debian Sarge, Postfix 2.1.5-9 patched
with VDA patch,
and the named AMAVIS 2.4.4.

Here is the relevant part of AMAVIS startup on the mail
log:

Apr 23 11:02:26 dalton amavis[28289]: starting. 
/usr/sbin/amavisd-new at
dalton                                            
.quimica.unlp.edu.ar
amavisd-new-2.4.4 (20061120), Unicode aware
Apr 23 11:02:26 dalton amavis[28289]: user=106, EUID: 106
(106);  group=,
EGID:                                              109 109
106 (109 109 106)
Apr 23 11:02:26 dalton amavis[28289]: Perl version          
    5.008004
Apr 23 11:02:27 dalton amavis[28289]: SpamControl:
init_pre_chroot done
Apr 23 11:02:27 dalton amavis[28290]: Net::Server: Process
Backgrounded
Apr 23 11:02:27 dalton amavis[28290]: Net::Server:
2007/04/23-11:02:27
Amavis (t                                             ype
Net::Server::PreForkSimple) starting! pid(28290)
Apr 23 11:02:27 dalton amavis[28290]: Net::Server: Binding
to UNIX socket
file /
var/lib/amavis/amavisd.sock using SOCK_STREAM
Apr 23 11:02:27 dalton amavis[28290]: Net::Server: Binding
to TCP port 10024
on host 127.0.0.1
Apr 23 11:02:27 dalton amavis[28290]: Net::Server: Group Not
Defined.
Defaulting to EGID '109 109 106'
Apr 23 11:02:27 dalton amavis[28290]: Net::Server: User Not
Defined.
Defaulting to EUID '106'
Apr 23 11:02:27 dalton amavis[28290]: Module Amavis::Conf   
    2.075
Apr 23 11:02:27 dalton amavis[28290]: Module Archive::Tar   
    1.30
Apr 23 11:02:27 dalton amavis[28290]: Module Archive::Zip   
    1.18
Apr 23 11:02:27 dalton amavis[28290]: Module BerkeleyDB     
    0.26
Apr 23 11:02:27 dalton amavis[28290]: Module Compress::Zlib 
    1.41
Apr 23 11:02:27 dalton amavis[28290]: Module Convert::TNEF  
    0.17
Apr 23 11:02:27 dalton amavis[28290]: Module Convert::UUlib 
    1.051
Apr 23 11:02:27 dalton amavis[28290]: Module DBD::mysql     
    2.9006
Apr 23 11:02:27 dalton amavis[28290]: Module DBI            
    1.46
Apr 23 11:02:27 dalton amavis[28290]: Module DB_File        
    1.808
Apr 23 11:02:27 dalton amavis[28290]: Module Digest::MD5    
    2.33
Apr 23 11:02:27 dalton amavis[28290]: Module MIME::Entity   
    5.417
Apr 23 11:02:27 dalton amavis[28290]: Module MIME::Parser   
    5.417
Apr 23 11:02:27 dalton amavis[28290]: Module MIME::Tools    
    5.417
Apr 23 11:02:27 dalton amavis[28290]: Module Mail:KIM     
    0.24
Apr 23 11:02:27 dalton amavis[28290]: Module Mail:omainKey
s    1.0
Apr 23 11:02:27 dalton amavis[28290]: Module Mail::Header   
    1.74
Apr 23 11:02:27 dalton amavis[28290]: Module Mail::Internet 
    1.74
Apr 23 11:02:27 dalton amavis[28290]: Module
Mail::SPF::Query    1.997
Apr 23 11:02:27 dalton amavis[28290]: Module
Mail::SpamAssassin  3.001008
Apr 23 11:02:27 dalton amavis[28290]: Module Net::Cmd       
    2.26
Apr 23 11:02:27 dalton amavis[28290]: Module Net:NS      
     0.59
Apr 23 11:02:27 dalton amavis[28290]: Module Net::SMTP      
    2.29
Apr 23 11:02:27 dalton amavis[28290]: Module Net::Server    
    0.87
Apr 23 11:02:27 dalton amavis[28290]: Module
Razor2::Client::Version 2.67
Apr 23 11:02:27 dalton amavis[28290]: Module Time::HiRes    
    1.59
Apr 23 11:02:27 dalton amavis[28290]: Module Unix::Syslog   
    0.100
Apr 23 11:02:27 dalton amavis[28290]: Amavis:B code  
   loaded
Apr 23 11:02:27 dalton amavis[28290]: Amavis::Cache code  
loaded
Apr 23 11:02:27 dalton amavis[28290]: SQL base code       
NOT loaded
Apr 23 11:02:27 dalton amavis[28290]: SQL::Log code       
NOT loaded
Apr 23 11:02:27 dalton amavis[28290]: SQL::Quarantine     
NOT loaded
Apr 23 11:02:27 dalton amavis[28290]: Lookup::SQL code    
NOT loaded
Apr 23 11:02:27 dalton amavis[28290]: Lookup::LDAP code   
NOT loaded
Apr 23 11:02:27 dalton amavis[28290]: AM.PDP-in proto code
loaded
Apr 23 11:02:27 dalton amavis[28290]: SMTP-in proto code  
loaded
Apr 23 11:02:27 dalton amavis[28290]: Courier proto code  
NOT loaded
Apr 23 11:02:27 dalton amavis[28290]: SMTP-out proto code 
loaded
Apr 23 11:02:27 dalton amavis[28290]: Pipe-out proto code 
NOT loaded
Apr 23 11:02:27 dalton amavis[28290]: BSMTP-out proto code
NOT loaded
Apr 23 11:02:27 dalton amavis[28290]: Local-out proto code
loaded
Apr 23 11:02:27 dalton amavis[28290]: OS_Fingerprint code 
NOT loaded
Apr 23 11:02:27 dalton amavis[28290]: ANTI-VIRUS code     
loaded
Apr 23 11:02:27 dalton amavis[28290]: ANTI-SPAM code      
loaded
Apr 23 11:02:27 dalton amavis[28290]: ANTI-SPAM-SA code   
loaded
Apr 23 11:02:27 dalton amavis[28290]: Unpackers code      
loaded
Apr 23 11:02:27 dalton amavis[28290]: Found $file           
at
/usr/bin/file
Apr 23 11:02:27 dalton amavis[28290]: No $dspam,            
not using it
Apr 23 11:02:27 dalton amavis[28290]: Internal decoder for
.mail
Apr 23 11:02:27 dalton amavis[28290]: Internal decoder for
.asc
Apr 23 11:02:27 dalton amavis[28290]: Internal decoder for
.uue
Apr 23 11:02:27 dalton amavis[28290]: Internal decoder for
.hqx
Apr 23 11:02:27 dalton amavis[28290]: Internal decoder for
.ync
Apr 23 11:02:27 dalton amavis[28290]: No decoder for      
.F    tried:
unfreeze, freeze -d, melt, fcat
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.Z    at
/bin/uncompress
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.gz   at
/bin/gzip -d
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.bz2  at
/usr/bin/bzip2 -d
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.lzo  at
/usr/bin/lzop -d
Apr 23 11:02:27 dalton amavis[28290]: No decoder for      
.rpm  tried:
rpm2cpio.pl, rpm2cpio
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.cpio at
/bin/cpio
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.tar  at
/bin/cpio
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.deb  at
/usr/bin/ar
Apr 23 11:02:27 dalton amavis[28290]: Internal decoder for
.zip
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.rar  at
/usr/bin/unrar
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.arj  at
/usr/bin/arj
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.arc  at
/usr/bin/nomarch
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.zoo  at
/usr/bin/zoo
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.lha  at
/usr/bin/lha
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.cab  at
/usr/bin/cabextract
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.tnef at
/usr/bin/tnef
Apr 23 11:02:27 dalton amavis[28290]: Found decoder for   
.exe  at
/usr/bin/unrar; /usr/bin/lha; /usr/bin/arj
Apr 23 11:02:27 dalton amavis[28290]: Using internal av
scanner code for
(primary) ClamAV-clamd
Apr 23 11:02:27 dalton amavis[28290]: Found secondary av
scanner
ClamAV-clamscan at /usr/bin/clamscan
Apr 23 11:02:27 dalton amavis[28290]: Creating db in
/var/lib/amavis/db/;
BerkeleyDB 0.26, libdb 4.3
Apr 23 11:02:27 dalton amavis[28290]: SpamControl:
initializing
Mail::SpamAssassin

Tyhe hardware is a P-IV HT 3.06 MHz, 1 GB RAM, 80 GB SATA
disc. Should be
enough for a 300-user site, right? I think AMAVIS is dying
because of lack
of memory, but this configuration has been running for a
year and a half
flawlessly, so the situation it's kinda driving me nuts...

Any ideas? If the info is not enough, ask and I'll post.

Thanks in advance,


Luix


-- 
-------------------------------------------------
GNU-GPL: "May The Source Be With You...
-------------------------------------------------
------------------------------------------------------------
-------------
This SF.net email is sponsored by DB2 Express
Download DB2 Express C - the FREE version of DB2 express and
take
control of your XML. No limits. Just data. Click to get it
now.
http://sourcefor
ge.net/powerbar/db2/
_______________________________________________
AMaViS-user mailing list
AMaViS-userlists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/amavis-user

AMaViS-FAQ:http://www.amav
is.org/amavis-faq.php3
AMaViS-HowTos:http://www.amavis.org/ho
wto/

Re: AMAVIS Dying
country flaguser name
Slovenia
2007-04-23 09:20:54
Luis Hernán Otegui,
> Hi, list, I've got a recurrent problem, and I think
I've been able to track
> it down to its cause, but I would like to have some
opinions from more
> experienced people.
>
> Every sunday AMAVIS dies, and a lot of mail gets queued
until I restart the
> service. It appears to happen when some cron jobs run.
Currently, my
> crontab looks like this:

> Apr 22 06:27:02 dalton amavis[15226]: Net::Server:
2007/04/22-06:27:02
> Server closing!
> Apr 22 06:27:02 dalton amavis[15226]: Net::Server:
2007/04/22-06:27:02
> HUP'ing server

Some service is sending HUP signal to amavisd, and it shuts
down.
This is a normal response from amavisd (very long time ago
this
worked as a restart, but not any longer, use: 'amavisd
reload' for that).

Find the guilty script that sends a HUP, and remove it.

I suspect some log rotation script. Log from amavisd should
go to syslog, directly writing a log file is not
recommended.
If logging goes to syslog, there is no need to restart
amavisd
in order to rotate logs.

  Mark

------------------------------------------------------------
-------------
This SF.net email is sponsored by DB2 Express
Download DB2 Express C - the FREE version of DB2 express and
take
control of your XML. No limits. Just data. Click to get it
now.
http://sourcefor
ge.net/powerbar/db2/
_______________________________________________
AMaViS-user mailing list
AMaViS-userlists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/amavis-user

AMaViS-FAQ:http://www.amav
is.org/amavis-faq.php3
AMaViS-HowTos:http://www.amavis.org/ho
wto/

Re: AMAVIS Dying
user name
2007-04-23 10:02:53
OK, I'm officially an ass. I forgot I run a script once an
hour to learn
spam and ham from the webmail users' Spam and Ham folders.
In that script,
I'ver used "/etc/init.d/amavis restart". And from
your mail, I see I should
use "/etc/init.d/amavis reload".

Sorry for the mistake.


Thanks again,


Luix


2007/4/23, Mark Martinec <Mark.Martinec+amavisijs.si>:
>
> Luis Hernán Otegui,
> > Hi, list, I've got a recurrent problem, and I
think I've been able to
> track
> > it down to its cause, but I would like to have
some opinions from more
> > experienced people.
> >
> > Every sunday AMAVIS dies, and a lot of mail gets
queued until I restart
> the
> > service. It appears to happen when some cron jobs
run. Currently, my
> > crontab looks like this:
>
> > Apr 22 06:27:02 dalton amavis[15226]: Net::Server:
2007/04/22-06:27:02
> > Server closing!
> > Apr 22 06:27:02 dalton amavis[15226]: Net::Server:
2007/04/22-06:27:02
> > HUP'ing server
>
> Some service is sending HUP signal to amavisd, and it
shuts down.
> This is a normal response from amavisd (very long time
ago this
> worked as a restart, but not any longer, use: 'amavisd
reload' for that).
>
> Find the guilty script that sends a HUP, and remove
it.
>
> I suspect some log rotation script. Log from amavisd
should
> go to syslog, directly writing a log file is not
recommended.
> If logging goes to syslog, there is no need to restart
amavisd
> in order to rotate logs.
>
>   Mark
>
>
------------------------------------------------------------
-------------
> This SF.net email is sponsored by DB2 Express
> Download DB2 Express C - the FREE version of DB2
express and take
> control of your XML. No limits. Just data. Click to get
it now.
> http://sourcefor
ge.net/powerbar/db2/
> _______________________________________________
> AMaViS-user mailing list
> AMaViS-userlists.sourceforge.net
> https://lists.sourceforge.net/lists/listinfo/amavis-user

> AMaViS-FAQ:http://www.amav
is.org/amavis-faq.php3
> AMaViS-HowTos:http://www.amavis.org/ho
wto/
>



-- 
-------------------------------------------------
GNU-GPL: "May The Source Be With You...
-------------------------------------------------
------------------------------------------------------------
-------------
This SF.net email is sponsored by DB2 Express
Download DB2 Express C - the FREE version of DB2 express and
take
control of your XML. No limits. Just data. Click to get it
now.
http://sourcefor
ge.net/powerbar/db2/
_______________________________________________
AMaViS-user mailing list
AMaViS-userlists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/amavis-user

AMaViS-FAQ:http://www.amav
is.org/amavis-faq.php3
AMaViS-HowTos:http://www.amavis.org/ho
wto/

[1-3]

about | contact  Other archives ( Real Estate discussion Medical topics )