[Postfixbuch-users] Amavisproblem

Grooz, Marc (regio iT) Marc.Grooz at regioit.de
Di Mär 27 11:56:50 CEST 2012


Hallo Zusammen,

kann mir jemand helfen?

Ich sehe folgendes Problem. Manchmal kommt es vor das über meinen Postfix + Amavis Pre-Queue Mailserver Emails versendet werden und der Amavis braucht sehr lange um diese zu verarbeiten. Im aktuellen Fall ist die Email ca 4 Mb Groß und hat mehrere PDF Anhänge.

Das Log zeigt folgendes:

Mar 27 11:22:03 mailserver amavis[32694]: (32694-02) ESMTP::10026 /var/lib/amavis/tmp/amavis-20120327T112101-32694: <email> -> <email> SIZE=3767669 BODY=8BITMIME ENVID=msgid Received: from mailserver ([ip]) by localhost 

Dann geht es 2 ½ Minuten später erst weiter:

Mar 27 11:24:31 mailserver amavis[32694]: (32694-02) smtp connection cache, dt: 56.0, state: 1
Mar 27 11:24:31 mailserver amavis[32694]: (32694-02) smtp connection cache, dt: 56.0 -> disabling
Mar 27 11:24:31 mailserver amavis[32694]: (32694-02) body hash: 82c47c9d37d5e15fbd4396f4820da444
...
Mar 27 11:24:33 mailserver amavis[32694]: (32694-02) smtp resp to DATA: 354 End data with <CR><LF>.<CR><LF>
Mar 27 11:36:25 mailserver amavis[32694]: (32694-02) smtp cmd> QUIT
...
Mar 27 11:36:25 mailserver amavis[32694]: (32694-02) TIMING-SA total 1770 ms - parse: 19 (1.1%), extract_message_metadata: 39 (2.2%), get_uri_detail_list: 3 (0.2%), tests_pri_-1000: 8 (0.4%), tests_pri_-950: 2 (0.1%), tests_pri_-900: 2 (0.1%), tests_pri_-400: 45 (2.5%), check_bayes: 43 (2.4%), tests_pri_0: 1625 (91.8%), check_dkim_adsp: 5 (0.3%), check_spf: 0.48 (0.0%), check_razor2: 1346 (76.1%), check_pyzor: 46 (2.6%), tests_pri_500: 5 (0.3%), learn: 6 (0.4%), get_report: 1.89 (0.1%)
Mar 27 11:36:25 mailserver amavis[32694]: (32694-02) sending SMTP response: "250 2.0.0 from MTA([ip]:10025): 250 2.0.0 Ok: queued as id"
Mar 27 11:36:25 mailserver amavis[32694]: (32694-02) TIMING [total 862408 ms] - SMTP greeting: 2 (0%)0, SMTP EHLO: 1 (0%)0, SMTP pre-MAIL: 2 (0%)0, SMTP pre-DATA-flush: 4 (0%)0, SMTP DATA: 148681 (17%)17, check_init: 1 (0%)17, digest_hdr: 1 (0%)17, digest_body_dkim: 25 (0%)17, gen_mail_id: 1 (0%)17, mime_decode: 205 (0%)17, get-file-type7: 30 (0%)17, parts_decode: 1 (0%)17, check_header: 2 (0%)17, AV-scan-1: 21 (0%)17, spam-wb-list: 1 (0%)17, SA parse: 20 (0%)17, SA check: 1747 (0%)17, update_cache: 6 (0%)17, decide_mail_destiny: 0 (0%)17, fwd-connect: 5 (0%)17, fwd-xforward: 1 (0%)17, fwd-mail-pip: 3 (0%)17, fwd-rcpt-pip: 0 (0%)17, fwd-data-chkpnt: 0 (0%)17, write-header: 1 (0%)17, fwd-data-contents: 711367 (82%)100, fwd-end-chkpnt: 259 (0%)100, prepare-dsn: 1 (0%)100, main_log_entry: 10 (0%)100, update_snmp: 3 (0%)100, SMTP pre-response: 0 (0%)100, SMTP response: 0 (0%)100, unlink-7-files: 1 (0%)100, rundown: 1 (0%)100
Mar 27 11:36:25 mailserver amavis[32694]: (32694-02) ESMTP: NOTICE: client broke the connection without a QUIT ()
Mar 27 11:36:25 mailserver amavis[32694]: (32694-02) load: 94 %, total idle 55.977 s, busy 868.361 s
Mar 27 11:36:30 mailserver amavis[32694]: (32694-02) loaded policy bank "EXT"
Mar 27 11:36:30 mailserver amavis[32694]: (32694-02) process_request: fileno sock=12, STDIN=0, STDOUT=1

Problematisch ist das die besagte Email in der Postfix Queue hängen bleibt und trotz Fehler zugestellt wird und das natürlich mehrfach.

Vom Postfix bekomme ich die Fehlermeldung :

Out: 451 4.3.0 Error: queue file write error

Amavisd-new nanny zeigt mir sehr lange AAAAAAA an bevor es mit ==== weitergeht.

Normalerweise sind Emails dieser Größe keine Probleme und das System arbeitet zuverlässig.

Gruß Marc
-------------- nächster Teil --------------
Ein Dateianhang mit HTML-Daten wurde abgetrennt...
URL: <https://listi.jpberlin.de/pipermail/postfixbuch-users/attachments/20120327/8d3e87a8/attachment.html>


Mehr Informationen über die Mailingliste Postfixbuch-users