On Fri, Sep 17, 2010 at 3:43 PM, Wietse Venema <wie...@porcupine.org> wrote:
> Jure Simsic:
> > On Fri, Sep 17, 2010 at 1:16 PM, Wietse Venema <wie...@porcupine.org>
> wrote:
> >
> > > Jure Simsic:
> > > > As the list refuses me to post such long debugs, I'm splitting my
> mail in
> > > > two:
> > >
> > > No-one here asked for DEBUG logging, so you just wasted a lot
> > > of electrons sending information that no-one will look at.
> > >
> > >
> > Ok, that's what I had. I tried to work it out myself first and see if
> there
> > is any explanation for that behavior. In case you feel more meaningful
> data
> > is in non debug information, here it is:
> >
> > No match:
> > Sep 17 15:11:58 fps-mms-mta3 postfix/smtpd[18258]: [ID 197553 mail.info]
>
> That is not what I asked for.
>
> I asked for:
>
> > Please show evidence in the form of actual email messages that
> > the To: is replaced and is not replaced.
>
> And the corresponding Postfix logging for those messages.
>
> So, could you please provide those actual email messages and
> the corresponding Postfix logging for those messages, in one
> posting to this mailing list.
>
> In case this is not 100% clear, show REAL INPUT, show REAL LOGGING,
> and show REAL RESULTS of the two messages that you believe demonstrate
> the problem.
>
This is actually somewhat difficult as the endpoints are both applications,
but i did a tcpdump to demonstrate this. In both cases the mail was sent by
hand from one box to the postfix (telnet 10.40.0.23 25 < /tmp/test3). The
content is the one I've already posted (I can post it again) and the only
thing I needed to obfuscate is the domain names, but they are consistent
(I'm a consultant and the client demands this, blah).. The header_checks is
the same in both cases, as posted, REGEXP:
/^To: \+1234567\/TYPE=PLMN$/
REPLACE To: 1919/TYPE=PLMN
The following are the SMTP going from this mta further on to the next mta,
first time with modified To: and the second without modification, the
difference is just the position of the headers in the source file.
Matched:
220 mms1.mms.domain1.com ESMTP Service (Multimedia IP message store
6.1.999.11) ready
EHLO mms-mta3.domain1.com
250-mms1.mms.domain1.com
250-DSN
250-8BITMIME
250-PIPELINING
250-HELP
250-AUTH
250 SIZE 2000000
MAIL FROM:<+11111111/type=p...@mms.domain2.com> SIZE=1017
RCPT TO:<1...@mms.domain1.com> ORCPT=rfc822;+2B1234567/
type+3dp...@mms.domain3.com <type%2b3dp...@mms.domain3.com>
DATA
250 MAIL FROM:<+11111111/type=p...@mms.domain2.com> OK
250 RCPT TO:<1...@mms.domain1.com> OK
354 Start mail input; end with <CRLF>.<CRLF>
Received: from mms-mta2.domain1.com (unknown [10.40.0.20])
by mms-mta3.domain1.com (Postfix) with ESMTP id CBDEA8C6D
for <+1234567/type=p...@mms.domain1.com>; Fri, 17 Sep 2010 17:15:05
+0200 (CEST)
X-Mms-3GPP-MMS-Version: 6.3.0
X-Mms-Ack-Request: Yes
X-Mms-Message-Type: MM4_forward.REQ
X-Mms-Delivery-Report: Yes
To: 1919/TYPE=PLMN
Received: from smtp.domain1.com ([127.0.0.1])
by localhost (mobi-mailv78.domain1.com [127.0.0.1]) (amavisd-new, port
10024)
From: +11111111/TYPE=PLMN
Date: Mon, 06 Sep 2010 11:09:56 +0000
Content-Type: multipart/related; Type="application/smil"; Start="<YoCEK>";
boundary="Nokia-mm-messageHandler-BoUnDaRy-=_
-1883574436"
Sender: +11111111/type=p...@mms.domain2.com
X-Mms-Originator-System: system-u...@mms.domain2.com
X-Mms-Message-ID: "TITMBAoEBgQAAEmtAAAGzAAAAHgAAAAB"
X-Mms-Transaction-ID: "TITMBAoEBgQAAEmtAAAGzAAAAHgAAAAA1"
Message-ID: <titmbqoebgqaac74aaatlqaaaaeaa...@mms.domain2.com>
X-Mms-Originator-R/S-Delivery-Report: NO
.
QUIT
250 <4C2C5CBF0019DF84> Mail accepted
221 mms1.mms.domain1.com QUIT
Not matched:
220 mms8.mms.domain1.com ESMTP Service (Multimedia IP message store
6.1.999.11) ready
EHLO mms-mta3.domain1.com
250-mms8.mms.domain1.com
250-DSN
250-8BITMIME
250-PIPELINING
250-HELP
250-AUTH
250 SIZE 2000000
MAIL FROM:<+11111111/type=p...@mms.domain2.com> SIZE=1025
RCPT TO:<1...@mms.domain1.com> ORCPT=rfc822;+2B1234567/
type+3dp...@mms.domain3.com <type%2b3dp...@mms.domain3.com>
DATA
250 MAIL FROM:<+11111111/type=p...@mms.domain2.com> OK
250 RCPT TO:<1...@mms.domain1.com> OK
354 Start mail input; end with <CRLF>.<CRLF>
Received: from mms-mta2.domain1.com (unknown [10.40.0.20])
by mms-mta3.domain1.com (Postfix) with ESMTP id 373098C6E
for <+1234567/type=p...@mms.domain1.com>; Fri, 17 Sep 2010 17:16:01
+0200 (CEST)
X-Mms-3GPP-MMS-Version: 6.3.0
X-Mms-Ack-Request: Yes
X-Mms-Message-Type: MM4_forward.REQ
X-Mms-Delivery-Report: Yes
Received: from smtp.domain1.com ([127.0.0.1])
by localhost (mobi-mailv78.domain1.com [127.0.0.1]) (amavisd-new, port
10024)
To: +1234567/TYPE=PLMN
From: +11111111/TYPE=PLMN
Date: Mon, 06 Sep 2010 11:09:56 +0000
Content-Type: multipart/related; Type="application/smil"; Start="<YoCEK>";
boundary="Nokia-mm-messageHandler-BoUnDaRy-=_
-1883574436"
Sender: +11111111/type=p...@mms.domain2.com
X-Mms-Originator-System: system-u...@mms.domain2.com
X-Mms-Message-ID: "TITMBAoEBgQAAEmtAAAGzAAAAHgAAAAB"
X-Mms-Transaction-ID: "TITMBAoEBgQAAEmtAAAGzAAAAHgAAAAA1"
Message-ID: <titmbqoebgqaac74aaatlqaaaaeaa...@mms.domain2.com>
X-Mms-Originator-R/S-Delivery-Report: NO
.
QUIT
250 <4C2C5F9700169399> Mail accepted
221 mms8.mms.domain1.com QUIT
And the corresponding log files as the message was accepted by this mta:
Matched:
Sep 17 17:15:05 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
connect from unknown[10.40.0.20]
Sep 17 17:15:05 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
improper command pipelining after EHLO from unknown[10.40.0.20]
Sep 17 17:15:05 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
CBDEA8C6D: client=unknown[10.40.0.20]
Sep 17 17:15:05 fps-mms-mta3 postfix/cleanup[18357]: [ID 197553 mail.info]
CBDEA8C6D: replace: header To: +1234567/TYPE=PLMN from unknown[10.40.0.20];
from=<+11111111/type=p...@mms.domain2.com> to=<1...@mms.domain1.com>
proto=ESMTP helo=<mms-mta2.domain1.com>: To: 1919/TYPE=PLMN
Sep 17 17:15:05 fps-mms-mta3 postfix/cleanup[18357]: [ID 197553 mail.info]
CBDEA8C6D: message-id=<>
Sep 17 17:15:05 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
lost connection after QUIT from unknown[10.40.0.20]
Sep 17 17:15:05 fps-mms-mta3 postfix/qmgr[18256]: [ID 197553 mail.info]
CBDEA8C6D: from=<+11111111/type=p...@mms.domain2.com>, size=1017, nrcpt=1
(queue active)
Sep 17 17:15:05 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
disconnect from unknown[10.40.0.20]
Sep 17 17:15:05 fps-mms-mta3 postfix/smtp[18358]: [ID 197553 mail.info]
CBDEA8C6D: to=<1...@mms.domain1.com>, orig_to=<+1234567/TYPE=
p...@mms.domain1.com>, relay=10.40.0.75[10.40.0.75]:25, delay=0.07,
delays=0.04/0.02/0/0, dsn=2.0.0, status=sent (250 <4C2C5CBF0019DF84> Mail
accepted)
Sep 17 17:15:05 fps-mms-mta3 postfix/qmgr[18256]: [ID 197553 mail.info]
CBDEA8C6D: removed
Not matched:
Sep 17 17:16:01 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
connect from unknown[10.40.0.20]
Sep 17 17:16:01 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
improper command pipelining after EHLO from unknown[10.40.0.20]
Sep 17 17:16:01 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
373098C6E: client=unknown[10.40.0.20]
Sep 17 17:16:01 fps-mms-mta3 postfix/cleanup[18357]: [ID 197553 mail.info]
373098C6E: message-id=<>
Sep 17 17:16:01 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
lost connection after QUIT from unknown[10.40.0.20]
Sep 17 17:16:01 fps-mms-mta3 postfix/smtpd[18354]: [ID 197553 mail.info]
disconnect from unknown[10.40.0.20]
Sep 17 17:16:01 fps-mms-mta3 postfix/qmgr[18256]: [ID 197553 mail.info]
373098C6E: from=<+11111111/type=p...@mms.domain2.com>, size=1025, nrcpt=1
(queue active)
Sep 17 17:16:01 fps-mms-mta3 postfix/smtp[18358]: [ID 197553 mail.info]
373098C6E: to=<1...@mms.domain1.com>, orig_to=<+1234567/TYPE=
p...@mms.domain1.com>, relay=10.40.0.75[10.40.0.75]:25, delay=0.03,
delays=0.02/0/0/0.01, dsn=2.0.0, status=sent (250 <4C2C5F9700169399> Mail
accepted)
Sep 17 17:16:01 fps-mms-mta3 postfix/qmgr[18256]: [ID 197553 mail.info]
373098C6E: removed
Is this clear as it is or do you require anything else?
Tnx
Jure
