1 Topic by ajsekeris (edited by ajsekeris 2012-07-31 18:09:57)

  • ajsekeris
  • Member
  • Offline
  • Registered: 2012-07-09
  • Posts: 9

Topic: [RESOLVED] Unable to receive e-mail

==== Provide required information ====
- iRedMail version and backend (LDAP/MySQL/PGSQL): v0.1.8 (MySQL)
- Linux/BSD distribution name and version: OpenBSD 5.1 (GENERIC) #160: Sun Feb 12 09:46:33 MST 2012
- Any related log?
Jul 30 10:43:09 pluto postfix/smtpd[26839]: B41972618A: client=saturn[192.168.0.39], sasl_method=PLAIN, sasl_username=test@seker.com
Jul 30 10:43:09 pluto postfix/qmgr[6239]: B41972618A: from=<test@seker.com>, size=567, nrcpt=1 (queue active)
Jul 30 10:43:29 pluto postfix/qmgr[6239]: 98DB02619C: from=<test@seker.com>, size=1503, nrcpt=1 (queue active)
Jul 30 10:43:29 pluto amavis[1758]: (01758-02) Passed CLEAN {RelayedOutbound}, MYNETS/MYUSERS LOCAL [192.168.0.39]:51409 [192.168.0.39] <test@seker.com> -> <seker@gmail.com>, Queue-ID: B41972618A, Message-ID: <E9147B5B-3FFE-4F5F-BE72-55A804303612@seker.com>, mail_id: 6Ryj6A-8OYkr, Hits: -10, size: 567, queued_as: 98DB02619C, dkim_new=dkim:seker.com, 19904 ms
Jul 30 10:49:39 pluto smtpd[328]: 084e467d: from=<seker@gmail.com>, relay=mail-wi0-f169.google.com [209.85.212.169], stat=LocalError (530 5.0.0 Recipient rejected: test@seker.com)
Jul 30 11:00:07 pluto postfix/local[9009]: B234E261AC: to=<test@pluto.seker.com>, relay=local, delay=0.09, delays=0.01/0.01/0/0.07, dsn=4.3.0, status=deferred (temporary failure)
Jul 30 11:06:33 pluto postfix/local[10525]: B234E261AC: to=<test@pluto.seker.com>, relay=local, delay=385, delays=385/0.06/0/0.07, dsn=4.3.0, status=deferred (temporary failure)
Jul 30 11:16:32 pluto postfix/local[22778]: B234E261AC: to=<test@pluto.seker.com>, relay=local, delay=985, delays=984/0.06/0/0.07, dsn=4.3.0, status=deferred (temporary failure)
Jul 30 11:36:32 pluto postfix/local[13879]: B234E261AC: to=<test@pluto.seker.com>, relay=local, delay=2185, delays=2185/0.06/0/0.07, dsn=4.3.0, status=deferred (temporary failure)
Jul 30 12:16:33 pluto postfix/local[22314]: B234E261AC: to=<test@pluto.seker.com>, relay=local, delay=4585, delays=4585/0.07/0/0.07, dsn=4.3.0, status=deferred (temporary failure)
====

I've searched this forum, because my issue seems to simple to not have occurred elsewhere, but I am simply not able to figure it out unfortunately, so I need a little help. I am likely missing something obvious.

Outgoing mail works perfectly, but incoming mail is getting recipient rejected. The above log file extract (sudo grep test /var/log/maillog) shows both the outgoing message and the reply to it coming back and getting rejected.

Please point in the right direction for solving this if possible. Let me know if additional information or logs are needed to help me address this.

Thanks!

----

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: 30,770

Re: [RESOLVED] Unable to receive e-mail

ajsekeris wrote:

The above log file extract (sudo grep test /var/log/maillog) shows both the outgoing message and the reply to it coming back and getting rejected.

Please just paste the original log message, don't filter them.

Is there any related log in /var/log/sieve.log and /var/log/dovecot.log?

P.S. Glad to see another OpenBSD box. smile

3 Reply by ajsekeris

  • ajsekeris
  • Member
  • Offline
  • Registered: 2012-07-09
  • Posts: 9

Re: [RESOLVED] Unable to receive e-mail

ZhangHuangbin wrote:
ajsekeris wrote:

The above log file extract (sudo grep test /var/log/maillog) shows both the outgoing message and the reply to it coming back and getting rejected.

Please just paste the original log message, don't filter them.

Is there any related log in /var/log/sieve.log and /var/log/dovecot.log?

P.S. Glad to see another OpenBSD box. smile

I repeated the test so I could get a clean logs and not have to filter.

maillog:

Jul 30 20:21:58 pluto postfix/smtpd[13967]: connect from saturn[192.168.0.39]
Jul 30 20:21:59 pluto postfix/smtpd[13967]: 6FD0626188: client=saturn[192.168.0.39], sasl_method=PLAIN, sasl_username=anton@sekerict.com
Jul 30 20:21:59 pluto postfix/cleanup[29555]: 6FD0626188: message-id=<E18154F7-EB69-43D7-9625-70779AC11264@sekerict.com>
Jul 30 20:21:59 pluto postfix/qmgr[32252]: 6FD0626188: from=<anton@sekerict.com>, size=554, nrcpt=1 (queue active)
Jul 30 20:22:00 pluto postfix/smtpd[13042]: connect from pluto.sekerict.com[127.0.0.1]
Jul 30 20:22:00 pluto postfix/smtpd[13042]: 5D6C62618A: client=pluto.sekerict.com[127.0.0.1]
Jul 30 20:22:00 pluto postfix/cleanup[29555]: 5D6C62618A: message-id=<E18154F7-EB69-43D7-9625-70779AC11264@sekerict.com>
Jul 30 20:22:00 pluto postfix/smtpd[13042]: disconnect from pluto.sekerict.com[127.0.0.1]
Jul 30 20:22:00 pluto postfix/qmgr[32252]: 5D6C62618A: from=<anton@sekerict.com>, size=1490, nrcpt=1 (queue active)
Jul 30 20:22:00 pluto amavis[25202]: (25202-01) Passed CLEAN {RelayedOutbound}, MYNETS/MYUSERS LOCAL [192.168.0.39]:53923 [192.168.0.39] <anton@sekerict.com> -> <ajsekeris@gmail.com>, Queue-ID: 6FD0626188, Message-ID: <E18154F7-EB69-43D7-9625-70779AC11264@sekerict.com>, mail_id: a7DfE23pv_EW, Hits: -10, size: 554, queued_as: 5D6C62618A, dkim_new=dkim:sekerict.com, 994 ms
Jul 30 20:22:00 pluto postfix/smtp[14217]: 6FD0626188: to=<ajsekeris@gmail.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.6, delays=0.49/0.03/0.04/0.99, 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 5D6C62618A)
Jul 30 20:22:00 pluto postfix/qmgr[32252]: 6FD0626188: removed
Jul 30 20:22:01 pluto postfix/smtp[19783]: 5D6C62618A: to=<ajsekeris@gmail.com>, relay=gmail-smtp-in.l.google.com[173.194.67.27]:25, delay=0.79, delays=0.02/0.02/0.21/0.54, dsn=2.0.0, status=sent (250 2.0.0 OK 1343672521 o43si9348415wee.111)
Jul 30 20:22:01 pluto postfix/qmgr[32252]: 5D6C62618A: removed
Jul 30 20:22:59 pluto postfix/smtpd[13967]: disconnect from saturn[192.168.0.39]
Jul 30 20:23:16 pluto smtpd[7626]: 0cc26584: from=<ajsekeris@gmail.com>, relay=mail-wg0-f49.google.com [74.125.82.49], stat=LocalError (530 5.0.0 Recipient rejected: anton@sekerict.com)

dovecot:


Jul 30 20:18:00 auth-worker: Info: mysql(127.0.0.1): Connected to database vmail
Jul 30 20:18:00 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=192.168.0.39, lip=85.223.111.122, mpid=910, TLS
Jul 30 20:18:01 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=192.168.0.39, lip=85.223.111.122, mpid=17558, TLS
Jul 30 20:18:01 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=192.168.0.39, lip=85.223.111.122, mpid=16518, TLS
Jul 30 20:20:27 auth-worker: Info: mysql(127.0.0.1): Connected to database vmail
Jul 30 20:20:27 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=30921, secured
Jul 30 20:20:27 imap(anton@sekerict.com): Info: Disconnected: Logged out bytes=29/419
Jul 30 20:20:27 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=26992, secured
Jul 30 20:20:27 dict: Info: mysql(127.0.0.1): Connected to database vmail
Jul 30 20:20:27 imap(anton@sekerict.com): Info: Disconnected: Logged out bytes=70/677
Jul 30 20:20:28 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=24351, secured
Jul 30 20:20:28 imap(anton@sekerict.com): Info: Disconnected: Logged out bytes=281/994
Jul 30 20:20:28 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=28451, secured
Jul 30 20:20:28 imap(anton@sekerict.com): Info: Disconnected: Logged out bytes=50/410
Jul 30 20:20:30 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=27931, secured
Jul 30 20:20:30 imap(anton@sekerict.com): Info: Disconnected: Logged out bytes=32/390
Jul 30 20:20:31 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=18553, secured
Jul 30 20:20:31 imap(anton@sekerict.com): Info: Disconnected: Logged out bytes=44/579
Jul 30 20:20:52 imap-login: Info: Login: user=<anton@sekerict.com>, method=PLAIN, rip=127.0.0.1, lip=127.0.0.1, mpid=14110, secured
Jul 30 20:20:52 imap(anton@sekerict.com): Info: Disconnected: Logged out bytes=12/342
Jul 30 20:21:58 auth-worker: Info: mysql(127.0.0.1): Connected to database vmail
Jul 30 20:21:59 dict: Info: mysql(127.0.0.1): Connected to database vmail

Strangely, no sieve.log :-S

I noticed something else, outgoing mail works from my mac using imap to my openBSD, outgoing mail does not work from roundcubemail. It says SMTP Error (250): Authentication failed. This seems to be related to the following log entry:

Jul 30 20:20:52 pluto roundcube: SMTP server does not support authentication ():
Jul 30 20:20:52 pluto roundcube: SMTP Error: SMTP error: Authentication failure: SMTP server does not support authentication (Code: ) in /var/www/roundcubemail/program/include/main.inc on line 1745 (POST /mail/?_unlock=loading1343672451629&_lang=undefined?_task=mail&_action=send)

I don't use webmail much, so not important for me, but it may be indicative in light of the other issue, so I thought I'd mention it.

4 Reply by ajsekeris

  • ajsekeris
  • Member
  • Offline
  • Registered: 2012-07-09
  • Posts: 9

Re: [RESOLVED] Unable to receive e-mail

Now I have a sieve.log as well

Jul 30 21:00:07 lda(anton): Fatal: setgid(1001(vmail) from mail_gid setting) failed with euid=1000(anton), gid=1000(anton), egid=1000(anton): Operation not permitted (This binary should probably be called with process group set to 1001(vmail) instead of 1000(anton))

This I also see mentioned elsewhere on the forum.

I added anton to group vmail using usermod -g vmail anton. This did not help though. I do note that sieve only logs this error a while after I see the recipient rejected in maillog. So possibly a secondary issue, not sure.

5 Reply by ZhangHuangbin

  • ZhangHuangbin
  • ZhangHuangbin
  • iRedMail Developers
  • Offline
  • Registered: 2009-05-06
  • Posts: 30,770

Re: [RESOLVED] Unable to receive e-mail

ajsekeris wrote:

Jul 30 21:00:07 lda(anton): Fatal: setgid(1001(vmail) from mail_gid setting) failed with euid=1000(anton), gid=1000(anton), egid=1000(anton): Operation not permitted (This binary should probably be called with process group set to 1001(vmail) instead of 1000(anton))

This is another issue not related to the one you mentioned in your first forum post. This can be solved by add an alias address in /etc/postfix/aliases for your system account "anton". For example:

- Add below line in /etc/postfix/aliases. Replace user@domain.ltd by a real email address so that you can receive the email.

anton: user@domain.ltd

- Execute postalias command to update alias db. Postfix will detect this change without reload/restart.

# postalias /etc/postfix/aliases

The issue in your first post is still not clear, please send one more testing email and check /var/log/sieve.log.

6 Reply by ajsekeris

  • ajsekeris
  • Member
  • Offline
  • Registered: 2012-07-09
  • Posts: 9

Re: [RESOLVED] Unable to receive e-mail

Ah right, I'd put in an alias for mail, but it's an alias for anton it needed. Silly me.

Sent another test e-mail. Sieve now looks like this:

Jul 31 09:31:42 lda(anton@sekerict.com): Info: msgid=<20120730090006.9AB662619C@pluto.sekerict.com>: saved mail to INBOX
Jul 31 09:31:42 lda(anton@sekerict.com): Info: msgid=<20120730190007.0F5A52618A@pluto.sekerict.com>: saved mail to INBOX
Jul 31 09:31:42 lda(anton@sekerict.com): Info: msgid=<20120730180006.A26492618A@pluto.sekerict.com>: saved mail to INBOX

These are however not the e-mail that is incoming from external, they seem to be related to the cron daemon mailing me these three messages:

1:
from: Cron Daemon <root@pluto.sekerict.com>
to: root@pluto.sekerict.com
subject: Cron <root@pluto> bash /var/vmail/backup/backup_mysql.sh

/bin/sh: bash: not found

2:
from: Cron Daemon <root@pluto.sekerict.com>
to: root@pluto.sekerict.com
subject: Cron <root@pluto> /usr/bin/newsyslog

iredapd(ok)
iredapd(ok)

3:
from: Cron Daemon <root@pluto.sekerict.com>
to: root@pluto.sekerict.com
subject: Cron <root@pluto> /usr/bin/newsyslog

/usr/local/bin/mysqladmin: connect to server at 'localhost' failed
error: 'Access denied for user 'root'@'localhost' (using password: NO)'

So still nothing relevant in sieve.log I think.

maillog:

Jul 31 09:21:16 pluto postfix/smtpd[26697]: connect from saturn[192.168.0.39]
Jul 31 09:21:16 pluto postfix/smtpd[4648]: connect from saturn[192.168.0.39]
Jul 31 09:21:16 pluto postfix/smtpd[26697]: disconnect from saturn[192.168.0.39]
Jul 31 09:21:17 pluto postfix/smtpd[4648]: disconnect from saturn[192.168.0.39]
Jul 31 09:23:21 pluto postfix/smtpd[17787]: connect from saturn[192.168.0.39]
Jul 31 09:23:22 pluto postfix/smtpd[17787]: 89DF52618F: client=saturn[192.168.0.39], sasl_method=PLAIN, sasl_username=anton@sekerict.com
Jul 31 09:23:22 pluto postfix/cleanup[2521]: 89DF52618F: message-id=<23C5F4F0-4FE7-4A0D-BCFC-0A9D5DE515D3@sekerict.com>
Jul 31 09:23:22 pluto postfix/qmgr[32252]: 89DF52618F: from=<anton@sekerict.com>, size=556, nrcpt=1 (queue active)
Jul 31 09:23:23 pluto postfix/smtpd[22675]: connect from pluto.sekerict.com[127.0.0.1]
Jul 31 09:23:23 pluto postfix/smtpd[22675]: 6500226190: client=pluto.sekerict.com[127.0.0.1]
Jul 31 09:23:23 pluto postfix/cleanup[2521]: 6500226190: message-id=<23C5F4F0-4FE7-4A0D-BCFC-0A9D5DE515D3@sekerict.com>
Jul 31 09:23:23 pluto postfix/smtpd[22675]: disconnect from pluto.sekerict.com[127.0.0.1]
Jul 31 09:23:23 pluto postfix/qmgr[32252]: 6500226190: from=<anton@sekerict.com>, size=1492, nrcpt=1 (queue active)
Jul 31 09:23:23 pluto amavis[25202]: (25202-10) Passed CLEAN {RelayedOutbound}, MYNETS/MYUSERS LOCAL [192.168.0.39]:56756 [192.168.0.39] <anton@sekerict.com> -> <ajsekeris@gmail.com>, Queue-ID: 89DF52618F, Message-ID: <23C5F4F0-4FE7-4A0D-BCFC-0A9D5DE515D3@sekerict.com>, mail_id: eS6u7Sn6cBB9, Hits: -10, size: 556, queued_as: 6500226190, dkim_new=dkim:sekerict.com, 843 ms
Jul 31 09:23:23 pluto postfix/smtp[14297]: 89DF52618F: to=<ajsekeris@gmail.com>, relay=127.0.0.1[127.0.0.1]:10024, delay=1.3, delays=0.42/0.04/0.02/0.85, 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 6500226190)
Jul 31 09:23:23 pluto postfix/qmgr[32252]: 89DF52618F: removed
Jul 31 09:23:24 pluto postfix/smtp[18525]: 6500226190: to=<ajsekeris@gmail.com>, relay=gmail-smtp-in.l.google.com[173.194.67.27]:25, delay=0.88, delays=0.02/0.02/0.2/0.63, dsn=2.0.0, status=sent (250 2.0.0 OK 1343719404 o59si143984wee.81)
Jul 31 09:23:24 pluto postfix/qmgr[32252]: 6500226190: removed
Jul 31 09:23:37 pluto smtpd[7626]: 317fbe34: from=<ajsekeris@gmail.com>, relay=mail-wi0-f169.google.com [209.85.212.169], stat=LocalError (530 5.0.0 Recipient rejected: anton@sekerict.com)
Jul 31 09:24:22 pluto postfix/smtpd[17787]: disconnect from saturn[192.168.0.39]
Jul 31 09:27:42 pluto postfix/anvil[380]: statistics: max connection rate 2/60s for (submission:192.168.0.39) at Jul 31 09:21:16
Jul 31 09:27:42 pluto postfix/anvil[380]: statistics: max connection count 2 for (submission:192.168.0.39) at Jul 31 09:21:16
Jul 31 09:27:42 pluto postfix/anvil[380]: statistics: max cache size 1 at Jul 31 09:21:16
Jul 31 09:31:16 pluto postfix/smtpd[27141]: connect from saturn[192.168.0.39]
Jul 31 09:31:16 pluto postfix/smtpd[11743]: connect from saturn[192.168.0.39]
Jul 31 09:31:17 pluto postfix/smtpd[27141]: disconnect from saturn[192.168.0.39]
Jul 31 09:31:17 pluto postfix/smtpd[11743]: disconnect from saturn[192.168.0.39]
Jul 31 09:31:42 pluto postfix/qmgr[32252]: 7BB582618D: from=<root@pluto.sekerict.com>, size=1282, nrcpt=1 (queue active)
Jul 31 09:31:42 pluto postfix/qmgr[32252]: CFF7926197: from=<root@pluto.sekerict.com>, size=1282, nrcpt=1 (queue active)
Jul 31 09:31:42 pluto postfix/qmgr[32252]: B234E261AC: from=<root@pluto.sekerict.com>, size=1282, nrcpt=1 (queue active)
Jul 31 09:31:42 pluto postfix/cleanup[31352]: 4934B26159: message-id=<20120730180006.A26492618A@pluto.sekerict.com>
Jul 31 09:31:42 pluto postfix/qmgr[32252]: 4934B26159: from=<root@pluto.sekerict.com>, size=1421, nrcpt=1 (queue active)
Jul 31 09:31:42 pluto postfix/local[14129]: 7BB582618D: to=<anton@pluto.sekerict.com>, relay=local, delay=48695, delays=48695/0.07/0/0.09, dsn=2.0.0, status=sent (forwarded as 4934B26159)
Jul 31 09:31:42 pluto postfix/cleanup[31352]: 50A5A26181: message-id=<20120730190007.0F5A52618A@pluto.sekerict.com>
Jul 31 09:31:42 pluto postfix/local[17092]: CFF7926197: to=<anton@pluto.sekerict.com>, relay=local, delay=45094, delays=45094/0.03/0/0.1, dsn=2.0.0, status=sent (forwarded as 50A5A26181)
Jul 31 09:31:42 pluto postfix/qmgr[32252]: 7BB582618D: removed
Jul 31 09:31:42 pluto postfix/qmgr[32252]: CFF7926197: removed
Jul 31 09:31:42 pluto postfix/qmgr[32252]: 50A5A26181: from=<root@pluto.sekerict.com>, size=1421, nrcpt=1 (queue active)
Jul 31 09:31:42 pluto postfix/cleanup[10152]: 5ABE226185: message-id=<20120730090006.9AB662619C@pluto.sekerict.com>
Jul 31 09:31:42 pluto postfix/local[14129]: B234E261AC: to=<anton@pluto.sekerict.com>, relay=local, delay=81095, delays=81094/0.14/0/0.11, dsn=2.0.0, status=sent (forwarded as 5ABE226185)
Jul 31 09:31:42 pluto postfix/qmgr[32252]: 5ABE226185: from=<root@pluto.sekerict.com>, size=1421, nrcpt=1 (queue active)
Jul 31 09:31:42 pluto postfix/qmgr[32252]: B234E261AC: removed
Jul 31 09:31:42 pluto postfix/pipe[14277]: 5ABE226185: to=<anton@sekerict.com>, relay=dovecot, delay=0.28, delays=0.1/0.01/0/0.16, dsn=2.0.0, status=sent (delivered via dovecot service)
Jul 31 09:31:42 pluto postfix/qmgr[32252]: 5ABE226185: removed
Jul 31 09:31:42 pluto postfix/pipe[32057]: 50A5A26181: to=<anton@sekerict.com>, relay=dovecot, delay=0.33, delays=0.02/0.06/0/0.24, dsn=2.0.0, status=sent (delivered via dovecot service)
Jul 31 09:31:42 pluto postfix/qmgr[32252]: 50A5A26181: removed
Jul 31 09:31:42 pluto postfix/pipe[14678]: 4934B26159: to=<anton@sekerict.com>, relay=dovecot, delay=0.48, delays=0.03/0.03/0/0.42, dsn=2.0.0, status=sent (delivered via dovecot service)
Jul 31 09:31:42 pluto postfix/qmgr[32252]: 4934B26159: removed
Jul 31 09:34:37 pluto postfix/anvil[22358]: statistics: max connection rate 2/60s for (submission:192.168.0.39) at Jul 31 09:31:16
Jul 31 09:34:37 pluto postfix/anvil[22358]: statistics: max connection count 2 for (submission:192.168.0.39) at Jul 31 09:31:16
Jul 31 09:34:37 pluto postfix/anvil[22358]: statistics: max cache size 1 at Jul 31 09:31:16
Jul 31 09:41:16 pluto postfix/smtpd[15602]: connect from saturn[192.168.0.39]
Jul 31 09:41:16 pluto postfix/smtpd[4512]: connect from saturn[192.168.0.39]
Jul 31 09:41:16 pluto postfix/smtpd[15602]: disconnect from saturn[192.168.0.39]
Jul 31 09:41:17 pluto postfix/smtpd[4512]: disconnect from saturn[192.168.0.39]
Jul 31 09:44:37 pluto postfix/anvil[4272]: statistics: max connection rate 2/60s for (submission:192.168.0.39) at Jul 31 09:41:16
Jul 31 09:44:37 pluto postfix/anvil[4272]: statistics: max connection count 2 for (submission:192.168.0.39) at Jul 31 09:41:16
Jul 31 09:44:37 pluto postfix/anvil[4272]: statistics: max cache size 1 at Jul 31 09:41:16

dovecot.log

Jul 31 09:00:08 dict: Info: mysql(127.0.0.1): Connected to database vmail
Jul 31 09:11:17 auth-worker: Info: mysql(127.0.0.1): Connected to database vmail
Jul 31 09:21:16 auth-worker: Info: mysql(127.0.0.1): Connected to database vmail
Jul 31 09:23:22 dict: Info: mysql(127.0.0.1): Connected to database vmail
Jul 31 09:31:16 auth-worker: Info: mysql(127.0.0.1): Connected to database vmail
Jul 31 09:31:42 dict: Info: mysql(127.0.0.1): Connected to database vmail
Jul 31 09:31:42 dict: Info: mysql(127.0.0.1): Connected to database vmail
Jul 31 09:41:17 auth-worker: Info: mysql(127.0.0.1): Connected to database vmail

In the meantime I'm reading up on Postfix/Dovecot to gain more understanding myself. But it is complex for me.

bash lives in /usr/local/bin and was installed on my box for iredmail specifically.

7 Reply by ajsekeris

  • ajsekeris
  • Member
  • Offline
  • Registered: 2012-07-09
  • Posts: 9

Re: [RESOLVED] Unable to receive e-mail

Finally, I figured it out. And ofcourse (but I was expecting that from the start) the mistake is all mine. It was actually looking at the maillog again that I suddenly saw the light. It says that smtpd is rejecting the recipient. What is smtpd doing there? It should be postfix/smtpd!

So what was going on was that a partially configured other smtpd instance was snatching the messages away in front of postfix. That's also why nothing ever ended up in sieve.log. I probably play around with smptd when it was made an integral part of OpenBSD recently and forgot all about it.

Thanks for all your help ZhangHuangbin! And thanks for this excellent product as well, because it does take a lot of the headache of installing all these separate tools away.

8 Reply by ajsekeris

  • ajsekeris
  • Member
  • Offline
  • Registered: 2012-07-09
  • Posts: 9

Re: [RESOLVED] Unable to receive e-mail

Oh and thanks for you guys supporting OpenBSD. I love it to bits, but not many developers tend to support it well ;-)

9 Reply by ZhangHuangbin

  • ZhangHuangbin
  • ZhangHuangbin
  • iRedMail Developers
  • Offline
  • Registered: 2009-05-06
  • Posts: 30,770

Re: [RESOLVED] Unable to receive e-mail

ajsekeris wrote:

Oh and thanks for you guys supporting OpenBSD. I love it to bits, but not many developers tend to support it well ;-)

OpenBSD is my favourite OS. And, please help spread iRedMail. smile

10 Reply by ajsekeris

  • ajsekeris
  • Member
  • Offline
  • Registered: 2012-07-09
  • Posts: 9

Re: [RESOLVED] Unable to receive e-mail

ZhangHuangbin wrote:
ajsekeris wrote:

Oh and thanks for you guys supporting OpenBSD. I love it to bits, but not many developers tend to support it well ;-)

OpenBSD is my favourite OS. And, please help spread iRedMail. smile

Will do! Although being a one-man company it won't have huge impact :-)