[Mailman-Users] 554 5.7.1 Relay access denied from outside, mailman or postfix ?
renaud courvoisier
renaud.courvoisier at ecole-art-aix.fr
Mon Sep 23 16:31:55 CEST 2013
Hi,
I'm encountering a problem on postfix with mailman and only with it :
sending a message from a domain outside my server cause a 554 5.7.1
"Relay access denied" error.
I do not have this error with messages directly sent to postfix.
I don't see how to fix it, and forums' messages didn't help...
In example, AAAAAA at aDomainName.tld sending mail to
MAILMAN at listes.mydomain2.tld don't work (and the log is really short) :
/2013-09-23T15:09:32.200535+02:00 serverName postfix/smtpd[13333]:
connect from 6.mo5.mail-out.ovh.net[178.32.119.138]
2013-09-23T15:09:32.212320+02:00 serverName postfix/smtpd[13333]:
NOQUEUE: reject: RCPT from 6.mo5.mail-out.ovh.net[178.32.119.138]: 554
5.7.1 <MAILMAN at listes.mydomain2.tld>: Relay access denied;
from=<AAAAAA at aDomainName.tld> to=<MAILMAN at listes.mydomain2.tld>
proto=ESMTP helo=<mo5.mail-out.ovh.net>
2013-09-23T15:09:32.237881+02:00 serverName postfix/smtpd[13333]:
disconnect from 6.mo5.mail-out.ovh.net[178.32.119.138]/
But AAAAAA at aDomainName.tld sending mail to BBBBBB at mydomain.tld works :
/2013-09-23T15:33:33.802619+02:00 serverName postfix/smtpd[18555]:
connect from 13.mo5.mail-out.ovh.net[87.98.182.191]
2013-09-23T15:33:33.818030+02:00 serverName postgrey[19316]:
2013/09/23-15:33:33 CONNECT TCP Peer: "127.0.0.1:52567" Local:
"127.0.0.1:10023"#012
2013-09-23T15:33:33.818466+02:00 serverName postgrey[19316]:
action=pass, reason=client whitelist,
client_name=13.mo5.mail-out.ovh.net, client_address=87.98.182.191,
sender=AAAAAA at aDomainName.tld, recipient=BBBBBB at mydomain2.tld
2013-09-23T15:33:33.868874+02:00 serverName postfix/smtpd[18555]:
CFFCF40CA1: client=13.mo5.mail-out.ovh.net[87.98.182.191]
2013-09-23T15:33:33.869833+02:00 serverName postfix/cleanup[18609]:
CFFCF40CA1: message-id=<52404319.2010100 at aDomainName.tld>
2013-09-23T15:33:33.919217+02:00 serverName postfix/smtpd[18555]:
disconnect from 13.mo5.mail-out.ovh.net[87.98.182.191]
2013-09-23T15:33:33.952553+02:00 serverName postfix/qmgr[19238]:
CFFCF40CA1: from=<AAAAAA at aDomainName.tld>, size=1773, nrcpt=1 (queue active)
2013-09-23T15:33:35.329837+02:00 serverName postfix/smtpd[18613]:
connect from localhost.localdomain[127.0.0.1]
2013-09-23T15:33:35.369716+02:00 serverName postfix/smtpd[18613]:
5621A416E4: client=localhost.localdomain[127.0.0.1]
2013-09-23T15:33:35.371378+02:00 serverName postfix/cleanup[18609]:
5621A416E4: message-id=<52404319.2010100 at aDomainName.tld>
2013-09-23T15:33:35.419960+02:00 serverName postfix/smtpd[18613]:
disconnect from localhost.localdomain[127.0.0.1]
2013-09-23T15:33:35.426334+02:00 serverName amavis[10989]: (10989-10)
Passed CLEAN, [87.98.182.191] [213.186.33.50] <AAAAAA at aDomainName.tld>
-> <BBBBBB at mydomain2.tld>, Message-ID:
<52404319.2010100 at aDomainName.tld>, mail_id: HI7ZU1BVElzF, Hits: -0.001,
size: 1771, queued_as: 5621A416E4, 1466 ms
2013-09-23T15:33:35.428068+02:00 serverName postfix/smtp[18610]:
CFFCF40CA1: to=<BBBBBB at mydomain2.tld>, relay=127.0.0.1[127.0.0.1]:10024,
delay=1.6, delays=0.14/0.01/0/1.5, dsn=2.0.0, status=sent (250 2.0.0 Ok,
id=10989-10, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as
5621A416E4)
2013-09-23T15:33:35.453549+02:00 serverName postfix/qmgr[19238]:
5621A416E4: from=<AAAAAA at aDomainName.tld>, size=2227, nrcpt=1 (queue active)
2013-09-23T15:33:35.487164+02:00 serverName postfix/qmgr[19238]:
CFFCF40CA1: removed
2013-09-23T15:33:35.639855+02:00 serverName postfix/pipe[18615]:
5621A416E4: to=<BBBBBB at mydomain2.tld>, relay=dovecot, delay=0.31,
delays=0.12/0.04/0/0.15, dsn=2.0.0, status=sent (delivered via dovecot
service)
2013-09-23T15:33:35.695823+02:00 serverName postfix/qmgr[19238]:
5621A416E4: removed
/And here is the log of CCCCCC at mydomain1.tld sending a message to
MAILMAN at listes.mydomain2.tld :/
2013-09-23T15:42:09.215473+02:00 serverName postfix/smtpd[20658]:
connect from myFAI[myIP]
2013-09-23T15:42:09.594357+02:00 serverName postfix/smtpd[20658]:
8CF8F40CA1: client=myFAI[myIP], sasl_method=PLAIN,
sasl_username=CCCCCC at mydomain1.tld
2013-09-23T15:42:09.667615+02:00 serverName postfix/cleanup[20666]:
8CF8F40CA1: message-id=<52404522.109 at mydomain1.tld>
2013-09-23T15:42:09.752959+02:00 serverName postfix/qmgr[19238]:
8CF8F40CA1: from=<CCCCCC at mydomain1.tld>, size=627, nrcpt=1 (queue active)
2013-09-23T15:42:09.794108+02:00 serverName postfix/smtpd[20658]:
disconnect from myFAI[myIP]
2013-09-23T15:42:10.114724+02:00 serverName postfix/smtpd[20671]:
connect from localhost.localdomain[127.0.0.1]
2013-09-23T15:42:10.153558+02:00 serverName postfix/smtpd[20671]:
215CA41798: client=localhost.localdomain[127.0.0.1]
2013-09-23T15:42:10.155397+02:00 serverName postfix/cleanup[20666]:
215CA41798: message-id=<52404522.109 at mydomain1.tld>
2013-09-23T15:42:10.260822+02:00 serverName amavis[10889]: (10889-13)
Passed CLEAN, [myIP] [myIP] <CCCCCC at mydomain1.tld> ->
<MAILMAN at listes.mydomain2.tld>, Message-ID:
<52404522.109 at mydomain1.tld>, mail_id: IfvI-bMGsfH3, Hits: -1, size:
627, queued_as: 215CA41798, 501 ms
2013-09-23T15:42:10.262625+02:00 serverName postfix/smtp[20668]:
8CF8F40CA1: to=<MAILMAN at listes.mydomain2.tld>,
relay=127.0.0.1[127.0.0.1]:10024, delay=0.75, delays=0.24/0.01/0/0.5,
dsn=2.0.0, status=sent (250 2.0.0 Ok, id=10889-13, from
MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 215CA41798)
2013-09-23T15:42:10.287447+02:00 serverName postfix/qmgr[19238]:
215CA41798: from=<CCCCCC at mydomain1.tld>, size=1097, nrcpt=1 (queue active)
2013-09-23T15:42:10.321013+02:00 serverName postfix/qmgr[19238]:
8CF8F40CA1: removed
2013-09-23T15:42:10.399095+02:00 serverName postfix/local[20673]:
215CA41798: to=<MAILMAN at listes.mydomain2.tld>, relay=local, delay=0.28,
delays=0.17/0.04/0/0.07, dsn=2.0.0, status=sent (delivered to command:
/var/lib/mailman/mail/mailman post mailman)
2013-09-23T15:42:10.446638+02:00 serverName postfix/qmgr[19238]:
215CA41798: removed
2013-09-23T15:42:10.956536+02:00 serverName spamd[31880]: spamd:
connection from localhost.localdomain [127.0.0.1] at port 55234
2013-09-23T15:42:10.957574+02:00 serverName spamd[31880]: spamd:
handle_user unable to find user: 'mailman'
2013-09-23T15:42:10.957889+02:00 serverName spamd[31880]: spamd: still
running as root: user not specified with -u, not found, or set to root,
falling back to nobody
2013-09-23T15:42:10.961841+02:00 serverName spamd[31880]: spamd:
checking message <52404522.109 at mydomain1.tld> for mailman:65534
2013-09-23T15:42:11.149420+02:00 serverName spamd[31880]: plugin: eval
failed: bayes: (in learn) locker: safe_lock: cannot create tmp lockfile
/nonexistent/.spamassassin/bayes.lock.mydomain1.tld.31880 for
/nonexistent/.spamassassin/bayes.lock: No such file or directory
2013-09-23T15:42:11.149945+02:00 serverName spamd[31880]: spamd: clean
message (-1.0/5.0) for mailman:65534 in 0.2 seconds, 1252 bytes.
2013-09-23T15:42:11.150140+02:00 serverName spamd[31880]: spamd: result:
. -1 - ALL_TRUSTED
scantime=0.2,size=1252,user=mailman,uid=65534,required_score=5.0,rhost=localhost.localdomain,raddr=127.0.0.1,rport=55234,mid=<52404522.109 at mydomain1.tld>,autolearn=unavailable
2013-09-23T15:42:11.186345+02:00 serverName spamd[31866]: prefork: child
states: II
2013-09-23T15:42:11.387431+02:00 serverName postfix/smtpd[20658]:
connect from localhost.localdomain[127.0.0.1]
2013-09-23T15:42:11.436712+02:00 serverName postfix/smtpd[20658]:
631E241798: client=localhost.localdomain[127.0.0.1]
2013-09-23T15:42:11.437309+02:00 serverName postfix/cleanup[20666]:
631E241798: message-id=<52404522.109 at mydomain1.tld>
2013-09-23T15:42:11.522618+02:00 serverName postfix/qmgr[19238]:
631E241798: from=<MAILMAN-bounces at listes.mydomain2.tld>, size=2175,
nrcpt=1 (queue active)
2013-09-23T15:42:11.565760+02:00 serverName postfix/smtpd[20658]:
8600B40CA1: client=localhost.localdomain[127.0.0.1]
2013-09-23T15:42:11.568849+02:00 serverName postfix/cleanup[20666]:
8600B40CA1: message-id=<52404522.109 at mydomain1.tld>
2013-09-23T15:42:11.616324+02:00 serverName postfix/smtpd[20658]:
disconnect from localhost.localdomain[127.0.0.1]
2013-09-23T15:42:11.649902+02:00 serverName postfix/qmgr[19238]:
8600B40CA1: from=<MAILMAN-bounces at listes.mydomain2.tld>, size=2144,
nrcpt=3 (queue active)
2013-09-23T15:42:12.125480+02:00 serverName postfix/smtpd[20671]:
1A80041734: client=localhost.localdomain[127.0.0.1]
2013-09-23T15:42:12.129236+02:00 serverName postfix/cleanup[20666]:
1A80041734: message-id=<52404522.109 at mydomain1.tld>
2013-09-23T15:42:12.188510+02:00 serverName amavis[10889]: (10889-14)
Passed CLEAN, LOCAL [127.0.0.1] [myIP]
<MAILMAN-bounces at listes.mydomain2.tld> ->
<AAAAAA at aDomainName.tld>,<BBBBBB at mydomain2.tld>,<XXXXXX at anotherDomainName.tld>,
Message-ID: <52404522.109 at mydomain1.tld>, mail_id: 8MQgWJ-2Apd1, Hits:
-0.999, size: 2144, queued_as: 1A80041734, 533 ms
2013-09-23T15:42:12.189785+02:00 serverName postfix/smtp[20676]:
8600B40CA1: to=<AAAAAA at aDomainName.tld>,
relay=127.0.0.1[127.0.0.1]:10024, delay=0.7, delays=0.16/0/0/0.53,
dsn=2.0.0, status=sent (250 2.0.0 Ok, id=10889-14, from
MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 1A80041734)
2013-09-23T15:42:12.193748+02:00 serverName postfix/smtp[20676]:
8600B40CA1: to=<BBBBBB at mydomain2.tld>, relay=127.0.0.1[127.0.0.1]:10024,
delay=0.7, delays=0.16/0/0/0.53, dsn=2.0.0, status=sent (250 2.0.0 Ok,
id=10889-14, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as
1A80041734)
2013-09-23T15:42:12.202111+02:00 serverName postfix/smtp[20676]:
8600B40CA1: to=<XXXXXX at anotherDomainName.tld>,
relay=127.0.0.1[127.0.0.1]:10024, delay=0.7, delays=0.16/0/0/0.53,
dsn=2.0.0, status=sent (250 2.0.0 Ok, id=10889-14, from
MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as 1A80041734)
2013-09-23T15:42:12.227203+02:00 serverName postfix/qmgr[19238]:
1A80041734: from=<MAILMAN-bounces at listes.mydomain2.tld>, size=2550,
nrcpt=3 (queue active)
2013-09-23T15:42:12.267880+02:00 serverName postfix/qmgr[19238]:
8600B40CA1: removed
2013-09-23T15:42:12.413714+02:00 serverName postfix/pipe[20678]:
1A80041734: to=<BBBBBB at mydomain2.tld>, relay=dovecot, delay=0.32,
delays=0.13/0.05/0/0.14, dsn=2.0.0, status=sent (delivered via dovecot
service)
2013-09-23T15:42:12.414958+02:00 serverName postfix/smtp[20679]:
1A80041734: to=<AAAAAA at aDomainName.tld>,
relay=mx1.ovh.net[213.186.33.29]:25, delay=0.32,
delays=0.13/0.05/0.02/0.12, dsn=2.0.0, status=sent (250 ok 1379943717 qp
24412)
2013-09-23T15:42:12.729639+02:00 serverName postfix/smtp[20681]:
1A80041734: to=<XXXXXX at anotherDomainName.tld>,
relay=mailhost.anotherDomainName.tld[83.145.80.114]:25, delay=0.64,
delays=0.13/0.05/0.18/0.27, dsn=2.0.0, status=sent (250 2.0.0
1f0qyxrkd4-1 Message accepted for delivery)
2013-09-23T15:42:12.784870+02:00 serverName postfix/qmgr[19238]:
1A80041734: removed
2013-09-23T15:42:13.038443+02:00 serverName postfix/smtpd[20682]:
connect from localhost.localdomain[127.0.0.1]
2013-09-23T15:42:13.077894+02:00 serverName postfix/smtpd[20682]:
0EE1840CA1: client=localhost.localdomain[127.0.0.1]
2013-09-23T15:42:13.079693+02:00 serverName postfix/cleanup[20666]:
0EE1840CA1: message-id=<52404522.109 at mydomain1.tld>
2013-09-23T15:42:13.128129+02:00 serverName postfix/smtpd[20682]:
disconnect from localhost.localdomain[127.0.0.1]
2013-09-23T15:42:13.133732+02:00 serverName amavis[10989]: (10989-13)
Passed CLEAN, LOCAL [127.0.0.1] [myIP]
<MAILMAN-bounces at listes.mydomain2.tld> -> <CCCCCC at mydomain1.tld>,
Message-ID: <52404522.109 at mydomain1.tld>, mail_id: Ulol1liVMq7z, Hits:
-0.999, size: 2175, queued_as: 0EE1840CA1, 1567 ms
2013-09-23T15:42:13.135386+02:00 serverName postfix/smtp[20668]:
631E241798: to=<CCCCCC at mydomain1.tld>, relay=127.0.0.1[127.0.0.1]:10024,
delay=1.7, delays=0.13/0.04/0/1.6, dsn=2.0.0, status=sent (250 2.0.0 Ok,
id=10989-13, from MTA([127.0.0.1]:10025): 250 2.0.0 Ok: queued as
0EE1840CA1)
2013-09-23T15:42:13.161720+02:00 serverName postfix/qmgr[19238]:
0EE1840CA1: from=<MAILMAN-bounces at listes.mydomain2.tld>, size=2645,
nrcpt=1 (queue active)
2013-09-23T15:42:13.195309+02:00 serverName postfix/qmgr[19238]:
631E241798: removed
2013-09-23T15:42:13.314512+02:00 serverName postfix/pipe[20678]:
0EE1840CA1: to=<CCCCCC at mydomain1.tld>, relay=dovecot, delay=0.27,
delays=0.12/0.03/0/0.12, dsn=2.0.0, status=sent (delivered via dovecot
service)
2013-09-23T15:42:13.370622+02:00 serverName postfix/qmgr[19238]:
0EE1840CA1: removed
/
What's wrong ?
Did I miss something ?
Thanks for the help.
--
Renaud Courvoisier
Responsable Informatique & Réseau ESAAIX
Rue Emile Tavan, 13100 Aix-en-Provence
More information about the Mailman-Users
mailing list