[Postfixbuch-users] Doppelte Mailzustellung

Sa Okt 25 13:11:50 CEST 2008

* Uwe Kiewel <ml at kiewel-online.de> wrote:
> Stefan Förster schrieb:
>> wie ich hier gerade die Nachrichten lese, die im Laufe des letzten
>> Tages aufgeschlagen sind, fällt mir auf, daß ich in letzter Zeit des
>> öfteren bei diversen Mailinglisten (neben dieser hier u.a. auch
>> amavis-users und die deutsche Debian-Benutzer-Mailingliste) Mails
>> doppelt empfange. Als Beispiel hier einmal diese Nachricht von Ralf
>> Hildebrandt:
> 
> Dieses Verhalten kann ich bestätigen. Ich würde sagen, bei mit ist es
> seit ich amavisd-new 2.6.1 im System habe. Welche Version fährst du?

Ja, das ist ein 2.6.1 in einem pre-queue-Setup. Aber ich hab keine
Ahnung, ob das auch passiert ist, als ich ihn noch als normalen
content_filter laufen ließ, ob das am Plugin RelayCountries liegt oder
was auch immer. Die Sache ist ja, das auch das Logfile von
amavisd-new, zumindest auf $log_level=2, nichts weiter hergibt:

Erste Mail:

#v+
Oct 24 23:17:27 nemea amavis[19818]: (19818-01) loaded policy bank "PREQ"
Oct 24 23:17:27 nemea amavis[19818]: (19818-02) ESMTP::10023 /var/lib/amavis/tmp/amavis-20081024T123048-19818: <postfixbuch-users-bounces at listen.jpberlin.de>
 -> <cite+postfix-buch at incertum.net> SIZE=4099 Received: from mail.incertum.net ([127.0.0.1]) by localhost (mail.incertum.net [127.0.0.1]) (amavisd-new, port
 10023) with ESMTP for <cite+postfix-buch at incertum.net>; Fri, 24 Oct 2008 23:17:27 +0200 (CEST)
Oct 24 23:17:27 nemea amavis[19818]: (19818-02) smtp connection cache, dt: 38796.1, state: 0
Oct 24 23:17:27 nemea amavis[19818]: (19818-02) Checking: Z7TT7gA2g1tV PREQ [213.203.238.6] <postfixbuch-users-bounces at listen.jpberlin.de> -> <cite+postfix-b
uch at incertum.net>
Oct 24 23:17:27 nemea amavis[19818]: (19818-02) p001 1 Content-Type: text/plain, size: 840 B, name:
Oct 24 23:17:29 nemea amavis[19818]: (19818-02) SPAM-TAG, <postfixbuch-users-bounces at listen.jpberlin.de> -> <cite+postfix-buch at incertum.net>, No, score=-3.58
9 required=6.31 tests=[AWL=-0.990, BAYES_00=-2.599]
Oct 24 23:17:29 nemea amavis[19818]: (19818-02) FWD via SMTP: <postfixbuch-users-bounces at listen.jpberlin.de> -> <cite+postfix-buch at incertum.net>,BODY=7BIT 25
0 2.0.0 Ok, id=19818-02, from MTA([127.0.0.1]:10027): 250 2.0.0 Ok: queued as 927DB10003
Oct 24 23:17:29 nemea amavis[19818]: (19818-02) Passed CLEAN, PREQ [213.203.238.6] [141.42.4.250] <postfixbuch-users-bounces at listen.jpberlin.de> -> <cite+pos
tfix-buch at incertum.net>, Message-ID: <20081024211717.GC28819 at charite.de>, mail_id: Z7TT7gA2g1tV, Hits: -3.589, size: 4362, queued_as: 927DB10003, 2531 ms
Oct 24 23:17:29 nemea amavis[19818]: (19818-02) TIMING [total 2580 ms] - SMTP greeting: 3 (0%)0, SMTP EHLO: 1 (0%)0, SMTP pre-MAIL: 1 (0%)0, lookup_sql: 12 (
0%)1, SMTP pre-DATA-flush: 2 (0%)1, SMTP DATA: 73 (3%)4, check_init: 1 (0%)4, digest_hdr: 2 (0%)4, digest_body: 0 (0%)4, sql-enter: 79 (3%)7, custom-new: 0 (
0%)7, mime_decode: 18 (1%)7, get-file-type1: 87 (3%)11, parts_decode: 0 (0%)11, check_header: 6 (0%)11, AV-scan-1: 8 (0%)11, AV-scan-2: 1 (0%)11, spam-wb-lis
t: 6 (0%)12, SA parse: 9 (0%)12, SA check: 1997 (77%)89, custom-checks: 13 (0%)90, update_cache: 1 (0%)90, decide_mail_destiny: 2 (0%)90, custom-before_send:
 3 (0%)90, fwd-connect: 10 (0%)90, fwd-xforward: 1 (0%)90, fwd-mail-pip: 14 (1%)91, fwd-rcpt-pip: 0 (0%)91, fwd-data-chkpnt: 0 (0%)91, write-header: 4 (0%)91
, fwd-data-contents: 0 (0%)91, fwd-end-chkpnt: 158 (6%)97, custom-after_send: 2 (0%)97, prepare-dsn: 1 (0%)97, main_log_entry: 20 (1%)98, sql-update: 39 (2%)
100, update_snmp: 3 (0%)100, custom-mail_done: 0 (0%)100, SMTP pre-respo...
Oct 24 23:17:29 nemea amavis[19818]: (19818-02) ...nse: 1 (0%)100, SMTP response: 0 (0%)100, unlink-1-files: 1 (0%)100, rundown: 1 (0%)100
#v-

Zweite Mail:

#v+
Oct 24 23:17:37 nemea amavis[19843]: (19843-01) loaded policy bank "PREQ"
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) ESMTP::10023 /var/lib/amavis/tmp/amavis-20081024T124755-19843: <postfixbuch-users-bounces at listen.jpberlin.de>
 -> <cite+postfix-buch at incertum.net> SIZE=4098 Received: from mail.incertum.net ([127.0.0.1]) by localhost (mail.incertum.net [127.0.0.1]) (amavisd-new, port
 10023) with ESMTP for <cite+postfix-buch at incertum.net>; Fri, 24 Oct 2008 23:17:37 +0200 (CEST)
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) smtp connection cache, dt: 37773.9, state: 0
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) Checking: 3hCzESn6dIKn PREQ [213.203.238.6] <postfixbuch-users-bounces at listen.jpberlin.de> -> <cite+postfix-b
uch at incertum.net>
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) cached 68f9fe497612e35f42fbd1cdd0a55a2f from <postfixbuch-users-bounces at listen.jpberlin.de> (1,1)
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) p001 1 Content-Type: text/plain, size: 840 B, name:
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) SPAM-TAG, <postfixbuch-users-bounces at listen.jpberlin.de> -> <cite+postfix-buch at incertum.net>, No, score=-3.58
9 required=6.31 tests=[AWL=-0.990, BAYES_00=-2.599]
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) FWD via SMTP: <postfixbuch-users-bounces at listen.jpberlin.de> -> <cite+postfix-buch at incertum.net>,BODY=7BIT 25
0 2.0.0 Ok, id=19843-02, from MTA([127.0.0.1]:10027): 250 2.0.0 Ok: queued as 69EAD10003
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) Passed CLEAN, PREQ [213.203.238.6] [141.42.4.250] <postfixbuch-users-bounces at listen.jpberlin.de> -> <cite+pos
tfix-buch at incertum.net>, Message-ID: <20081024211717.GC28819 at charite.de>, mail_id: 3hCzESn6dIKn, Hits: -3.589, size: 4361, queued_as: 69EAD10003, 522 ms
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) TIMING [total 568 ms] - SMTP greeting: 3 (1%)1, SMTP EHLO: 1 (0%)1, SMTP pre-MAIL: 1 (0%)1, lookup_sql: 10 (2
%)3, SMTP pre-DATA-flush: 2 (0%)3, SMTP DATA: 56 (10%)13, check_init: 1 (0%)13, digest_hdr: 2 (0%)13, digest_body: 0 (0%)14, sql-enter: 115 (20%)34, custom-n
ew: 0 (0%)34, mime_decode: 17 (3%)37, get-file-type1: 84 (15%)52, parts_decode: 0 (0%)52, check_header: 6 (1%)53, spam-wb-list: 7 (1%)54, custom-checks: 0 (0
%)54, update_cache: 2 (0%)54, decide_mail_destiny: 2 (0%)55, custom-before_send: 2 (0%)55, fwd-connect: 12 (2%)57, fwd-xforward: 1 (0%)57, fwd-mail-pip: 4 (1
%)58, fwd-rcpt-pip: 0 (0%)58, fwd-data-chkpnt: 0 (0%)58, write-header: 3 (1%)59, fwd-data-contents: 0 (0%)59, fwd-end-chkpnt: 165 (29%)88, custom-after_send:
 0 (0%)88, prepare-dsn: 1 (0%)88, main_log_entry: 26 (5%)93, sql-update: 35 (6%)99, update_snmp: 3 (0%)99, custom-mail_done: 0 (0%)99, SMTP pre-response: 1 (
0%)99, SMTP response: 1 (0%)100, unlink-1-files: 1 (0%)100, rundown: 1 (...
Oct 24 23:17:37 nemea amavis[19843]: (19843-02) ...0%)100
#v-

Ich nehme an, außer z.B. ilpostino.jpberlin.de in debug_peer_list
aufzunehmen kann ich nicht mehr viel tun, um den Fehler zu finden
(vielleicht den Postmaster um Logs anhauen...), oder?

Ciao
Stefan
-- 
Stefan Förster     http://www.incertum.net/     Public Key: 0xBBE2A9E9
FdI #246: Service Pack - Hauptnahrung bei Softwarebulemie. (Manfred Worm
Schäfer)