[Dovecot] 1.1b1 initial pop3 login: assertion failed
Currently running 1.0.2 with 1.1b1 listening on a different port. On first pop3 login on 1.1b1 I received an immediate disconnect (I was testing with telnet) with the log entries below. Subsequent logins work fine. Other accounts that I tried did not have the same problem. So this is probably isolated to some bad indexes or something, but I thought I should let Timo know.
Regards,
David
Here is what I found in the logs:
Sep 28 15:51:14 kelly-a dovecot: POP3(xxx@xxxxx.com)[8112]: Fixed index file /home/vmail/x/xxxxx.com/xxx/Maildir/dovecot.index: first_recent_uid 0 -> 1
Sep 28 15:51:14 kelly-a dovecot: POP3(xxx@xxxxx.com)[8112]: file mail-index-view-sync.c: line 304 (mail_index_view_sync_begin): assertion failed: (view->index->map->hdr.messages_count >= ctx->finish_min_msg_count)
Sep 28 15:51:14 kelly-a dovecot: POP3(xxx@xxxxx.com)[8112]: Raw backtrace: pop3 [0x80cd42e] -> pop3(i_fatal+0) [0x80cce93] -> pop3(mail_index_view_sync_begin+0x228) [0x80a91d2] -> pop3(index_mailbox_sync_init+0xac) [0x8093abe] -> pop3(maildir_storage_sync_init+0x11e) [0x80646a1] -> pop3(mailbox_sync_init+0x1b) [0x80bb428] -> pop3(mailbox_sync+0x18) [0x80bb49b] -> pop3 [0x80582f5] -> pop3(client_create+0x237) [0x80587ac] -> pop3 [0x805afe8] -> pop3(main+0x95) [0x805b0e4] -> /lib/tls/libc.so.6(__libc_start_main+0xd3) [0x477de3] -> pop3 [0x80581ed]
Sep 28 15:51:14 kelly-a dovecot: child 8112 (pop3) killed with signal 6
Other information
$ cat /etc/redhat-release Red Hat Enterprise Linux ES release 4 (Nahant Update 5)
$ uname -r 2.6.9-42.0.10.ELsmp
$ ./dovecot -n # 1.1.beta1: /usr/local/dovecot-1.1/etc/dovecot.conf base_dir: /var/run/dovecot-1.1/ protocols: imap pop3 listen(default): *:9143 listen(imap): *:9143 listen(pop3): *:9110 ssl_disable: yes login_dir: /var/run/dovecot-1.1/login login_executable(default): /usr/local/dovecot-1.1/libexec/dovecot/imap-login login_executable(imap): /usr/local/dovecot-1.1/libexec/dovecot/imap-login login_executable(pop3): /usr/local/dovecot-1.1/libexec/dovecot/pop3-login login_greeting: postoffice.no-ip.com (1.1) login_log_format_elements: user=<%u@%d> method=%m rip=%r lip=%l %c login_process_per_connection: no verbose_proctitle: yes first_valid_uid: 89 mail_uid: vmail mail_gid: vmail mail_executable(default): /usr/local/dovecot-1.1/libexec/dovecot/imap mail_executable(imap): /usr/local/dovecot-1.1/libexec/dovecot/imap mail_executable(pop3): /usr/local/dovecot-1.1/libexec/dovecot/pop3 mail_plugin_dir(default): /usr/local/dovecot-1.1/lib/dovecot/imap mail_plugin_dir(imap): /usr/local/dovecot-1.1/lib/dovecot/imap mail_plugin_dir(pop3): /usr/local/dovecot-1.1/lib/dovecot/pop3 mail_log_prefix: %Us(%u)[%p]: pop3_uidl_format(default): %08Xu%08Xv pop3_uidl_format(imap): %08Xu%08Xv pop3_uidl_format(pop3): %f pop3_client_workarounds(default): pop3_client_workarounds(imap): pop3_client_workarounds(pop3): outlook-no-nuls oe-ns-eoh auth default: mechanisms: plain login digest-md5 cram-md5 user: nobody username_translation: %@ username_format: %Lu verbose: yes passdb: driver: sql args: /usr/local/dovecot-1.1/etc/dovecot-sql.conf userdb: driver: prefetch socket: type: listen client: path: /var/run/dovecot-1.1/auth-client mode: 432 plugin: quota: dict:user::proxy::quota dict: quota: mysql:/usr/local/dovecot-1.1/etc/dovecot-dict-quota.conf
On Fri, 2007-09-28 at 16:12 -0700, David Jonas wrote:
Sep 28 15:51:14 kelly-a dovecot: POP3(xxx@xxxxx.com)[8112]: Fixed index file /home/vmail/x/xxxxx.com/xxx/Maildir/dovecot.index: first_recent_uid 0 -> 1
Fixed now: http://hg.dovecot.org/dovecot/rev/392a49f0c69a
Sep 28 15:51:14 kelly-a dovecot: POP3(xxx@xxxxx.com)[8112]: file mail-index-view-sync.c: line 304 (mail_index_view_sync_begin): assertion failed: (view->index->map->hdr.messages_count >= ctx->finish_min_msg_count)
I guess you don't have a core file from this crash? It probably had something to do with upgrading index files from v1.0, but it still shouldn't happen and I'd like to fix it.
Timo Sirainen wrote:
On Fri, 2007-09-28 at 16:12 -0700, David Jonas wrote:
Sep 28 15:51:14 kelly-a dovecot: POP3(xxx@xxxxx.com)[8112]: Fixed index file /home/vmail/x/xxxxx.com/xxx/Maildir/dovecot.index: first_recent_uid 0 -> 1
Fixed now: http://hg.dovecot.org/dovecot/rev/392a49f0c69a
Sep 28 15:51:14 kelly-a dovecot: POP3(xxx@xxxxx.com)[8112]: file mail-index-view-sync.c: line 304 (mail_index_view_sync_begin): assertion failed: (view->index->map->hdr.messages_count >= ctx->finish_min_msg_count)
I guess you don't have a core file from this crash? It probably had something to do with upgrading index files from v1.0, but it still shouldn't happen and I'd like to fix it.
I dug around the filesystem and didn't see a core file hanging around. What do I need to do to get a core dump? I can set a script to login into a bunch of accounts until it gets one that core dumps, if that'd be helpful. I just need to know how to make it produce the core and where the core might be written.
participants (2)
-
David Jonas
-
Timo Sirainen