1 Topic by my.digital.hobbies

  • my.digital.hobbies
  • Member
  • Offline
  • Registered: 2022-02-03
  • Posts: 9

Topic: Problems receiving an email from other local postfix sending server

==== REQUIRED BASIC INFO OF YOUR IREDMAIL SERVER ====
- iRedMail version (check /etc/iredmail-release): 1.5.1 MARIADB edition.
- Deployed with iRedMail Easy or the downloadable installer? yes
- Linux/BSD distribution name and version: CENTOS STREAM 8
- Store mail accounts in which backend (LDAP/MySQL/PGSQL):  MySQL
- Web server (Apache or Nginx): Nginx
- Manage mail accounts with iRedAdmin-Pro? No
- [IMPORTANT] Related original log or error message is required if you're experiencing an issue.

Both platforms work fine. Iredmail works as designed and all users can sent and receive emails from around the world. A second local machine (Freebpx) can sent emails to the world, but not to an email domain hosted locally.

Find attached the log. Although I'm not an email expert, the sending log seems to tell me that everything was successfully sent. Iredmail logs seems to reject the same email, but not reason why exactly.

Sending system /var/log/maillog

Mar 15 18:36:53 FREEPBX_ postfix/cleanup[21758]: B4647606B684: message-id=<20220315173653.B4647606B684@FREEPBX_.localdomain>
Mar 15 18:36:53 FREEPBX_ postfix/qmgr[20930]: B4647606B684: from=<asterisk@FREEPBX_.localdomain>, size=484, nrcpt=1 (queue active)
Mar 15 18:36:54 FREEPBX_ postfix/smtp[21760]: B4647606B684: to=<voicemail@mydomain.com>, relay=relay.host2[aa.bb.cc.dd]:25, delay=0.4, delays=0.04/0.03/0.17/0.16, dsn=2.0.0, status=sent (250 Ok: queued as 101B829C006B)
Mar 15 18:36:54 FREEPBX_ postfix/qmgr[20930]: B4647606B684: removed
Mar 15 18:38:27 FREEPBX_ postfix/pickup[20929]: BB183606B684: uid=995 from=<asterisk>
Mar 15 18:38:27 FREEPBX_ postfix/cleanup[21758]: BB183606B684: message-id=<20220315173827.BB183606B684@FREEPBX_.localdomain>
Mar 15 18:38:27 FREEPBX_ postfix/qmgr[20930]: BB183606B684: from=<asterisk@FREEPBX_.localdomain>, size=475, nrcpt=1 (queue active)
Mar 15 18:38:28 FREEPBX_ postfix/smtp[21760]: BB183606B684: to=<myprivate@mail.com>, relay=relay.host2[aa.bb.cc.dd]:25, delay=0.3, delays=0.01/0/0.12/0.17, dsn=2.0.0, status=sent (250 Ok: queued as F2ECA1820067)
Mar 15 18:38:28 FREEPBX_ postfix/qmgr[20930]: BB183606B684: removed

Iredmail receiving system /var/log/maillog

Mar 15 18:36:05 IredMail postfix/anvil[708006]: statistics: max connection rate 2/60s for (smtpd:yy.zz.xx.kk) at Mar 15 18:29:49
Mar 15 18:36:05 IredMail postfix/anvil[708006]: statistics: max connection count 1 for (smtpd:212.71.1.221) at Mar 15 18:26:05
Mar 15 18:36:05 IredMail postfix/anvil[708006]: statistics: max cache size 2 at Mar 15 18:26:32
Mar 15 18:36:54 IredMail postfix/postscreen[708616]: CONNECT from [yy.zz.xx.kk]:52548 to [192.168.1.198]:25
Mar 15 18:36:54 IredMail postfix/postscreen[708616]: PASS OLD [yy.zz.xx.kk]:52548
Mar 15 18:36:54 IredMail postfix/smtpd[708619]: connect from relay-host[yy.zz.xx.kk]
Mar 15 18:36:54 IredMail postfix/smtpd[708619]: warning: connect to Milter service inet:127.0.0.1:8891: Connection refused
Mar 15 18:36:54 IredMail postfix/smtpd[708619]: discarding EHLO keywords: CHUNKING
Mar 15 18:36:54 IredMail postfix/smtpd[708619]: Anonymous TLS connection established from relay-host[yy.zz.xx.kk]: TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits) key-exchange X25519 server-signature RSA-PSS (2048 bits)
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: discarding EHLO keywords: CHUNKING
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: NOQUEUE: reject: RCPT from relay-host[yy.zz.xx.kk]: 554 5.7.1 <voicemail@mydomain.com>: Recipient address rejected: SMTP AUTH is required for users under this sender domain; from=<no-reply@mydomain.com> to=<voicemail@mydomain.com> proto=ESMTP helo=<relay-host>
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: disconnect from relay-host[yy.zz.xx.kk] ehlo=2 starttls=1 mail=1 rcpt=0/1 data=0/1 rset=1 quit=1 commands=6/8
Mar 15 18:36:55 IredMail postfix/postscreen[708616]: CONNECT from [yy.zz.xx.kk]:52562 to [192.168.1.198]:25
Mar 15 18:36:55 IredMail postfix/postscreen[708616]: PASS OLD [yy.zz.xx.kk]:52562
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: connect from relay-host[yy.zz.xx.kk]
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: warning: connect to Milter service inet:127.0.0.1:8891: Connection refused
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: discarding EHLO keywords: CHUNKING
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: Anonymous TLS connection established from relay-host[yy.zz.xx.kk]: TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits) key-exchange X25519 server-signature RSA-PSS (2048 bits)
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: discarding EHLO keywords: CHUNKING
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: 4KJ0vq42SXzB28nB: client=relay-host[yy.zz.xx.kk]
Mar 15 18:36:55 IredMail postfix/cleanup[708629]: 4KJ0vq42SXzB28nB: message-id=<20220315173655.3FE4A2BF5680@relay-host>
Mar 15 18:36:55 IredMail opendmarc[841]: 4KJ0vq42SXzB28nB: SPF(helo): relay-host none
Mar 15 18:36:55 IredMail opendmarc[841]: 4KJ0vq42SXzB28nB: LOCALHOST none
Mar 15 18:36:55 IredMail postfix/qmgr[16056]: 4KJ0vq42SXzB28nB: from=<>, size=4184, nrcpt=1 (queue active)
Mar 15 18:36:55 IredMail postfix/smtpd[708619]: disconnect from relay-host[yy.zz.xx.kk] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7
Mar 15 18:36:55 IredMail clamd[823]: SelfCheck: Database status OK.
Mar 15 18:36:57 IredMail postfix/10025/smtpd[708634]: connect from localhost[127.0.0.1]
Mar 15 18:36:57 IredMail postfix/10025/smtpd[708634]: warning: connect to Milter service inet:127.0.0.1:8891: Connection refused
Mar 15 18:36:57 IredMail opendmarc[841]: ignoring connection from localhost
Mar 15 18:36:57 IredMail postfix/10025/smtpd[708634]: discarding EHLO keywords: CHUNKING
Mar 15 18:36:57 IredMail postfix/10025/smtpd[708634]: 4KJ0vs44DfzB28nD: client=localhost[127.0.0.1]
Mar 15 18:36:57 IredMail postfix/cleanup[708629]: 4KJ0vs44DfzB28nD: message-id=<20220315173655.3FE4A2BF5680@relay-host>
Mar 15 18:36:57 IredMail postfix/10025/smtpd[708634]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5
Mar 15 18:36:57 IredMail postfix/qmgr[16056]: 4KJ0vs44DfzB28nD: from=<>, size=5198, nrcpt=1 (queue active)
Mar 15 18:36:57 IredMail amavis[1844]: (01844-09) Passed CLEAN {RelayedInbound}, [yy.zz.xx.kk]:52562 [yy.zz.xx.kk] ESMTP/ESMTP <> -> <no-reply@mydomain.com>, (ESMTPS://[yy.zz.xx.kk]:52562), Queue-ID: 4KJ0vq42SXzB28nB, Message-ID: <20220315173655.3FE4A2BF5680@relay-host>, mail_id: EkPLNjYM9GTQ, b: sKbisf8RZ, Hits: 3.55, size: 4375, queued_as: 4KJ0vs44DfzB28nD, Subject: "Undelivered Mail Returned to Sender", From: <MAILER-DAEMON@localhost>, helo=relay-host, Tests: [MIME_HEADER_CTYPE_ONLY=0.1,RAZOR2_CF_RANGE_51_100=2.43,RAZOR2_CHECK=1.729,RCVD_IN_DNSWL_LOW=-0.7,SPF_HELO_NONE=0.001,T_SCC_BODY_TEXT_LINE=-0.01], autolearn=no autolearn_force=no, autolearnscore=3.55, 1891 ms
Mar 15 18:36:57 IredMail amavis[1844]: (01844-09) Passed CLEAN, <> -> <no-reply@mydomain.com>, Hits: 3.55, tag=2, tag2=6.2, kill=6.9, queued_as: 4KJ0vs44DfzB28nD, L/Y/0/0
Mar 15 18:36:57 IredMail postfix/amavis/smtp[708632]: 4KJ0vq42SXzB28nB: to=<no-reply@mydomain.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=2.2, delays=0.22/0.03/0/1.9, dsn=2.0.0, status=sent (250 2.0.0 from MTA(smtp:[127.0.0.1]:10025): 250 2.0.0 Ok: queued as 4KJ0vs44DfzB28nD)
Mar 15 18:36:57 IredMail postfix/qmgr[16056]: 4KJ0vq42SXzB28nB: removed
Mar 15 18:36:57 IredMail postfix/pipe[708636]: 4KJ0vs44DfzB28nD: to=<no-reply@mydomain.com>, relay=dovecot, delay=0.13, delays=0.02/0.03/0/0.08, dsn=2.0.0, status=sent (delivered via dovecot service)
Mar 15 18:36:57 IredMail postfix/qmgr[16056]: 4KJ0vs44DfzB28nD: removed
Mar 15 18:38:19 IredMail postfix/postscreen[708616]: CONNECT from [5.34.204.147]:50227 to [192.168.1.198]:25
Mar 15 18:38:19 IredMail postfix/dnsblog[708618]: addr 5.34.204.147 listed by domain zen.spamhaus.org as 127.0.0.11
Mar 15 18:38:19 IredMail postfix/dnsblog[708618]: addr 5.34.204.147 listed by domain zen.spamhaus.org as 127.0.0.4
Mar 15 18:38:19 IredMail postfix/postscreen[708616]: PREGREET 11 after 0.07 from [5.34.204.147]:50227: EHLO User\r\n
Mar 15 18:38:19 IredMail postfix/postscreen[708616]: DISCONNECT [5.34.204.147]:50227
Mar 15 18:40:15 IredMail postfix/anvil[708621]: statistics: max connection rate 2/60s for (smtpd:yy.zz.xx.kk) at Mar 15 18:36:55
Mar 15 18:40:15 IredMail postfix/anvil[708621]: statistics: max connection count 1 for (smtpd:yy.zz.xx.kk) at Mar 15 18:36:54
Mar 15 18:40:15 IredMail postfix/anvil[708621]: statistics: max cache size 1 at Mar 15 18:36:54

Post's attachments

situation.png
situation.png 45.23 kb, file has never been downloaded. 

You don't have the permssions to download the attachments of this post.

----

Spider Email Archiver: On-Premises, lightweight email archiving software developed by iRedMail team. Supports Amazon S3 compatible storage and custom branding.

2 Reply by ZhangHuangbin

  • ZhangHuangbin
  • ZhangHuangbin
  • iRedMail Developers
  • Offline
  • Registered: 2009-05-06
  • Posts: 31,082

Re: Problems receiving an email from other local postfix sending server

my.digital.hobbies wrote:

Mar 15 18:36:54 IredMail postfix/smtpd[708619]: warning: connect to Milter service inet:127.0.0.1:8891: Connection refused

Your milter service (which is supposed to be listening on port 8891) is not running.

3 Reply by my.digital.hobbies

  • my.digital.hobbies
  • Member
  • Offline
  • Registered: 2022-02-03
  • Posts: 9

Re: Problems receiving an email from other local postfix sending server

ZhangHuangbin wrote:
my.digital.hobbies wrote:

Mar 15 18:36:54 IredMail postfix/smtpd[708619]: warning: connect to Milter service inet:127.0.0.1:8891: Connection refused

Your milter service (which is supposed to be listening on port 8891) is not running.

I used your remark as a starting point and found out that I did not install Milter. Did that and the error was indeed gone but not the problem of receiving. The maillog came with the following log

Postfix error 554: Recipient address rejected: SMTP AUTH is required for users under this sender domain;

I was sending with an email-address like no-reply@xyz.tld to the receiving addres mail@xyz.tld.
Changing this in /etc/postfix/generic so I would sent no-reply@domain.com and

postmap /etc/postfix/generic
service postfix restart

Did the trick. It is now sending emails to the other system.


Still have to look into my Spam protection settings.