Here is the first crash I've seen with the current CVS... Feb 19 00:45:52 mail35a dovecot: IMAP(mnash at stest1.com): Corrupted transaction log file /var/index//data1/mail/st/stest1.com/mn/mnash//.Trash/dovecot.index.log: Append with UID 5736, but next_uid = 5744 Feb 19 00:45:55 mail35a dovecot: IMAP(mnash at stest1.com): Corrupted transaction log file /var/index//data1/mail/st/stest1.com/mn/mnash//.Trash/dovecot.index.log: Append with UID 5737, but next_uid = 5744 Feb 19 00:46:34 mail35a dovecot: IMAP(mnash at stest1.com): file index-mail.c: line 790: unreached Feb 19 00:46:34 mail35a dovecot: IMAP(mnash at stest1.com): Raw backtrace: imap [0x8091552] -> imap [0x80910cf] -> imap [0x806c891] -> imap(mail_set_seq+0x10) [0x8084ce0] -> imap(index_storage_search_next+0x3b) [0x806f28b] -> imap(mailbox_search_next+0x14) [0x8085ae4] -> imap(imap_expunge+0x8a) [0x805b3e6] -> imap(cmd_expunge+0x61) [0x8056e69] -> imap [0x805a51e] -> imap [0x805a498] -> imap(_client_input+0x5a) [0x805a5e6] -> imap(io_loop_handler_run+0x10c) [0x80965fc] -> imap(io_loop_run+0x25) [0x8095a75] -> imap(main+0x6b) [0x80614f7] -> /lib/tls/libc.so.6(__libc_start_main+0xda) [0xd9478a] -> imap(setuid+0xa1) [0x8055825] Feb 19 00:46:34 mail35a dovecot: child 23564 (imap) killed with signal 6 Feb 19 00:46:38 mail35a dovecot: IMAP(mnash at stest1.com): fscking index file /var/index//data1/mail/st/stest1.com/mn/mnash//.Trash/dovecot.index Feb 19 00:46:38 mail35a dovecot: IMAP(mnash at stest1.com): Fixed index file /var/index//data1/mail/st/stest1.com/mn/mnash//.Trash/dovecot.index: first_recent_uid_lowwater 5744 -> 5738
On Mon, 2007-02-19 at 06:06 -0500, Bill Boebel wrote:> Here is the first crash I've seen with the current CVS... > > Feb 19 00:45:52 mail35a dovecot: IMAP(mnash at stest1.com): Corrupted transaction log file /var/index//data1/mail/st/stest1.com/mn/mnash//.Trash/dovecot.index.log: Append with UID 5736, but next_uid = 5744Wonder how this could be reproduced.. I think I saw these at one point with my imaptest tool, but then they went away. Probably there's still a lock race condition somewhere.> Feb 19 00:46:34 mail35a dovecot: IMAP(mnash at stest1.com): file index-mail.c: line 790: unreachedI guess it's because of the above error, although I'm not sure why. BTW. Could you add %p (pid) to mail_log_prefix? That would tell in situations like these if these errors came from the same process or a different one. -------------- next part -------------- A non-text attachment was scrubbed... Name: signature.asc Type: application/pgp-signature Size: 189 bytes Desc: This is a digitally signed message part URL: <http://dovecot.org/pipermail/dovecot/attachments/20070222/592aeed1/attachment.bin>
On Thu, February 22, 2007 2:51 pm, Timo Sirainen <tss at iki.fi> said:> BTW. Could you add %p (pid) to mail_log_prefix? That would tell in > situations like these if these errors came from the same process or a > different one. >I've added the pid to the log right after the username. Here is another similar crash... Mar 4 17:21:26 mail40a dovecot: IMAP(flanigan at example.com)(27115): file index-mail.c: line 790: unreached Mar 4 17:21:26 mail40a dovecot: IMAP(flanigan at example.com)(27115): Raw backtrace: imap [0x80a6832] -> imap [0x80a63af] -> imap [0x8081acd] -> imap(mail_set_seq+0x10) [0x8099f3c] -> imap(index_storage_search_next+0x3b) [0x80844c7] -> imap(mailbox_search_next+0x14) [0x809ad40] -> imap(imap_fetch+0x64) [0x805cff4] -> imap(cmd_fetch+0xee) [0x805899a] -> imap(cmd_uid+0x4d) [0x805b19d] -> imap [0x805bb86] -> imap [0x805bb00] -> imap(_client_input+0x5a) [0x805bc4e] -> imap(io_loop_handler_run+0x10c) [0x80ab980] -> imap(io_loop_run+0x25) [0x80aadf9] -> imap(main+0x6b) [0x8062b73] -> /lib/tls/libc.so.6(__libc_start_main+0xda) [0x13d78a] -> imap(setuid+0xa1) [0x8056e8d] Mar 4 17:21:26 mail40a dovecot: child 27115 (imap) killed with signal 6 Mar 4 17:21:31 mail40a dovecot: IMAP(flanigan at example.com)(27199): fscking index file /data1/mail/ex/example.com/fl/flanigan/.Trash/dovecot.index Mar 4 17:21:31 mail40a dovecot: IMAP(flanigan at example.com)(27199): Fixed index file /data1/mail/ex/example.com/fl/flanigan/.Trash/dovecot.index: first_recent_uid_lowwater 3345 -> 3297
On Tue, March 6, 2007 9:06 am, Timo Sirainen <tss at iki.fi> said:>> Mar 4 17:21:26 mail40a dovecot: IMAP(flanigan at example.com)(27115): file >> index-mail.c: line 790: unreached > > This time there weren't those "Append with UID xx, but next_uid = yy" > errors before this? >No, not this time. Bill