[Dovecot] Possible Bug segnalation
Hi to all,
Today i have manually copied at least 250 mail from a mailbox to another and i have encountered some problems with dovecot. When finished to download all the messages, via pop3, at the next check mail dovecot give me that error:
dovecot: Jan 15 10:59:55 Info: POP3(michele@domain.net): Mailbox init failed top=0/0, retr=0/0, del=0/29, size=932800
Then, the messages from the pop server was deleted, to the client an error was given but no mail downloaded.
I have resolved that deleting all the dovecot files into the mailbox, so:
dovecot-uidlist dovecot.index dovecot.index.cache dovecot.index.log
Then, all restarted to works normally, but...the most bad thing is... the lost mails!
I use OpenSuSE 11 with dovecot11-1.1.3-5.1 with postfix and virtual users on mysql.
Here is my dovecot -n:
# 1.1.3: /etc/dovecot/dovecot.conf log_path: /var/log/dovecot-err.log info_log_path: /var/log/dovecot-inf.log protocols: imap imaps pop3 pop3s disable_plaintext_auth: no login_dir: /var/run/dovecot/login login_executable(default): /usr/lib/dovecot/imap-login login_executable(imap): /usr/lib/dovecot/imap-login login_executable(pop3): /usr/lib/dovecot/pop3-login first_valid_uid: 51 last_valid_uid: 51 first_valid_gid: 51 last_valid_gid: 51 mail_location: maildir:/var/mail/virtual/%d/%u mail_debug: yes mail_executable(default): /usr/lib/dovecot/imap mail_executable(imap): /usr/lib/dovecot/imap mail_executable(pop3): /usr/lib/dovecot/pop3 mail_plugins(default): quota imap_quota mail_plugins(imap): quota imap_quota mail_plugins(pop3): quota mail_plugin_dir(default): /usr/lib/dovecot/modules/imap mail_plugin_dir(imap): /usr/lib/dovecot/modules/imap mail_plugin_dir(pop3): /usr/lib/dovecot/modules/pop3 imap_client_workarounds(default): outlook-idle imap_client_workarounds(imap): outlook-idle imap_client_workarounds(pop3): pop3_uidl_format(default): %08Xu%08Xv pop3_uidl_format(imap): %08Xu%08Xv pop3_uidl_format(pop3): %Mf auth default: passdb: driver: sql args: /etc/dovecot/dovecot-mysql.conf userdb: driver: passwd userdb: driver: sql args: /etc/dovecot/dovecot-mysql.conf socket: type: listen master: path: /var/run/dovecot/auth-master mode: 384 plugin: quota: maildir quota: maildir:user quota quota_warning: storage=80%% /usr/bin/quota_warning.sh 80 quota_warning2: storage=90%% /usr/bin/quota_warning.sh 90 quota_warning3: storage=99%% /usr/bin/quota_warning.sh 90
Anyone have some similar experience to mine?
Cordially,
Claudio Prono.
--
Claudio Prono Systems Development @ PSS Srl, Divisione Implementazione Sistemi Via San Bernardino, 17 - 10137 Torino (TO) - IT Tel +39-011.32.72.100 Fax +39-011.32.46.497 PGP Fingerprint: 75C2 4049 E23D 2FBF A65F 40DB EA5C 11AC C2B0 3647 Disclaimer: http://atpss.net/disclaimer
On Thu, 2009-01-15 at 11:08 +0100, Claudio Prono wrote:
Today i have manually copied at least 250 mail from a mailbox to another and i have encountered some problems with dovecot. When finished to download all the messages, via pop3, at the next check mail dovecot give me that error:
Since POP3 supports only downloading mails, I guess this copying operation was the same as if you simply had downloaded the mails.
dovecot: Jan 15 10:59:55 Info: POP3(michele@domain.net): Mailbox init failed top=0/0, retr=0/0, del=0/29, size=932800
Do you see another error message? This isn't actually error (see the Info: line there). The error message should be written either before that line, or perhaps in another log file entirely. See http://wiki.dovecot.org/Logging
Then, the messages from the pop server was deleted,
Probably the messages were deleted by the previous download? This error message doesn't cause messages to be deleted.
I have resolved that deleting all the dovecot files into the mailbox, so:
dovecot-uidlist dovecot.index dovecot.index.cache dovecot.index.log
Deleting only the dovecot.index* files would probably have been enough.
Then, all restarted to works normally, but...the most bad thing is... the lost mails!
You mean that all the 250 mails weren't copied, or they were all copied but also deleted?
Timo Sirainen ha scritto:
On Thu, 2009-01-15 at 11:08 +0100, Claudio Prono wrote:
Today i have manually copied at least 250 mail from a mailbox to another and i have encountered some problems with dovecot. When finished to download all the messages, via pop3, at the next check mail dovecot give me that error:
Since POP3 supports only downloading mails, I guess this copying operation was the same as if you simply had downloaded the mails.
I think so also, before what is happened...
dovecot: Jan 15 10:59:55 Info: POP3(michele@domain.net): Mailbox init failed top=0/0, retr=0/0, del=0/29, size=932800
Do you see another error message? This isn't actually error (see the Info: line there). The error message should be written either before that line, or perhaps in another log file entirely. See http://wiki.dovecot.org/Logging
I have looked at all the logging file of Dovecot, but no other error found...
Then, the messages from the pop server was deleted,
Probably the messages were deleted by the previous download? This error message doesn't cause messages to be deleted.
No, sorry i have explained bad what is happened. The Client have downloaded all the mail, without problems. Then, i have send to him a mail for testing purpouse, and the error is happened. The client have got an error like "can't do STAT command to mail server, connection lost", the mail i have sended to him is deleted, and no mail was recieved from the Client.
I have resolved that deleting all the dovecot files into the mailbox, so:
dovecot-uidlist dovecot.index dovecot.index.cache dovecot.index.log
Deleting only the dovecot.index* files would probably have been enough.
Yes can be.
Then, all restarted to works normally, but...the most bad thing is... the lost mails!
You mean that all the 250 mails weren't copied, or they were all copied but also deleted?
See my previous explaination.
!DSPAM:70,496f59d3137471420520662! Thank u,
Claudio Prono.
--
Claudio Prono Systems Development @ PSS Srl, Divisione Implementazione Sistemi Via San Bernardino, 17 - 10137 Torino (TO) - IT Tel +39-011.32.72.100 Fax +39-011.32.46.497 PGP Fingerprint: 75C2 4049 E23D 2FBF A65F 40DB EA5C 11AC C2B0 3647 Disclaimer: http://atpss.net/disclaimer
On Thu, 2009-01-15 at 18:28 +0100, Claudio Prono wrote:
dovecot: Jan 15 10:59:55 Info: POP3(michele@domain.net): Mailbox init failed top=0/0, retr=0/0, del=0/29, size=932800
Do you see another error message? This isn't actually error (see the Info: line there). The error message should be written either before that line, or perhaps in another log file entirely. See http://wiki.dovecot.org/Logging
I have looked at all the logging file of Dovecot, but no other error found... .. log_path: /var/log/dovecot-err.log
It must have written it to dovecot-err.log. The code looks like this:
i_error("Couldn't init INBOX: %s", errmsg);
client_destroy(client, "Mailbox init failed");So before logging the "Mailbox init failed" it always logs the "Couldn't init INBOX" to the error log. I can't think of a reason why it wouldn't have done that.
Then, the messages from the pop server was deleted,
Probably the messages were deleted by the previous download? This error message doesn't cause messages to be deleted.
No, sorry i have explained bad what is happened. The Client have downloaded all the mail, without problems. Then, i have send to him a mail for testing purpouse, and the error is happened. The client have got an error like "can't do STAT command to mail server, connection lost", the mail i have sended to him is deleted, and no mail was recieved from the Client.
Are you sure the mail was ever even successfully written to the maildir? Are you using Dovecot's deliver to deliver the mails?
Timo Sirainen ha scritto:
On Thu, 2009-01-15 at 18:28 +0100, Claudio Prono wrote:
dovecot: Jan 15 10:59:55 Info: POP3(michele@domain.net): Mailbox init failed top=0/0, retr=0/0, del=0/29, size=932800
Do you see another error message? This isn't actually error (see the Info: line there). The error message should be written either before that line, or perhaps in another log file entirely. See http://wiki.dovecot.org/Logging
I have looked at all the logging file of Dovecot, but no other error found...
.
log_path: /var/log/dovecot-err.log
It must have written it to dovecot-err.log. The code looks like this:
i_error("Couldn't init INBOX: %s", errmsg); client_destroy(client, "Mailbox init failed");
So before logging the "Mailbox init failed" it always logs the "Couldn't init INBOX" to the error log. I can't think of a reason why it wouldn't have done that.
The file dovecot-err.log is empty....
ls -la dovecot-err.log -rw------- 1 root root 0 Jan 15 11:45 dovecot-err.log
ls -la dovecot-inf.log -rw------- 1 root root 127836484 Jan 16 10:36 dovecot-inf.log
Then, the messages from the pop server was deleted,
Probably the messages were deleted by the previous download? This error message doesn't cause messages to be deleted.
No, sorry i have explained bad what is happened. The Client have downloaded all the mail, without problems. Then, i have send to him a mail for testing purpouse, and the error is happened. The client have got an error like "can't do STAT command to mail server, connection lost", the mail i have sended to him is deleted, and no mail was recieved from the Client.
Are you sure the mail was ever even successfully written to the maildir? Are you using Dovecot's deliver to deliver the mails?
Yes, the mail was written to maildir, i have checked it. And yes, i use dovecot deliver to deliver the mail into the mailboxes.
!DSPAM:70,496f99f1188511726110729!
--
Claudio Prono Systems Development @ PSS Srl, Divisione Implementazione Sistemi Via San Bernardino, 17 - 10137 Torino (TO) - IT Tel +39-011.32.72.100 Fax +39-011.32.46.497 PGP Fingerprint: 75C2 4049 E23D 2FBF A65F 40DB EA5C 11AC C2B0 3647 Disclaimer: http://atpss.net/disclaimer
On Jan 16, 2009, at 4:37 AM, Claudio Prono wrote:
It must have written it to dovecot-err.log. The code looks like
this:i_error("Couldn't init INBOX: %s", errmsg); client_destroy(client, "Mailbox init failed");
So before logging the "Mailbox init failed" it always logs the
"Couldn't init INBOX" to the error log. I can't think of a reason why it
wouldn't have done that.The file dovecot-err.log is empty....
That's weird.
ls -la dovecot-err.log -rw------- 1 root root 0 Jan 15 11:45 dovecot-err.log
ls -la dovecot-inf.log -rw------- 1 root root 127836484 Jan 16 10:36 dovecot-inf.log
Do you ever get anything written to dovecot-err.log? For example if
you manually use kill -SEGV for e.g. dovecot-auth process?
participants (2)
-
Claudio Prono
-
Timo Sirainen