Hi,
I am running Postfix 2.2.9 + Amavis 3.10 on Fedora FC5 (Zimbra 4.0.4 installation) A few days ago email delivery started being delayed after a long time with no problems. Things started getting worse and worse and finally the postfix "active" queue was growing faster than mail was being delivered creating many hour delays. Turning off spam filtering using @bypass_spam_checks_maps = (1); got mail flowing again and cleared the over 4000 awaiting emails within 30 minutes... Looking at the Amavis log files shows problems: Sample 1: Feb 9 05:29:22[12436]: (12436-01) lookup (local_domains) => true, "[EMAIL PROTECTED]" matches, result="1", matching_key="." Feb 9 05:31:23[12436]: (12436-01) spam_scan: from DSPAM: Received: from web30113.mail.mud.yahoo.com (web30113.mail.mud.yahoo.com [209.191.69.45])\n Almost 2 minutes between entries... DSPAM is taking way too long to process. How can I find out what exactly is causing this slowness? Sample 2: Feb 9 05:35:31[12426]: (12426-01-3) lookup_ldap_attr(amavislocal), no attribute, "[EMAIL PROTECTED]" result=1 Feb 9 05:35:31[12426]: (12426-01-3) lookup (local_domains) => true, "[EMAIL PROTECTED]" matches, result="1", matching_key="/cached/" Feb 9 05:55:03[12426]: (12426-01-3) TROUBLE in check_mail: spam_scan FAILED: timed out Feb 9 05:55:03[12426]: (12426-01-3) prolong_timer check done: remaining time = 0 s Feb 9 05:55:03[12426]: (12426-01-3) sending SMTP response: "451 4.5.0 Error in processing, id=12426-01-3, spam_scan FAILED: timed out" Feb 9 05:55:03[12426]: (12426-01-3) PRESERVING EVIDENCE in /opt/zimbra/amavisd/tmp/amavis-20070209T053134-12426 Feb 9 05:55:03[12426]: (12426-01-3) TIMING [total 1172691 ms] - lookup_ldap: 517 (0%)0, SMTP pre-DATA-flush: 2 (0%)0, SMTP DATA: 42 (0%)0, body_digest: 1 (0%)0, gen_mail_id: 1 (0%)0, mime_decode: 15 (0%)0, get-file-type2: 17 (0%)0, parts_decode: 1 (0%)0, AV-scan-1: 24 (0%)0, spam-wb-list: 6 (0%)0, rundown: 1172065 (100%)100 Feb 9 05:55:03[12426]: (12426-01-3) ESMTP> 451 4.5.0 Error in processing, id=12426-01-3, spam_scan FAILED: timed out Feb 9 05:55:03[12426]: (12426-01-3) switch_to_client_time 480 s, smtp response sent Feb 9 05:55:03[12426]: (12426-01-3) idle_proc, 6: was busy, 1172173.8 ms, total idle 1.089 s, busy 1408.663 s Feb 9 05:55:04[12426]: (12426-01-3) idle_proc, 5: was idle, 823.7 ms, total idle 1.913 s, busy 1408.663 s Feb 9 05:55:04[12426]: (12426-01-3) ESMTP< RSET\r\n Feb 9 05:55:04[12426]: (12426-01-3) switch_to_my_time 480 s, SMTP RSET received Feb 9 05:55:04[12426]: (12426-01-3) ESMTP> 250 2.0.0 Ok RSET Feb 9 05:55:04[12426]: (12426-01-3) switch_to_client_time 480 s, smtp response sent Feb 9 05:55:04[12426]: (12426-01-3) idle_proc, 6: was busy, 1.1 ms, total idle 1.913 s, busy 1408.664 s Feb 9 05:55:04[12426]: (12426-01-3) idle_proc, 5: was idle, 0.2 ms, total idle 1.913 s, busy 1408.664 s Feb 9 05:55:04[12426]: (12426-01-3) ESMTP< XFORWARD NAME=out010.topica-platinum-y.com ADDR=66.227.60.30\r\n Feb 9 05:55:04[12426]: (12426-01-3) switch_to_my_time 480 s, SMTP XFORWARD received Feb 9 05:55:04[12426]: (12426-01-3) ESMTP> 250 2.5.0 Ok XFORWARD Feb 9 05:55:04[12426]: (12426-01-3) switch_to_client_time 480 s, smtp response sent Feb 9 05:55:04[12426]: (12426-01-3) idle_proc, 6: was busy, 0.8 ms, total idle 1.913 s, busy 1408.664 s Feb 9 05:55:04[12426]: (12426-01-3) idle_proc, 5: was idle, 0.1 ms, total idle 1.913 s, busy 1408.664 s Feb 9 05:55:04[12426]: (12426-01-3) ESMTP< XFORWARD PROTO=SMTP HELO=out010.topica-platinum-y.com\r\n Feb 9 05:55:04[12426]: (12426-01-3) switch_to_my_time 480 s, SMTP XFORWARD received Feb 9 05:55:04[12426]: (12426-01-3) ESMTP> 250 2.5.0 Ok XFORWARD Feb 9 05:55:04[12426]: (12426-01-3) switch_to_client_time 480 s, smtp response sent Feb 9 05:55:04[12426]: (12426-01-3) idle_proc, 6: was busy, 11.3 ms, total idle 1.913 s, busy 1408.676 s Feb 9 05:55:04[12426]: (12426-01-3) idle_proc, 5: was idle, 0.2 ms, total idle 1.913 s, busy 1408.676 s Feb 9 05:55:04[12426]: (12426-01-3) ESMTP< MAIL FROM:<[EMAIL PROTECTED]> SIZE=17818\r\n Any ideas? Thanks, Eric ------------------------------------------------------------------------- Using Tomcat but need to do more? Need to support web services, security? Get stuff done quickly with pre-integrated technology to make your job easier. Download IBM WebSphere Application Server v.1.0.1 based on Apache Geronimo http://sel.as-us.falkag.net/sel?cmd=lnk&kid=120709&bid=263057&dat=121642 _______________________________________________ AMaViS-user mailing list [email protected] https://lists.sourceforge.net/lists/listinfo/amavis-user AMaViS-FAQ:http://www.amavis.org/amavis-faq.php3 AMaViS-HowTos:http://www.amavis.org/howto/
