Daniel C wrote:
Hi,
Sorry for the informations missing. Here they are. This is running on a
vserver, which are behind a iptables firewall, and the local IPs are in the
range 10.0.32.0/24.
I've annotated your logs...
Feb 19 22:23:15 homer postfix/smtpd[3711]: connect from
xxxxxxxxxx[xxx.xxx.xxx.xxx]
Feb 19 22:23:16 homer postfix/smtpd[3711]: 1B292370557:
client=xxxxxxxxxx[xxx.xxx.xxx.xxx], sasl_method=PLAIN,
sasl_username=jac...@mydomain.com
Feb 19 22:23:16 homer postfix/cleanup[3893]: 1B292370557:
message-id=
Feb 19 22:23:16 homer postfix/qmgr[3176]: 1B292370557: from=,
size=796, nrcpt=1 (queue active)
Feb 19 22:23:16 homer postfix/smtpd[3711]: disconnect from
xxxxxxxxxx[xxx.xxx.xxx.xxx]
message A arrives via SMTP AUTH
One recipient.
Feb 19 22:23:16 homer postfix/pickup[3175]: 4774B3706C6:
uid=207 from=
Feb 19 22:23:16 homer postfix/cleanup[3893]: 4774B3706C6:
message-id=
Feb 19 22:23:16 homer postfix/qmgr[3176]: 4774B3706C6: from=,
size=686, nrcpt=1 (queue active)
message B arrives via sendmail(1)
one recipient.
Feb 19 22:23:19 homer postfix/smtpd[3910]: connect from
mail.mydomain.com[10.0.32.13]
Feb 19 22:23:19 homer postfix/smtpd[3910]: 81995370679:
client=homer.mydomain.com[10.0.32.13]
Feb 19 22:23:19 homer postfix/cleanup[3893]: 81995370679:
message-id=
Feb 19 22:23:19 homer postfix/qmgr[3176]: 81995370679: from=,
size=1269, nrcpt=1 (queue active)
Feb 19 22:23:19 homer postfix/smtpd[3910]: disconnect from
homer.mydomain.com[10.0.32.13]
message AF arrives from content filter
still one recipient.
Feb 19 22:23:19 homer postfix/qmgr[3176]: 1B292370557: removed
Feb 19 22:23:19 homer postfix/lmtp[3894]: 1B292370557: to=,
relay=10.0.32.13[10.0.32.13]:10024, delay=3.5,
delays=0.1/0.01/0/3.4, dsn=2.0.0, status=sent (250 2.0.0 Ok,
id=21166-10, from MTA([10.0.32.13]:10025): 250 2.0.0 Ok:
queued as 81995370679)
message A sent to content filter, new ID is 81995370679 (AF)
Feb 19 22:23:19 homer postfix/smtpd[3910]: connect from
homer.mydomain.com[10.0.32.13]
Feb 19 22:23:19 homer postfix/smtpd[3910]: 9ACC2370557:
client=homer.mydomain.com[10.0.32.13]
Feb 19 22:23:19 homer postfix/cleanup[3893]: 9ACC2370557:
message-id=
Feb 19 22:23:19 homer postfix/qmgr[3176]: 9ACC2370557: from=,
size=1159, nrcpt=1 (queue active)
Feb 19 22:23:19 homer postfix/smtpd[3910]: disconnect from
homer.mydomain.com[10.0.32.13]
message BF arrives from content filter
still one recipient
Feb 19 22:23:19 homer postfix/lmtp[3900]: 4774B3706C6: to=,
relay=10.0.32.13[10.0.32.13]:10024, delay=3.4,
delays=0.05/0.01/0/3.3, dsn=2.0.0, status=sent (250 2.0.0 Ok,
id=21929-10, from MTA([10.0.32.13]:10025): 250 2.0.0 Ok:
queued as 9ACC2370557)
Feb 19 22:23:19 homer postfix/qmgr[3176]: 4774B3706C6: removed
message B sent to content filter, new ID 9ACC2370557 (BF)
Feb 19 22:23:20 homer postfix/smtp[3913]: 81995370679: to=,
relay=mx4.hotmail.com[65.54.244.104]:25, delay=0.6,
delays=0.01/0.01/0.25/0.34, dsn=2.0.0, status=sent (250
Queued mail for delivery)
Feb 19 22:23:20 homer postfix/qmgr[3176]: 81995370679: removed
message AF delivered to destination
Feb 19 22:23:20 homer postfix/smtp[3914]: 9ACC2370557: to=,
relay=mx3.hotmail.com[65.54.244.72]:25, delay=0.56,
delays=0.01/0.01/0.25/0.31, dsn=2.0.0, status=sent (250
Queued mail for delivery)
Feb 19 22:23:20 homer postfix/qmgr[3176]: 9ACC2370557: removed
mesasge BF delivered to destination
==================
Looks from here as if the message was submitted twice. The
problem you report is apparently not a postfix problem, nor
related to your content_filter.
BTW (and not related to your reported problem), check the RBLs
you are using in your smtpd_recipient_restrictions; several of
them are dead.
-- Noel Jones
