[Postfixbuch-users] double-bounce/reject von Postfix und Amavis

Michael Nausch michael at nausch.org
Mi Jul 8 20:44:43 CEST 2009


Ach menno,

irgendwie steh' ich im Wald. Jetzt dachte ich, da spuckt der  
Backup-Mailserver in die Suppe, aber, ich habe gerade ben nochmals via  
M-net eine Webmailabgesetzt, un ddie kam direkt zu mir durch:

maillogfile:
Jul  8 20:30:35 nss postfix/smtpd[14190]: connect from  
mail-out.m-online.net[212.18.0.10]
Jul  8 20:30:42 nss postfix/policyd-weight[6130]: decided  
action=PREPEND X-policyd-weight: using cached result; rate: -8.5;  
<client=212.18.0.10> <helo=mail-out.m-online.net>  
<from=django at mnet-mail.de> <to=michael at nausch.org>; delay: 1s
Jul  8 20:30:42 nss postgrey[3871]: action=pass, reason=triplet found,  
delay=30289, client_name=mail-out.m-online.net,  
client_address=212.18.0.10, sender=django at mnet-mail.de,  
recipient=michael at nausch.org
Jul  8 20:30:42 nss amavis[19388]: (19388-08) process_request: fileno  
sock=12, STDIN=0, STDOUT=1
Jul  8 20:30:42 nss postfix/smtpd[14190]: NOQUEUE:  
client=mail-out.m-online.net[212.18.0.10]
Jul  8 20:30:42 nss amavis[19388]: (19388-09) ESMTP::10024  
/var/amavis/tmp/amavis-20090708T194034-19388: <django at mnet-mail.de> ->  
<michael at nausch.org> SIZE=1528 BODY=7BIT Received: from mx1.nausch.org  
([127.0.0.1]) by localhost (amavis.nausch.org [127.0.0.1])  
(amavisd-new, port 10024) with ESMTP for <michael at nausch.org>; Wed,  8  
Jul 2009 20:30:42 +0200 (CEST)
Jul  8 20:30:42 nss amavis[19388]: (19388-09) Actual message size 1865  
B greater than the declared 1528 B
Jul  8 20:30:42 nss amavis[19388]: (19388-09) body hash:  
abacf6dcaf1452f30f006e37b316dbbb
Jul  8 20:30:42 nss amavis[19388]: (19388-09) Checking: u-JNb47JxiY5  
[212.18.0.10] <django at mnet-mail.de> -> <michael at nausch.org>
Jul  8 20:30:42 nss amavis[19388]: (19388-09) 2822.From: <django at mnet-mail.de>
Jul  8 20:30:42 nss amavis[19388]: (19388-09) p001 1 Content-Type:  
text/plain, size: 23 B, name:
Jul  8 20:30:42 nss amavis[19388]: (19388-09) Checking for banned  
types and filenames
Jul  8 20:30:42 nss amavis[19388]: (19388-09) collect banned table[0]:  
michael at nausch.org, tables: DEFAULT=>Amavis::Lookup::RE=ARRAY(0xa7ff3c4)
Jul  8 20:30:42 nss amavis[19388]: (19388-09) p.path  
michael at nausch.org: "P=p001,L=1,M=text/plain,T=asc"
Jul  8 20:30:42 nss amavis[19388]: (19388-09) Using ClamAV-clamd:  
(built-in interface)
Jul  8 20:30:42 nss amavis[19388]: (19388-09) Using (ClamAV-clamd) on  
dir: CONTSCAN /var/amavis/tmp/amavis-20090708T194034-19388/parts\n
Jul  8 20:30:42 nss amavis[19388]: (19388-09) ClamAV-clamd: Connecting  
to socket  /tmp/clamd.socket
Jul  8 20:30:42 nss postfix/qmgr[7041]: 6F16D11586EE: removed
Jul  8 20:30:42 nss amavis[19388]: (19388-09) ClamAV-clamd: Sending  
CONTSCAN /var/amavis/tmp/amavis-20090708T194034-19388/parts\n to UNIX  
socket /tmp/clamd.socket
Jul  8 20:30:42 nss amavis[19388]: (19388-09) ask_av (ClamAV-clamd):  
/var/amavis/tmp/amavis-20090708T194034-19388/parts CLEAN
Jul  8 20:30:42 nss amavis[19388]: (19388-09) ClamAV-clamd result: clean
Jul  8 20:30:46 nss amavis[19388]: (19388-09) spam_scan: score=3.493  
autolearn=no tests=[AWL=-2.102,TRACKER_ID=2.696,TVD_SPACE_RATIO=2.899]
Jul  8 20:30:46 nss amavis[19388]: (19388-09) do_notify_and_quar:  
ccat=CleanTag (1,1) ("1,1":CleanTag, "1":Clean, "0":CatchAll)  
ccat_block=(), q_mth=, qar_mth=
Jul  8 20:30:46 nss amavis[19388]: (19388-09) SPAM-TAG,  
<django at mnet-mail.de> -> <michael at nausch.org>, No, score=3.493  
tagged_above=2 required=6.31 tests=[AWL=-2.102, TRACKER_ID=2.696,  
TVD_SPACE_RATIO=2.899]
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp creating socket by  
IO::Socket::INET: 127.0.0.1
Jul  8 20:30:46 nss postfix/smtpd[14495]: connect from  
localhost.localdomain[127.0.0.1]
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to greeting:  
220 mx1.nausch.org ESMTP Postfix
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> EHLO localhost
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to EHLO: 250  
mx1.nausch.org\nPIPELINING\nSIZE 10240000\nVRFY\nETRN\nSTARTTLS\nAUTH  
LOGIN PLAIN\nAUTH=LOGIN PLAIN\nXFORWARD NAME ADDR PROTO HELO  
SOURCE\nENHANCEDSTATUSCODES\n8BITMIME
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> XFORWARD  
ADDR=212.18.0.10 NAME=mail-out.m-online.net PROTO=ESMTP  
HELO=mail-out.m-online.net
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to XFORWARD:  
250 2.0.0 Ok
Jul  8 20:30:46 nss amavis[19388]: (19388-09) AUTH not needed,  
user='', MTA offers 'LOGIN PLAIN'
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> MAIL  
FROM:<django at mnet-mail.de> BODY=7BIT
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> RCPT  
TO:<michael at nausch.org>
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> DATA
Jul  8 20:30:46 nss postfix/smtpd[14495]: 9C05611586EE:  
client=mail-out.m-online.net[212.18.0.10]
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to MAIL (pip):  
250 2.1.0 Ok
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to RCPT (pip)  
(<michael at nausch.org>): 250 2.1.5 Ok, id=19388-09, from  
MTA([127.0.0.1]:10025): 250 2.1.5 Ok
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to DATA: 354  
End data with <CR><LF>.<CR><LF>
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> QUIT
Jul  8 20:30:46 nss postfix/cleanup[14496]: 9C05611586EE:  
message-id=<20090708203032.wr0h456zw4okkoso at webmail.mnet-online.de>
Jul  8 20:30:46 nss postfix/cleanup[14496]: 9C05611586EE: reject:  
header Subject: Sicherheitsaktualisierung from  
mail-out.m-online.net[212.18.0.10]; from=<django at mnet-mail.de>  
to=<michael at nausch.org> proto=ESMTP helo=<mail-out.m-online.net>:  
5.7.1 Header-Subject-Spamschutzregel Subj-1071
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to data-dot  
(<michael at nausch.org>): 550 5.7.1 Header-Subject-Spamschutzregel  
Subj-1071
Jul  8 20:30:46 nss amavis[19388]: (19388-09) Negative SMTP resp. to  
data-dot (<michael at nausch.org>): 550 5.7.1  
Header-Subject-Spamschutzregel Subj-1071
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to QUIT: 221 2.0.0 Bye
Jul  8 20:30:46 nss amavis[19388]: (19388-09) (!)FWD via SMTP:  
<django at mnet-mail.de> -> <michael at nausch.org>,BODY=7BIT 550 5.6.0  
Failed, id=19388-09, from MTA([127.0.0.1]:10025): 550 5.7.1  
Header-Subject-Spamschutzregel Subj-1071
Jul  8 20:30:46 nss amavis[19388]: (19388-09) DSN: NOTIFICATION:  
Action:failed, RELAYED 550 MTA-Rejected, <django at mnet-mail.de> ->  
<michael at nausch.org>
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp creating socket by  
IO::Socket::INET: 127.0.0.1
Jul  8 20:30:46 nss postfix/smtpd[14495]: disconnect from  
localhost.localdomain[127.0.0.1]
Jul  8 20:30:46 nss postfix/smtpd[14495]: connect from  
localhost.localdomain[127.0.0.1]
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to greeting:  
220 mx1.nausch.org ESMTP Postfix
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> EHLO localhost
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to EHLO: 250  
mx1.nausch.org\nPIPELINING\nSIZE 10240000\nVRFY\nETRN\nSTARTTLS\nAUTH  
LOGIN PLAIN\nAUTH=LOGIN PLAIN\nXFORWARD NAME ADDR PROTO HELO  
SOURCE\nENHANCEDSTATUSCODES\n8BITMIME
Jul  8 20:30:46 nss amavis[19388]: (19388-09) AUTH not needed,  
user='', MTA offers 'LOGIN PLAIN'
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> MAIL FROM:<>
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> RCPT  
TO:<django at mnet-mail.de>
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> DATA
Jul  8 20:30:46 nss postfix/smtpd[14495]: B88CF11586EE:  
client=localhost.localdomain[127.0.0.1]
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to MAIL (pip):  
250 2.1.0 Ok
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to RCPT (pip)  
(<django at mnet-mail.de>): 250 2.1.5 Ok, id=19388-09, from  
MTA([127.0.0.1]:10025): 250 2.1.5 Ok
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to DATA: 354  
End data with <CR><LF>.<CR><LF>
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp cmd> QUIT
Jul  8 20:30:46 nss postfix/cleanup[14496]: B88CF11586EE:  
message-id=<DSNu-JNb47JxiY5 at amavis.nausch.org>
Jul  8 20:30:46 nss postfix/qmgr[7041]: B88CF11586EE: from=<>,  
size=3988, nrcpt=1 (queue active)
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to data-dot  
(<django at mnet-mail.de>): 250 2.0.0 Ok: queued as B88CF11586EE
Jul  8 20:30:46 nss amavis[19388]: (19388-09) smtp resp to QUIT: 221 2.0.0 Bye
Jul  8 20:30:46 nss amavis[19388]: (19388-09) SEND via SMTP: <> ->  
<django at mnet-mail.de>, 250 2.6.0 Ok, id=19388-09, from  
MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as B88CF11586EE
Jul  8 20:30:46 nss amavis[19388]: (19388-09) Blocked MTA-BLOCKED,  
[212.18.0.10] [88.217.187.21] <django at mnet-mail.de> ->  
<michael at nausch.org>, Message-ID:  
<20090708203032.wr0h456zw4okkoso at webmail.mnet-online.de>, mail_id:  
u-JNb47JxiY5, Hits: 3.493, size: 1865, 4381 ms
Jul  8 20:30:46 nss amavis[19388]: (19388-09) TIMING [total 4384 ms] -  
SMTP greeting: 2 (0%)0, SMTP EHLO: 0 (0%)0, SMTP pre-MAIL: 0 (0%)0,  
SMTP pre-DATA-flush: 2 (0%)0, SMTP DATA: 20 (0%)1, check_init: 1  
(0%)1, digest_hdr: 1 (0%)1, digest_body: 0 (0%)1, gen_mail_id: 1  
(0%)1, mime_decode: 14 (0%)1, get-file-type1: 22 (1%)1,  
decompose_part: 1 (0%)1, parts_decode: 0 (0%)1, check_header: 2 (0%)2,  
AV-scan-1: 6 (0%)2, spam-wb-list: 1 (0%)2, SA parse: 3 (0%)2, SA  
check: 3982 (91%)93, update_cache: 5 (0%)93, decide_mail_destiny: 1  
(0%)93, fwd-connect: 6 (0%)93, fwd-xforward: 1 (0%)93, fwd-mail-pip:  
135 (3%)96, fwd-rcpt-pip: 0 (0%)96, fwd-data-chkpnt: 0 (0%)96,  
write-header: 1 (0%)96, fwd-data-contents: 0 (0%)96, fwd-end-chkpnt:  
99 (2%)98, prepare-dsn: 12 (0%)98, fwd-connect: 3 (0%)99,  
fwd-mail-pip: 2 (0%)99, fwd-rcpt-pip: 0 (0%)99, fwd-data-chkpnt: 0  
(0%)99, write-header: 0 (0%)99, fwd-data-contents: 5 (0%)99,  
fwd-end-chkpnt: 47 (1%)100, main_log_entry: 6 (0%)100, update_snmp: 1  
(0%)100, SMTP pre-response...
Jul  8 20:30:46 nss amavis[19388]: (19388-09) ...: 0 (0%)100, SMTP  
response: 0 (0%)100, unlink-1-files: 0 (0%)100, rundown: 0 (0%)100
Jul  8 20:30:46 nss postfix/smtpd[14190]: disconnect from  
mail-out.m-online.net[212.18.0.10]
Jul  8 20:30:46 nss postfix/smtpd[14495]: disconnect from  
localhost.localdomain[127.0.0.1]
Jul  8 20:30:46 nss amavis[19388]: (19388-09) load: 1 %, total idle  
2974.413 s, busy 37.598 s
Jul  8 20:30:48 nss postfix/smtp[17296]: B88CF11586EE:  
to=<django at mnet-mail.de>, relay=mail-in.m-online.net[212.18.5.45]:25,  
delay=1.7, delays=0.05/0.03/0.95/0.65, dsn=2.0.0, status=sent (250  
2.0.0 Ok: queued as D644E46C0A7)
Jul  8 20:30:48 nss postfix/qmgr[7041]: B88CF11586EE: removed

Mit dem Erfolg, dass wieder zwei Notifications im M-Net-Webmailer  
auftauch(t)en.

1. Meldung:
Datum:   	 Wed, 8 Jul 2009 20:30:42 +0200 [20:30:42 CEST]
Von:  	"Content-filter at amavis.nausch.org" <postmaster at nausch.org>
An:  	django at mnet-mail.de
Betreff:  	Undeliverable mail, MTA-BLOCKED
The message WAS NOT relayed to:
   <michael at nausch.org>: [127.0.0.1] said:
    550 5.7.1 Header-Subject-Spamschutzregel Subj-1071

This nondelivery report was generated by the program amavisd-new at host
amavis.nausch.org. Our internal reference code for your message is
19388-09/u-JNb47JxiY5

Return-Path: <django at mnet-mail.de>
Message-ID: <20090708203032.wr0h456zw4okkoso at webmail.mnet-online.de>
Subject: Sicherheitsaktualisierung








2.Meldung: Datum:   	 Wed, 8 Jul 2009 20:30:46 +0200 [20:30:46 CEST]
Von:  	Mail Delivery System <MAILER-DAEMON at mail-out.m-online.net>
An:  	django at mnet-mail.de
Betreff:  	Undelivered Mail Returned to Sender
     This is the mail system at host mail-out.m-online.net.

     I'm sorry to have to inform you that your message could not
     be delivered to one or more recipients. It's attached below.

     For further assistance, please send mail to postmaster.

     If you do so, please include this problem report. You can
     delete your own text from the attached returned message.

                        The mail system

     <michael at nausch.org>: host mx1.nausch.org[88.217.187.21] said: 550 5.7.1
         Header-Subject-Spamschutzregel Subj-1071 (in reply to end of  
DATA command)


Setze ich hingegen per Hand eine Mail ab, so z.B. mit:

$ telnet mx1.nausch.org 25
Trying 88.217.187.21...
Connected to mx1.nausch.org (88.217.187.21).
Escape character is '^]'.
220 mx1.nausch.org ESMTP Postfix
helo test
250 mx1.nausch.org
MAIL FROM: <michael at nausch.org>
250 2.1.0 Ok
RCPT TO: <bigchief at omni128.de>
250 2.1.5 Ok
DATA
354 End data with <CR><LF>.<CR><LF>
From:  <michael at nausch.org>
To:  <bigchief at omni128.de>
Subject: Sicherheitsaktualisierung

test
.
550 5.7.1 Header-Subject-Spamschutzregel Subj-1071
quit
221 2.0.0 Bye
Connection closed by foreign host.


Da bekomme ich _nur_ eine Notification. Das zugehörige Maillog sieht  
dann so aus:

Jul  8 20:00:20 nss postfix/smtpd[18894]: connect from  
office.nausch.org[192.168.10.20]
Jul  8 20:00:30 nss amavis[8920]: (08920-08) process_request: fileno  
sock=12, STDIN=0, STDOUT=1
Jul  8 20:00:30 nss amavis[8920]: (08920-09) loaded policy bank "MYNETS"
Jul  8 20:00:30 nss postfix/smtpd[18894]: NOQUEUE:  
client=office.nausch.org[192.168.10.20]
Jul  8 20:00:34 nss amavis[8920]: (08920-09) ESMTP::10024  
/var/amavis/tmp/amavis-20090708T191654-08920: <michael at nausch.org> ->  
<bigchief at omni128.de> Received: from mx1.nausch.org ([127.0.0.1]) by  
localhost (amavis.nausch.org [127.0.0.1]) (amavisd-new, port 10024)  
with ESMTP for <bigchief at omni128.de>; Wed,  8 Jul 2009 20:00:30 +0200  
(CEST)
Jul  8 20:00:41 nss imap[6473]: accepted connection
Jul  8 20:00:41 nss master[21473]: about to exec /usr/lib/cyrus-imapd/imapd
Jul  8 20:00:41 nss imap[6473]: login: vdr.nausch.org [192.168.10.10]  
inge plaintext User logged in
Jul  8 20:00:41 nss imap[21473]: executed
Jul  8 20:00:41 nss imap[6473]: seen_db: user inge opened  
/var/lib/imap/user/i/inge.seen
Jul  8 20:00:43 nss amavis[8920]: (08920-09) body hash:  
d41d8cd98f00b204e9800998ecf8427e
Jul  8 20:00:43 nss amavis[8920]: (08920-09) Checking: z6e5npePSSTH  
MYNETS [192.168.10.20] <michael at nausch.org> -> <bigchief at omni128.de>
Jul  8 20:00:43 nss amavis[8920]: (08920-09) 2822.From: <michael at nausch.org>
Jul  8 20:00:43 nss amavis[8920]: (08920-09) Cached virus check  
expired, TTL = 180 s
Jul  8 20:00:43 nss amavis[8920]: (08920-09) cached  
d41d8cd98f00b204e9800998ecf8427e from <michael at nausch.org> (0,0)
Jul  8 20:00:43 nss amavis[8920]: (08920-09) WARN: MIME::Parser error:  
unexpected end of header
Jul  8 20:00:43 nss amavis[8920]: (08920-09) p001 1 Content-Type:  
text/plain, size: 0 B, name:
Jul  8 20:00:43 nss amavis[8920]: (08920-09) check_header: 7, Improper  
folded header field made up entirely of whitespace (char 20 hex):  
Subject: Sicherheitsaktualisierung\\n \\n
Jul  8 20:00:43 nss amavis[8920]: (08920-09) check_header: 7, Invalid  
header field syntax: test\\n
Jul  8 20:00:43 nss amavis[8920]: (08920-09) check_header: 7, Missing  
required header field: "Date"
Jul  8 20:00:43 nss amavis[8920]: (08920-09) Checking for banned types  
and filenames
Jul  8 20:00:43 nss amavis[8920]: (08920-09) collect banned table[0]:  
bigchief at omni128.de, tables:  
DEFAULT=>Amavis::Lookup::RE=ARRAY(0xa7ff3c4)
Jul  8 20:00:43 nss amavis[8920]: (08920-09) p.path  
bigchief at omni128.de: "P=p001,L=1,M=text/plain,T=empty"
Jul  8 20:00:43 nss amavis[8920]: (08920-09) presenting full original  
message to scanners as  
/var/amavis/tmp/amavis-20090708T191654-08920/parts/p002, MIME error:  
error: unexpected end of header
Jul  8 20:00:43 nss amavis[8920]: (08920-09) Using ClamAV-clamd:  
(built-in interface)
Jul  8 20:00:43 nss amavis[8920]: (08920-09) Using (ClamAV-clamd) on  
dir: CONTSCAN /var/amavis/tmp/amavis-20090708T191654-08920/parts\n
Jul  8 20:00:43 nss amavis[8920]: (08920-09) ClamAV-clamd: Connecting  
to socket  /tmp/clamd.socket
Jul  8 20:00:43 nss amavis[8920]: (08920-09) ClamAV-clamd: Sending  
CONTSCAN /var/amavis/tmp/amavis-20090708T191654-08920/parts\n to UNIX  
socket /tmp/clamd.socket
Jul  8 20:00:43 nss amavis[8920]: (08920-09) ask_av (ClamAV-clamd):  
/var/amavis/tmp/amavis-20090708T191654-08920/parts CLEAN
Jul  8 20:00:43 nss amavis[8920]: (08920-09) ClamAV-clamd result: clean
Jul  8 20:00:43 nss amavis[8920]: (08920-09) spam_scan: score=5.357  
autolearn=no  
tests=[ALL_TRUSTED=-1.44,AWL=-1.300,MISSING_DATE=0.001,MISSING_HB_SEP=2.5,MISSING_MID=0.001,TRACKER_ID=2.696,TVD_SPACE_RATIO=2.899]
Jul  8 20:00:43 nss amavis[8920]: (08920-09) do_notify_and_quar:  
ccat=BadHdrMime (4,7) ("4,1":BadHdrMime, "4":BadHdr, "1,1":CleanTag,  
"1":Clean, "0":CatchAll) ccat_block=(), q_mth=local:badh-%m, qar_mth=
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp creating socket by  
IO::Socket::INET: 127.0.0.1
Jul  8 20:00:43 nss postfix/smtpd[19062]: connect from  
localhost.localdomain[127.0.0.1]
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to greeting:  
220 mx1.nausch.org ESMTP Postfix
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> EHLO localhost
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to EHLO: 250  
mx1.nausch.org\nPIPELINING\nSIZE 10240000\nVRFY\nETRN\nSTARTTLS\nAUTH  
LOGIN PLAIN\nAUTH=LOGIN PLAIN\nXFORWARD NAME ADDR PROTO HELO  
SOURCE\nENHANCEDSTATUSCODES\n8BITMIME
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> XFORWARD  
ADDR=192.168.10.20 NAME=office.nausch.org PROTO=SMTP HELO=test
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to XFORWARD:  
250 2.0.0 Ok
Jul  8 20:00:43 nss amavis[8920]: (08920-09) AUTH not needed, user='',  
MTA offers 'LOGIN PLAIN'
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> MAIL  
FROM:<michael at nausch.org> BODY=7BIT
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> RCPT  
TO:<bigchief at omni128.de>
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> DATA
Jul  8 20:00:43 nss postfix/smtpd[19062]: 8F08011586D2:  
client=office.nausch.org[192.168.10.20]
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to MAIL (pip):  
250 2.1.0 Ok
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to RCPT (pip)  
(<bigchief at omni128.de>): 250 2.1.5 Ok, id=08920-09, from  
MTA([127.0.0.1]:10025): 250 2.1.5 Ok
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to DATA: 354  
End data with <CR><LF>.<CR><LF>
Jul  8 20:00:43 nss amavis[8920]: (08920-09) INFO: unfolded 1 illegal  
all-whitespace continuation lines
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> QUIT
Jul  8 20:00:43 nss postfix/cleanup[19065]: 8F08011586D2: reject:  
header Subject: Sicherheitsaktualisierung  from  
office.nausch.org[192.168.10.20]; from=<michael at nausch.org>  
to=<bigchief at omni128.de> proto=SMTP helo=<test>: 5.7.1  
Header-Subject-Spamschutzregel Subj-1071
Jul  8 20:00:43 nss postfix/cleanup[19065]: 8F08011586D2:  
message-id=<20090708180043.8F08011586D2 at mx1.nausch.org>
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to data-dot  
(<bigchief at omni128.de>): 550 5.7.1 Header-Subject-Spamschutzregel  
Subj-1071
Jul  8 20:00:43 nss amavis[8920]: (08920-09) Negative SMTP resp. to  
data-dot (<bigchief at omni128.de>): 550 5.7.1  
Header-Subject-Spamschutzregel Subj-1071
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to QUIT: 221 2.0.0 Bye
Jul  8 20:00:43 nss amavis[8920]: (08920-09) (!)FWD via SMTP:  
<michael at nausch.org> -> <bigchief at omni128.de>,BODY=7BIT 550 5.6.0  
Failed, id=08920-09, from MTA([127.0.0.1]:10025): 550 5.7.1  
Header-Subject-Spamschutzregel Subj-1071
Jul  8 20:00:43 nss amavis[8920]: (08920-09) DSN: NOTIFICATION:  
Action:failed, RELAYED 550 MTA-Rejected, <michael at nausch.org> ->  
<bigchief at omni128.de>
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp creating socket by  
IO::Socket::INET: 127.0.0.1
Jul  8 20:00:43 nss postfix/smtpd[19062]: disconnect from  
localhost.localdomain[127.0.0.1]
Jul  8 20:00:43 nss postfix/smtpd[19062]: connect from  
localhost.localdomain[127.0.0.1]
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to greeting:  
220 mx1.nausch.org ESMTP Postfix
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> EHLO localhost
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to EHLO: 250  
mx1.nausch.org\nPIPELINING\nSIZE 10240000\nVRFY\nETRN\nSTARTTLS\nAUTH  
LOGIN PLAIN\nAUTH=LOGIN PLAIN\nXFORWARD NAME ADDR PROTO HELO  
SOURCE\nENHANCEDSTATUSCODES\n8BITMIME
Jul  8 20:00:43 nss amavis[8920]: (08920-09) AUTH not needed, user='',  
MTA offers 'LOGIN PLAIN'
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> MAIL FROM:<>
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> RCPT  
TO:<michael at nausch.org>
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> DATA
Jul  8 20:00:43 nss postfix/smtpd[19062]: 936EF11586D2:  
client=localhost.localdomain[127.0.0.1]
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to MAIL (pip):  
250 2.1.0 Ok
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to RCPT (pip)  
(<michael at nausch.org>): 250 2.1.5 Ok, id=08920-09, from  
MTA([127.0.0.1]:10025): 250 2.1.5 Ok
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to DATA: 354  
End data with <CR><LF>.<CR><LF>
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp cmd> QUIT
Jul  8 20:00:43 nss postfix/cleanup[19065]: 936EF11586D2:  
message-id=<DSNz6e5npePSSTH at amavis.nausch.org>
Jul  8 20:00:43 nss postfix/qmgr[7041]: 936EF11586D2: from=<>,  
size=2340, nrcpt=1 (queue active)
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to data-dot  
(<michael at nausch.org>): 250 2.0.0 Ok: queued as 936EF11586D2
Jul  8 20:00:43 nss amavis[8920]: (08920-09) smtp resp to QUIT: 221 2.0.0 Bye
Jul  8 20:00:43 nss amavis[8920]: (08920-09) SEND via SMTP: <> ->  
<michael at nausch.org>, 250 2.6.0 Ok, id=08920-09, from  
MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 936EF11586D2
Jul  8 20:00:43 nss amavis[8920]: (08920-09) Blocked MTA-BLOCKED,  
MYNETS LOCAL [192.168.10.20] [192.168.10.20] <michael at nausch.org> ->  
<bigchief at omni128.de>, mail_id: z6e5npePSSTH, Hits: 5.357, size: 267,  
12799 ms
Jul  8 20:00:43 nss amavis[8920]: (08920-09) TIMING [total 12802 ms] -  
SMTP greeting: 2 (0%)0, SMTP EHLO: 1 (0%)0, SMTP pre-MAIL: 0 (0%)0,  
SMTP pre-DATA-flush: 3326 (26%)26, SMTP DATA: 9151 (71%)97,  
check_init: 1 (0%)97, digest_hdr: 0 (0%)97, digest_body: 0 (0%)97,  
gen_mail_id: 1 (0%)97, mime_decode: 5 (0%)98, get-file-type0: 0  
(0%)98, parts_decode: 0 (0%)98, check_header: 1 (0%)98, AV-scan-1: 27  
(0%)98, spam-wb-list: 1 (0%)98, SA parse: 1 (0%)98, SA check: 45  
(0%)98, update_cache: 5 (0%)98, decide_mail_destiny: 1 (0%)98,  
fwd-connect: 161 (1%)99, fwd-xforward: 1 (0%)99, fwd-mail-pip: 2  
(0%)99, fwd-rcpt-pip: 0 (0%)99, fwd-data-chkpnt: 0 (0%)99,  
write-header: 0 (0%)99, fwd-data-contents: 0 (0%)99, fwd-end-chkpnt: 2  
(0%)99, prepare-dsn: 10 (0%)100, fwd-connect: 3 (0%)100, fwd-mail-pip:  
2 (0%)100, fwd-rcpt-pip: 0 (0%)100, fwd-data-chkpnt: 0 (0%)100,  
write-header: 0 (0%)100, fwd-data-contents: 4 (0%)100, fwd-end-chkpnt:  
38 (0%)100, main_log_entry: 5 (0%)100, update_snmp: 1 (0%)100, SMTP  
pre-response: ...
Jul  8 20:00:43 nss amavis[8920]: (08920-09) ...0 (0%)100, SMTP  
response: 0 (0%)100, unlink-1-files: 0 (0%)100, rundown: 0 (0%)100
Jul  8 20:00:43 nss amavis[8920]: (08920-09) load: 4 %, total idle  
2527.426 s, busy 101.757 s
Jul  8 20:00:43 nss postfix/smtpd[19062]: disconnect from  
localhost.localdomain[127.0.0.1]
Jul  8 20:00:43 nss lmtpunix[21048]: accepted connection
Jul  8 20:00:43 nss lmtpunix[21048]: lmtp connection preauth'd as postman
Jul  8 20:00:43 nss lmtpunix[21048]: duplicate_check:  
<DSNz6e5npePSSTH at amavis.nausch.org>      user.bigchief        0
Jul  8 20:00:43 nss lmtpunix[21048]: duplicate_check:  
<DSNz6e5npePSSTH at amavis.nausch.org>      user.bigchief        0
Jul  8 20:00:43 nss lmtpunix[21048]: mystore: starting txn 2147490549
Jul  8 20:00:43 nss lmtpunix[21048]: mystore: committing txn 2147490549
Jul  8 20:00:43 nss lmtpunix[21048]: duplicate_mark:  
<DSNz6e5npePSSTH at amavis.nausch.org>      user.bigchief         
1247076043 3219605828
Jul  8 20:00:43 nss lmtpunix[21048]: Delivered:  
<DSNz6e5npePSSTH at amavis.nausch.org> to mailbox: user.bigchief
Jul  8 20:00:43 nss lmtpunix[21048]: mystore: starting txn 2147490550
Jul  8 20:00:43 nss lmtpunix[21048]: mystore: committing txn 2147490550
Jul  8 20:00:43 nss lmtpunix[21048]: duplicate_mark:  
<DSNz6e5npePSSTH at amavis.nausch.org>      .bigchief+ at .sieve.    
1247076043 0
Jul  8 20:00:43 nss postfix/pipe[19073]: 936EF11586D2:  
to=<bigchief at nausch.org>, orig_to=<michael at nausch.org>, relay=cyrus,  
delay=0.35, delays=0.04/0.01/0/0.29, dsn=2.0.0, status=sent (delivered  
via cyrus service)
Jul  8 20:00:43 nss postfix/qmgr[7041]: 936EF11586D2: removed
Jul  8 20:00:45 nss postfix/smtpd[18894]: disconnect from  
office.nausch.org[192.168.10.20]

Ich versteh's einfach nicht (mehr oder noch nicht)!

Ciao,
      Django
-- 
"Bonnie & Clyde der Postmaster-Szene!" approved by Postfix-God

http://wetterstation-pliening.info
http://dokuwiki.nausch.org





Mehr Informationen über die Mailingliste Postfixbuch-users