Sorry to answer my own posts, problem hasn't gone away. I've set log = level 5 and this is what I've found.
It seems that Amavis gives up at the 'CALLING SA check' stage, and skips to the final part to save and destroy the process in hand. Does anyone have any advice how I can trace this issue further - is Amavis looking for a connection to a Spamassassin child and can't find one? For an email that fails to process this is the end of the log Jul 5 16:56:42 vps10521 amavis[9651]: (09651-01) SpamControl: calling spam scanner Jul 5 16:56:42 vps10521 amavis[9651]: (09651-01) spam_scan: DSPAM not available, skipping it Jul 5 16:56:42 vps10521 amavis[9651]: (09651-01) timer set to 800 s for SA (was 1200 s) Jul 5 16:56:42 vps10521 amavis[9651]: (09651-01) calling SA parse, SA version 3.2.5, 3.002005, data as GLOB Jul 5 16:56:42 vps10521 amavis[9651]: (09651-01) CALLING SA check Jul 5 16:56:43 vps10521 amavis[9651]: (09651-01) child_finish_hook: invoking DESTROY methods Jul 5 16:56:43 vps10521 amavis[9651]: (09651-01) Amavis::Cache DESTROY called Jul 5 16:56:43 vps10521 amavis[9651]: (09651-01) Amavis::DB::SNMP DESTROY called Jul 5 16:56:43 vps10521 amavis[9651]: (09651-01) ESMTP> 421 4.3.2 Service shutting down, closing channel Jul 5 16:56:43 vps10521 amavis[9651]: (09651-01) switch_to_client_time 480 s, smtp response sent Jul 5 16:56:43 vps10521 amavis[9651]: (09651-01) Amavis::TempDir DESTROY called Jul 5 16:56:43 vps10521 amavis[9651]: (09651-01) (!)TempDir removal: tempdir is to be PRESERVED: /var/amavis/tmp/amavis-20100705T165642-09651 for an email that is ok: Jul 5 16:38:37 vps10521 amavis[8072]: (08072-09) SpamControl: calling spam scanner Jul 5 16:38:37 vps10521 amavis[8072]: (08072-09) spam_scan: DSPAM not available, skipping it Jul 5 16:38:37 vps10521 amavis[8072]: (08072-09) timer set to 800 s for SA (was 1200 s) Jul 5 16:38:37 vps10521 amavis[8072]: (08072-09) calling SA parse, SA version 3.2.5, 3.002005, data as GLOB Jul 5 16:38:37 vps10521 amavis[8072]: (08072-09) CALLING SA check Jul 5 16:38:38 vps10521 amavis[8072]: (08072-09) prolong_timer spam_scan_sa_finish: timer set to 1199 s Jul 5 16:38:38 vps10521 amavis[8072]: (08072-09) spam_scan: score=-0.528 autolearn=no tests=[ALL_TRUSTED=-1.44,AWL=-0.608,HTML_IMAGE_ONLY_28=1.519,HTML_MESSAGE=0.001] Jul 5 16:38:38 vps10521 amavis[8072]: (08072-09) prolong_timer spam_scan: remaining time = 1199 s Jul 5 16:38:38 vps10521 amavis[8072]: (08072-09) enqueue: stat is not numeric: "" Jul 5 16:38:38 vps10521 amavis[8072]: (08072-09) enqueue: deleting: 132ab45ab78ee0097460be46dd0cce10 Jul 5 16:38:38 vps10521 amavis[8072]: (08072-09) enqueue: stat is not numeric: "" Jul 5 16:38:38 vps10521 amavis[8072]: (08072-09) lookup: (scalar) matches, result="-999" <cut lots of SA stuff> (note these logs we from the same sender and recipient email address) Colin. On 30/06/2010 9:06 PM, Colin Harris - Website Development wrote: > Dear all, > > I'm running amavisd-new on a server and it has been working ok, until the > last few days. > > I'm getting a lot of queuing of emails, looking at the log files I get a > few of these: > > postfix/smtp[1556]: DCDE21270BAE: to=<hid...@email.com>, > relay=127.0.0.1[127.0.0.1]:10024, delay=300, delays=0.21/0.01/300/0, > dsn=4.4.2, status=deferred (conversation with 127.0.0.1[127.0.0.1] timed > out while receiving the initial server greeting) > > Sometimes they clear out after a while, but sometimes the only way to > process them is via an Amavis restart or postqueue -f > > I'm running this with spamassassain and postfix if that's any help. > > Anyway if you can help that's great. > > Colin. > > > > > > > ------------------------------------------------------------------------------ > This SF.net email is sponsored by Sprint > What will you do first with EVO, the first 4G phone? > Visit sprint.com/first -- http://p.sf.net/sfu/sprint-com-first > _______________________________________________ > AMaViS-user mailing list > AMaViS-user@lists.sourceforge.net > https://lists.sourceforge.net/lists/listinfo/amavis-user > Please visit http://www.ijs.si/software/amavisd/ regularly > For administrativa requests please send email to rainer at openantivirus > dot org > > > -- colin harris website development w...@colinharris.net <mailto:w...@colinharris.net> www.colinharris.net <http://www.colinharris.net> colin harris website development <http://www.colinharris.net> *EMAIL DISCLAIMER:* This email and any attachments to it may be confidential and are intended solely for the use of the individual to whom it is addressed. Any views or opinions expressed are solely those of the author and do not necessarily represent those of Colin Harris Website Development. If you are not the intended recipient of this email, you must neither take any action based upon its contents, nor copy or show it to anyone. Please contact the sender if you believe you have received this email in error. Colin Harris Website Development | First Floor 2-4 Queen Street | Amble | Northumberland | NE65 0BZ | 01665 714433 ------------------------------------------------------------------------------ This SF.net email is sponsored by Sprint What will you do first with EVO, the first 4G phone? Visit sprint.com/first -- http://p.sf.net/sfu/sprint-com-first _______________________________________________ AMaViS-user mailing list AMaViS-user@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/amavis-user Please visit http://www.ijs.si/software/amavisd/ regularly For administrativa requests please send email to rainer at openantivirus dot org
