-----Original Message-----
From: [EMAIL PROTECTED]
[mailto:[EMAIL PROTECTED] On Behalf Of Gary V
Sent: Wednesday, May 09, 2007 2:52 PM
To: [email protected]
Subject: Re: [AMaViS-user] processing times
Dylan wrote:
> Gary,
> Thank you for the reply/suggestions. I had the logging on 2 and
changed
> it to 3 then 4 but could not really see anything that pointed out what
> was taking the most time to process besides looking at the log entry
> time for each. As for mysql traffic, there isn't a WHOLE lot of mail
> going through this system yet (most is still on my plain
postfix/amavis
> install) and the box that has the mysql db on it is connected to the
> same Cisco Catalyst (both ports 100/full). Neither box is under a load
> higher than 1 or even close under normail circumstances. I am not
super
> familiar with SQL, mysql, or tuning InnoDB so I'm not sure if this is
my
> problem. I did change my Pyzor server to the one suggested and ran the
> razor discover but neither changed the process timing in either
> direction.
> Dylan
You should have some log entries similar to this:
May 9 12:43:54 mail amavis[28510]: (28510-01) TIMING [total 19502 ms]
- SMTP greeting: 7 (0%)0, SMTP EHLO: 1 (0%)0, SMTP pre-MAIL: 1 (0%)0,
mkdir tempdir: 1 (0%)0, create email.txt: 1 (0%)0, SMTP pre-DATA-flush:
4 (0%)0, SMTP DATA: 78 (0%)0, check_init: 1 (0%)0, digest_hdr: 1
(0%)0,
digest_body: 1 (0%)0, sql-connect: 5 (0%)1, sql-enter: 12 (0%)1, mkdir
parts: 3 (0%)1, mime_decode: 33 (0%)1, get-file-type3: 20 (0%)1,
decompose_part: 3 (0%)1, parts_decode: 0 (0%)1, AV-scan-1: 3671
(19%)20,
AV-scan-2: 68 (0%)20, AV-scan-3: 2862 (15%)35, spam-wb-list: 3
(0%)35,
SA msg read: 2 (0%)35, SA parse: 6 (0%)35, SA check: 12603 (65%)99,
update_cache: 9 (0%)99, penpals_check: 3 (0%)99,
decide_mail_destiny: 1
<...>
It would be helpful to see a few.
Do you know if your old amavisd.conf file you were using with
amavisd-new had?:
$sa_local_tests_only = 1;
Gary V
I sent a test from gmail to a recipient behind this server and below are
my results:
This is from the maia server with $sa_local_tests_only = 1;
May 9 14:54:13 mxfilter /usr/local/sbin/amavisd[844]: (00844-02) TIMING
[total 518 ms] - SMTP EHLO: 3 (1%), SMTP pre-MAIL: 1 (0%), lookup_sql: 5
(1%), SMTP pre-DATA-flush: 2 (0%), SMTP DATA: 33 (6%), body_hash: 1
(0%), maia_connect: 4 (1%), maia_read_system_config: 2 (0%),
maia_get_mysql_size_limit: 1 (0%), lookup_sql: 5 (1%), mime_decode: 23
(4%), get-file-type2: 21 (4%), decompose_part: 1 (0%), decompose_part: 0
(0%), parts_decode: 0 (0%), AV-scan-1: 11 (2%), spam-wb-list: 8 (1%), SA
msg read: 1 (0%), SA parse: 3 (1%), SA check: 223 (43%), update_cache: 2
(0%), maia_store_mail: 9 (2%), deal_with_mail_size: 2 (0%),
maia_record_tests: 15 (3%), maia_set_mail_status: 6 (1%), fwd-connect: 8
(2%), fwd-mail-from: 1 (0%), fwd-rcpt-to: 2 (0%), write-header: 3 (1%),
fwd-data: 0 (0%), fwd-data-end: 92 (18%), fwd-rundown: 1 (0%),
main_log_entry: 26 (5%), update_snmp: 2 (0%), maia_cleanup: 1 (0%),
maia_disconnect: 0 (0%), unlink-2-files: 2 (0%), rundown: 0 (0%)
This is from the same maia server with $sa_local_tests_only = 0;
May 9 14:56:30 mxfilter /usr/local/sbin/amavisd[923]: (00923-01) TIMING
[total 6081 ms] - sql-prepare: 7 (0%), SMTP EHLO: 6 (0%), SMTP pre-MAIL:
2 (0%), mkdir tempdir: 1 (0%), create email.txt: 1 (0%), sql-connect: 21
(0%), lookup_sql: 6 (0%), SMTP pre-DATA-flush: 3 (0%), SMTP DATA: 10
(0%), body_hash: 2 (0%), maia_connect: 5 (0%), maia_read_system_config:
2 (0%), maia_get_mysql_size_limit: 1 (0%), mkdir parts: 1 (0%),
lookup_sql: 5 (0%), mime_decode: 31 (1%), get-file-type2: 22 (0%),
decompose_part: 2 (0%), decompose_part: 0 (0%), parts_decode: 0 (0%),
AV-scan-1: 13 (0%), spam-wb-list: 9 (0%), SA msg read: 1 (0%), SA parse:
4 (0%), SA check: 5748 (95%), update_cache: 2 (0%), maia_store_mail: 10
(0%), deal_with_mail_size: 2 (0%), maia_record_tests: 19 (0%),
maia_set_mail_status: 6 (0%), fwd-connect: 10 (0%), fwd-mail-from: 2
(0%), fwd-rcpt-to: 2 (0%), write-header: 4 (0%), fwd-data: 0 (0%),
fwd-data-end: 91 (1%), fwd-rundown: 2 (0%), main_log_entry: 26 (0%),
update_snmp: 2 (0%), maia_cleanup: 1 (0%), maia_disconnect: 0 (0%),
unlink-2-files: 2 (0%), rundown: 1 (0%)
My other postfix/amavis install has the local tests only set to 0 and
has had since inception.
-------------------------------------------------------------------------
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://sourceforge.net/powerbar/db2/
_______________________________________________
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/
