Mailcow-dockerized: SOGo inbox not show receive mail.

[pinkykitten]

Hi bro, many thanks for all your hard work on this project.

Describe the bug
I can send mail but can't receive email.
When I send mail from Gmail to [email protected], SOGo inbox is empty but Rspamd log can see the request. I have read articles that have similar problems but are not effective for me like (change MX record, the problem with port, exists postfix). Port telnet success:

25
80
110
143
443
465
587
993
995

How to reproduce Reproduce
Steps to reproduce the behavior please explain how to reproduce the bug:

1. Install mailcow-dockerized.
2. Add Domain
3. Add Mailbox
4. Send a test email from Mailcow to Gmail
5. Send a test email from Gmail to Mailcow

Expected behavior
The email from Gmail to Mailcow showing in SOGo inbox.

Screenshots

System

• OS: Ubuntu 16.04
• Browser: chrome
• Other clients involved:

[andryyy]

Hi, thanks. Cannot confirm this. :/

Please show postfix-mailcow and dovecot-mailcow logs for a time span you expected the mail to be delivered.

[pinkykitten]

thanks for your quick response, my logs:

dovecot-mailcow

dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:45:01 mail CRON[4512]: pam_unix(cron:session): session opened for user vmail by (uid=0)
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:45:01 mail CRON[4511]: pam_unix(cron:session): session opened for user root by (uid=0)
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:45:01 mail CRON[4514]: (vmail) CMD (/usr/local/bin/trim_logs.sh >> /dev/console 2>&1)
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:45:01 mail CRON[4516]: (root) CMD ( /usr/local/bin/imapsync_cron.pl)
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:45:01 mail CRON[4512]: pam_unix(cron:session): session closed for user vmail
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:45:01 mail CRON[4511]: pam_unix(cron:session): session closed for user root
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:46:01 mail CRON[4525]: pam_unix(cron:session): session opened for user root by (uid=0)
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:46:01 mail CRON[4526]: pam_unix(cron:session): session opened for user vmail by (uid=0)
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:46:01 mail CRON[4530]: (vmail) CMD (/usr/local/bin/trim_logs.sh >> /dev/console 2>&1)
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:46:01 mail CRON[4528]: (root) CMD ( /usr/local/bin/imapsync_cron.pl)
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:46:01 mail CRON[4526]: pam_unix(cron:session): session closed for user vmail
dovecot-mailcow_1_cdb8fa3219f2 | Nov 29 06:46:01 mail CRON[4525]: pam_unix(cron:session): session closed for user root

postfix-mailcow

postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:09 mail postfix/postscreen[597]: CONNECT from [209.85.217.68]:36662 to [172.22.1.8]:25
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:09 mail postfix/postscreen[597]: WHITELISTED [209.85.217.68]:36662
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:11 mail postfix/smtpd[599]: connect from mail-vs1-f68.google.com[209.85.217.68]
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:12 mail postfix/smtpd[599]: Anonymous TLS connection established from mail-vs1-f68.google.com[209.85.217.68]: TLSv1.2 with cipher ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:12 mail postfix/smtpd[599]: 9F583BE2D6: client=mail-vs1-f68.google.com[209.85.217.68]
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:13 mail postfix/cleanup[605]: 9F583BE2D6: message-id=<CAG4fAMUGTVpzhf=[e-mail]>
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:19 mail postfix/qmgr[343]: 9F583BE2D6: from=<{MY_GMAIL}@gmail.com>, size=6061, nrcpt=1 (queue active)
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:20 mail postfix/smtpd[599]: disconnect from mail-vs1-f68.google.com[209.85.217.68] ehlo=2 starttls=1 mail=1 rcpt=1 data=1 quit=1 commands=7
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/postscreen[597]: CONNECT from [172.22.1.1]:56546 to [172.22.
1.8]:25
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/postscreen[597]: WHITELISTED [172.22.1.1]:56546
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/smtpd[599]: connect from unknown[172.22.1.1]
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/smtp[606]: warning: host mail.{MY_DOMAIN}[{MY_SERVER_IP}]:25 greeted me with my own hostname mail.{MY_DOMAIN}
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/smtp[606]: warning: host mail.{MY_DOMAIN}[{MY_SERVER_IP}]:25 replied to HELO/EHLO with my own hostname mail.{MY_DOMAIN}
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/smtp[606]: 9F583BE2D6: to=<admin@{MY_DOMAIN}>, relay=mail.{MY_DOMAIN}[{MY_SERVER_IP}]:25, delay=9.6, delays=7.2/0.04/2.4/0, dsn=5.4.6, status=bounced (mail for {MY_DOMAIN} loops back to myself)
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/smtpd[599]: disconnect from unknown[172.22.1.1] ehlo=1 quit=1 commands=2
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/cleanup[605]: 464E5BE2D8: message-id=<20181129064522.464E5BE2D8@mail.{MY_DOMAIN}>
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/qmgr[343]: 464E5BE2D8: from=<>, size=9049, nrcpt=1 (queue active)
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/bounce[607]: 9F583BE2D6: sender non-delivery notification: 464E5BE2D8
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:22 mail postfix/qmgr[343]: 9F583BE2D6: removed
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:24 mail postfix/smtp[609]: Trusted TLS connection established to gmail-smtp-in.l.google.com[108.177.97.26]:25: TLSv1.2 with cipher ECDHE-RSA-CHACHA20-POLY1305 (256/256 bits)
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:25 mail postfix/smtp[609]: 464E5BE2D8: to=<{MY_GMAIL}@gmail.com>, relay=gmail-smtp-in.l.google.com[108.177.97.26]:25, delay=2.9, delays=0.01/0.03/2/0.82, dsn=5.7.1, status=bounced (host gmail-smtp-in.l.google.com[108.177.97.26] said: 550-5.7.1 Unauthenticated email from {MY_DOMAIN} is not accepted due to domain's 550-5.7.1 DMARC policy. Please contact the administrator of {MY_DOMAIN} domain if 550-5.7.1 this was a legitimate mail. Please visit 550-5.7.1  https://support.google.com/mail/answer/2451690 to learn about the 550 5.7.1 DMARC initiative. g187si1197523pfc.43 - gsmtp (in reply to end of DATA command))
postfix-mailcow_1_879bb5356b77 | Nov 29 06:45:25 mail postfix/qmgr[343]: 464E5BE2D8: removed

[andryyy]

You probably checked „backup mx“ settings like „relay domain“ in the domain settings.

[pinkykitten]

Yes, I checked both Relay domain & Relay all recipients.
I try to uncheck all option but problem not resolved.

[andryyy]

It may be cached. Need logs if it doesn't work.

[pinkykitten]

Great!!
You are right, clear cached and it works fine.
I'm very grateful.
The last question. What "Backup MX options" meaning and when use it?

[andryyy]

Noice. :o

It is for lower prio mx' that forward the mail to your primary mx when it is back online. When your only mx is marked as backup mx, it will try to forward to itself. That's why it logged mail for {MY_DOMAIN} loops back to myself.

[pinkykitten]

You're a lifesaver.