[bug][Pigeonhole 0.4.10] Missing msgid
Pigeonhole 0.4.10 doesn't log msgid for some messages.
Dec 16 09:57:57 mx dovecot: lmtp(user1@example.com): EbLlL2gLcVYCBgEAPZa6/Q: sieve: msgid=<20151216065756.BE1DF1FFD8@cp.bitrix24.com>: forwarded to <user3@example.com> Dec 16 09:57:57 mx dovecot: lmtp(user1@example.com): EbLlL2gLcVYCBgEAPZa6/Q: sieve: stored mail into mailbox 'INBOX' Dec 16 09:57:57 mx dovecot: lmtp(user2@example.com): FrLlL2gLcVYCBgEAPZa6/Q: sieve: msgid=<20151216065756.C77BB1FFD8@cp.bitrix24.com>: forwarded to <user3@example.com> Dec 16 09:57:57 mx dovecot: lmtp(user2@example.com): FrLlL2gLcVYCBgEAPZa6/Q: sieve: msgid=<20151216065756.C77BB1FFD8@cp.bitrix24.com>: stored mail into mailbox 'bitrix'
Op 12/16/2015 om 8:31 AM schreef Alexander Moisseev:
Pigeonhole 0.4.10 doesn't log msgid for some messages.
Dec 16 09:57:57 mx dovecot: lmtp(user1@example.com): EbLlL2gLcVYCBgEAPZa6/Q: sieve: msgid=<20151216065756.BE1DF1FFD8@cp.bitrix24.com>: forwarded to <user3@example.com> Dec 16 09:57:57 mx dovecot: lmtp(user1@example.com): EbLlL2gLcVYCBgEAPZa6/Q: sieve: stored mail into mailbox 'INBOX' Dec 16 09:57:57 mx dovecot: lmtp(user2@example.com): FrLlL2gLcVYCBgEAPZa6/Q: sieve: msgid=<20151216065756.C77BB1FFD8@cp.bitrix24.com>: forwarded to <user3@example.com> Dec 16 09:57:57 mx dovecot: lmtp(user2@example.com): FrLlL2gLcVYCBgEAPZa6/Q: sieve: msgid=<20151216065756.C77BB1FFD8@cp.bitrix24.com>: stored mail into mailbox 'bitrix'
That means that LTMP performed that delivery. That would normally only happen when an error occurs.
Do you see anything strange in the user log? Does system log show anything more when mail_debug=yes is active?
What is your configuration?
Regards,
Stephan.
Op 12/16/2015 om 10:32 AM schreef Stephan Bosch:
Op 12/16/2015 om 8:31 AM schreef Alexander Moisseev:
Pigeonhole 0.4.10 doesn't log msgid for some messages.
Dec 16 09:57:57 mx dovecot: lmtp(user1@example.com): EbLlL2gLcVYCBgEAPZa6/Q: sieve: msgid=<20151216065756.BE1DF1FFD8@cp.bitrix24.com>: forwarded to <user3@example.com> Dec 16 09:57:57 mx dovecot: lmtp(user1@example.com): EbLlL2gLcVYCBgEAPZa6/Q: sieve: stored mail into mailbox 'INBOX' Dec 16 09:57:57 mx dovecot: lmtp(user2@example.com): FrLlL2gLcVYCBgEAPZa6/Q: sieve: msgid=<20151216065756.C77BB1FFD8@cp.bitrix24.com>: forwarded to <user3@example.com> Dec 16 09:57:57 mx dovecot: lmtp(user2@example.com): FrLlL2gLcVYCBgEAPZa6/Q: sieve: msgid=<20151216065756.C77BB1FFD8@cp.bitrix24.com>: stored mail into mailbox 'bitrix' That means that LTMP performed that delivery. That would normally only happen when an error occurs.
Oh, but it does have a "sieve: " prefix... hmm.
Regards,
Stephan
On 16.12.15 12:32, Stephan Bosch wrote:
That means that LTMP performed that delivery. That would normally only happen when an error occurs.
No errors. All mail is delivering as expected.
Do you see anything strange in the user log? Does system log show anything more when mail_debug=yes is active?
There is nothing unusual in the log. Dec 16 12:43:29 mx dovecot: lmtp(72024): Connect from local Dec 16 12:43:29 mx dovecot: lmtp(user10@example.com): bD6dNzIycVZYGQEAPZa6/Q: sieve: stored mail into mailbox 'INBOX' Dec 16 12:43:29 mx postfix/lmtp[72023]: 7C9D836: to=<user10@example.com>, relay=mx.mezonplus.ru[private/dovecot-lmtp], delay=0.05, delays=0.02/0/0/0.02, dsn=2.0.0, status=sent (250 2.0.0 <user10@example.com> bD6dNzIycVZYGQEAPZa6/Q Saved) Dec 16 12:43:29 mx dovecot: lmtp(72024): Disconnect from local: Successful quit Dec 16 12:43:29 mx postfix/qmgr[70108]: 7C9D836: removed
What is your configuration? Attached.
Op 16-12-2015 om 11:00 schreef Alexander Moisseev:
What is your configuration? Attached.
I can't make much sense of it yet. It probably relates to this change:
http://hg.rename-it.nl/dovecot-2.2-pigeonhole/rev/d23225e408af
and the fact that you use a sieve_after script.
So, what do your sieve scripts look like? Could you provide an example of a sieve_before, sieve_after and a user sieve script (and perhaps an example message) that trigger this issue?
Regards,
Stephan.
Op 12/16/2015 om 11:00 AM schreef Alexander Moisseev:
On 16.12.15 12:32, Stephan Bosch wrote:
That means that LTMP performed that delivery. That would normally only happen when an error occurs.
No errors. All mail is delivering as expected.
Do you see anything strange in the user log? Does system log show anything more when mail_debug=yes is active?
There is nothing unusual in the log. Dec 16 12:43:29 mx dovecot: lmtp(72024): Connect from local Dec 16 12:43:29 mx dovecot: lmtp(user10@example.com): bD6dNzIycVZYGQEAPZa6/Q: sieve: stored mail into mailbox 'INBOX' Dec 16 12:43:29 mx postfix/lmtp[72023]: 7C9D836: to=<user10@example.com>, relay=mx.mezonplus.ru[private/dovecot-lmtp], delay=0.05, delays=0.02/0/0/0.02, dsn=2.0.0, status=sent (250 2.0.0 <user10@example.com> bD6dNzIycVZYGQEAPZa6/Q Saved) Dec 16 12:43:29 mx dovecot: lmtp(72024): Disconnect from local: Successful quit Dec 16 12:43:29 mx postfix/qmgr[70108]: 7C9D836: removed
What is your configuration? Attached.
I am quite confident that this fixes it:
http://hg.rename-it.nl/dovecot-2.2-pigeonhole/rev/37ddc42c007c
Regards,
Stephan.
On 22.12.15 2:06, Stephan Bosch wrote:
I am quite confident that this fixes it: http://hg.rename-it.nl/dovecot-2.2-pigeonhole/rev/37ddc42c007c
Regards, Stephan.
Yes, that change fixed the issue. Thanks!
participants (2)
-
Alexander Moisseev
-
Stephan Bosch