[TriLUG] Amavis dying, new info.

[Rick DeNatale]

A week or so ago, I posted a query about how to debug why amavisd-new
was periodically dying about once a day on my system.

I wrote a script which I run as a frequent cron job which checks on
the health of amavisd, fetchmail, and clamd. If one or more of these
is found to have died, the script restarts it and emails me with the
last 50 lines from the appropriate log.

Below is the message Ifound this morning.  I've editted it down a bit,
by eliminating a bunch of traffic about e-mail which got through
spamassassin and clamav, but it looks like I'm running into a memory
allocation limit, while trying to quarrantine an email. I doubt that
I'm actually running out of virtual memory. This happened at 4:00 am
and not much was going on in the system at the time.  From the syslog,
the awstats cron job did start about 2 minutes before the failure, and
my rsync backup job started about 30 seconds AFTER the last failure
was logged.

Is there a config parameter somewhere in amavis, or the system which
limits memory usage?  The resource limits section in amavisd.conf
doesn't seem to have anything which is apropos.


---------- Forwarded message ----------
From: root <root at denhaven2.com>
Date: Nov 4, 2005 4:10 AM
Subject: Mail Monitor
To: rick at denhaven2.com
Cc: rick.denatale at gmail.com


Amavis found dead at Fri Nov 4 04:10:04 EST 2005

TAIL OF LOG


<root at denhaven2.com> -> <spam-admin at denhaven2.com>, quarantine
spam-867eedd011d2f9477e5e47d9afe0d915-20051104-040151-22899-05,
Message-ID: <20051104090111.E4221107D11 at localhost>, Hits: -2.801
Nov  4 04:02:01 frodo amavisd-new[23040]: (23040-05) 451 4.5.0 Local
delivery(1) to /var/lib/amavis/virusmails/spam-a7449483f41e36495367c8a73d5dd3f3-20051104-040201-23040-05.gz
failed: gzip failed: Cannot allocate memory at /usr/sbin/amavisd-new
line 2639, <GEN12> line 1431.
Nov  4 04:02:01 frodo amavisd-new[23040]: (23040-05) TROUBLE in
check_mail: spam quar+notif FAILED: temporarily unable to quarantine:
451 4.5.0 Local delivery(1) to
/var/lib/amavis/virusmails/spam-a7449483f41e36495367c8a73d5dd3f3-20051104-040201-23040-05.gz
failed: gzip failed: Cannot allocate memory at /usr/sbin/amavisd-new
line 2639, <GEN12> line 1431., id=23040-05 at /usr/sbin/amavisd-new
line 6117.
Nov  4 04:02:01 frodo amavisd-new[23040]: (23040-05) PRESERVING
EVIDENCE in /var/lib/amavis/amavis-20051103T222721-23040
Nov  4 04:02:01 frodo amavisd-new[23040]: (23040-06) TROUBLE in
check_mail: decoding2-get-file-types FAILED: run_command (open pipe):
Can't fork at /usr/lib/perl/5.8/IO/File.pm line 70. at
/usr/sbin/amavisd-new line 1125.
Nov  4 04:02:01 frodo amavisd-new[23040]: (23040-06) PRESERVING
EVIDENCE in /var/lib/amavis/amavis-20051104T040201-23040
Nov  4 04:02:31 frodo amavisd-new[22899]: (22899-06) 451 4.5.0 Local
delivery(1) to /var/lib/amavis/virusmails/spam-6e4ee7dc29e4de3d5f8786a1c43c3dfb-20051104-040231-22899-06.gz
failed: gzip failed: Cannot allocate memory at /usr/sbin/amavisd-new
line 2639, <GEN12> line 20441.
Nov  4 04:02:31 frodo amavisd-new[22899]: (22899-06) TROUBLE in
check_mail: spam quar+notif FAILED: temporarily unable to quarantine:
451 4.5.0 Local delivery(1) to
/var/lib/amavis/virusmails/spam-6e4ee7dc29e4de3d5f8786a1c43c3dfb-20051104-040231-22899-06.gz
failed: gzip failed: Cannot allocate memory at /usr/sbin/amavisd-new
line 2639, <GEN12> line 20441., id=22899-06 at /usr/sbin/amavisd-new
line 6117.
Nov  4 04:02:31 frodo amavisd-new[22899]: (22899-06) PRESERVING
EVIDENCE in /var/lib/amavis/amavis-20051103T222155-22899
Nov  4 04:05:04 frodo amavisd-new[25881]: starting.  amavisd-new at
frodo amavisd-new-20030616-p10, Unicode aware, LANG=en_US.UTF-8
Nov  4 04:05:04 frodo amavisd-new[25881]: Perl version               5.008004
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Amavis::Conf        1.15
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Archive::Tar        1.24
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Archive::Zip        1.14
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Compress::Zlib      1.33
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Convert::TNEF       0.17
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Convert::UUlib      1.03
Nov  4 04:05:04 frodo amavisd-new[25881]: Module DB_File             1.808
Nov  4 04:05:04 frodo amavisd-new[25881]: Module MIME::Entity        5.415
Nov  4 04:05:04 frodo amavisd-new[25881]: Module MIME::Parser        5.415
Nov  4 04:05:04 frodo amavisd-new[25881]: Module MIME::Tools         5.415
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Mail::Header        1.62
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Mail::Internet      1.62
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Mail::SpamAssassin  3.000002
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Net::Cmd            2.26
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Net::DNS            0.48
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Net::SMTP           2.29
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Net::Server         0.87
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Time::HiRes         1.59
Nov  4 04:05:04 frodo amavisd-new[25881]: Module Unix::Syslog        0.100
\n\nEND OF LOG\n\nRestarting amavis\n\n
Starting amavisd: amavisd-new.




--
Rick DeNatale

Visit the Project Mercury Wiki Site
http://www.mercuryspacecraft.com/