[Dovecot] litte problems upgrade from 1.0.x to 1.1.1

Andre Hübner andre.huebner at gmx.de
Mon Jul 21 12:59:04 EEST 2008


Hi,

> Can you get a gdb backtrace from this crash? See 
> http://dovecot.org/bugreport.html

additional to my last mail now a cordump was created

this is dovecot -n


# 1.1.1: /etc/dovecot.conf
protocols: imap imaps pop3 pop3s
ssl_ca_file: /path/path/*.myservername.com.bundle.crt
ssl_cert_file: /path/path/*.myservername.com.crt
ssl_key_file: /path/path/*.myservername.com.key
disable_plaintext_auth: no
login_dir: /var/run/dovecot/login
login_executable(default): /usr/libexec/dovecot/imap-login
login_executable(imap): /usr/libexec/dovecot/imap-login
login_executable(pop3): /usr/libexec/dovecot/pop3-login
login_greeting: myservername.com mailserver ready.
login_process_per_connection: no
login_processes_count: 1
max_mail_processes: 100
verbose_proctitle: yes
mail_location: mbox:~/mail:INBOX=/var/spool/mail/%u
mail_cache_min_mail_count: 30
mail_debug: yes
mbox_read_locks: dotlock
mbox_very_dirty_syncs: yes
mail_drop_priv_before_exec: yes
mail_executable(default): /usr/libexec/dovecot/imap
mail_executable(imap): /usr/libexec/dovecot/imap
mail_executable(pop3): /usr/libexec/dovecot/pop3
mail_plugins(default): mail_log
mail_plugins(imap): mail_log
mail_plugins(pop3):
mail_plugin_dir(default): /usr/lib/dovecot/imap
mail_plugin_dir(imap): /usr/lib/dovecot/imap
mail_plugin_dir(pop3): /usr/lib/dovecot/pop3
imap_client_workarounds(default): outlook-idle netscape-eoh
tb-extra-mailbox-sep delay-newmail
imap_client_workarounds(imap): outlook-idle netscape-eoh
tb-extra-mailbox-sep delay-newmail
imap_client_workarounds(pop3):
pop3_client_workarounds(default):
pop3_client_workarounds(imap):
pop3_client_workarounds(pop3): oe-ns-eoh outlook-no-nuls
auth default:
  verbose: yes
  passdb:
    driver: shadow
  userdb:
    driver: passwd

lines in log:



Jul 16 08:45:55 servername dovecot: IMAP(user): Loading modules from 
directory: /usr/lib/dovecot/imap
Jul 16 08:45:55 servername dovecot: imap-login: Login: user=<user>, 
method=PLAIN, rip=85.13.133.104, lip=85.13.133.104, secured
Jul 16 08:45:55 servername dovecot: IMAP(user): Module loaded: 
/usr/lib/dovecot/imap/lib20_mail_log_plugin.so
Jul 16 08:45:55 servername dovecot: IMAP(user): Effective uid=504, gid=501, 
home=/home/popuser/user
Jul 16 08:45:55 servername dovecot: IMAP(user): mbox: 
data=/home/popuser/user/mail:INBOX=/var/spool/mail/user
Jul 16 08:45:55 servername dovecot: IMAP(user): fs: 
root=/home/popuser/user/mail, index=, control=, inbox=/var/spool/mail/user
Jul 16 08:45:55 servername dovecot: IMAP(user): Next message unexpectedly 
lost from 6693538
Jul 16 08:45:55 servername dovecot: IMAP(user): Next message unexpectedly 
lost from 6693538
Jul 16 08:45:55 servername dovecot: Panic: IMAP(user): file 
message-parser.c: line 770 (message_parser_parse_next_block): assertion 
failed: (ctx->input->eof
|| ctx->input->closed || ctx->input->stream_errno != 0 || ctx->broken)
Jul 16 08:45:55 servername dovecot: IMAP(user): Raw backtrace: imap 
[0x80c2cf0] -> imap [0x80c2d4a] -> imap [0x80c265c] -> 
imap(message_parser_parse_body+0)
[0x80bbfa0] -> imap(index_mail_cache_parse_continue+0x22) [0x8087172] -> 
imap(mbox_save_continue+0x9c) [0x807054c] -> imap(mail_storage_copy+0xe4) 
[0x8091684]
 -> /usr/lib/dovecot/imap/lib20_mail_log_plugin.so [0xb7f88d1a] -> 
imap(cmd_copy+0x1d2) [0x805a1c2] -> imap [0x805edfc] -> imap [0x805eea5] -> 
imap [0x805f655
] -> imap(client_input+0x5e) [0x805f86e] -> imap(io_loop_handler_run+0x100) 
[0x80ca590] -> imap(io_loop_run+0x28) [0x80c9738] -> imap(main+0x46b) 
[0x806736b]
-> /lib/libc.so.6(__libc_start_main+0xdc) [0xb7e7287c] -> imap [0x8059211]
Jul 16 08:45:55 servername dovecot: child 26263 (imap) killed with signal 6



gdb output:


gdb /usr/libexec/dovecot/imap /home/popuser/user/core
GNU gdb 6.4
Copyright 2005 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
welcome to change it and/or distribute copies of it under certain 
conditions.
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB.  Type "show warranty" for details.
This GDB was configured as "i586-suse-linux"...Using host libthread_db 
library "/lib/libthread_db.so.1".


warning: exec file is newer than core file.
Core was generated by `imap [user 85.13.133.104]'.
Program terminated with signal 6, Aborted.

warning: Can't read pathname for load map: Eingabe-/Ausgabefehler.
Reading symbols from /lib/libdl.so.2...done.
Loaded symbols for /lib/libdl.so.2
Reading symbols from /lib/libc.so.6...done.
Loaded symbols for /lib/libc.so.6
Reading symbols from /lib/ld-linux.so.2...done.
Loaded symbols for /lib/ld-linux.so.2
Reading symbols from /usr/lib/dovecot/imap/lib20_mail_log_plugin.so...done.
Loaded symbols for /usr/lib/dovecot/imap/lib20_mail_log_plugin.so
Reading symbols from /lib/libnss_files.so.2...done.
Loaded symbols for /lib/libnss_files.so.2
Reading symbols from /lib/libgcc_s.so.1...done.
Loaded symbols for /lib/libgcc_s.so.1
#0  0xffffe410 in __kernel_vsyscall ()
(gdb) bt full
#0  0xffffe410 in __kernel_vsyscall ()
No symbol table info available.
#1  0xb7e857d0 in raise () from /lib/libc.so.6
No symbol table info available.
#2  0xb7e86ea3 in abort () from /lib/libc.so.6
No symbol table info available.
#3  0x080c2cfd in fd_debug_verify_leaks (first_fd=135383096, last_fd=0) at 
fd-close-on-exec.c:32
        addr = {family = 11517, u = {ip6 = {in6_u = {u6_addr8 = 
"AM\016\bx\005\017\bÌ_\r\bý\v\b", u6_addr16 = {19777, 2062, 1400, 2063, 
24524, 2061, 48579,
          2059}, u6_addr32 = {135155009, 135202168, 135094220, 134987203}}}, 
ip4 = {s_addr = 135155009}}}
        raddr = {family = 0, u = {ip6 = {in6_u = {u6_addr8 = 
"\001\000\000\000\000\000\000\0008È\021\b\230H¯¿", u6_addr16 = {1, 0, 0, 0, 
51256, 2065, 18584,
          49071}, u6_addr32 = {1, 0, 135383096, 3215935640}}}, ip4 = {s_addr 
= 1}}}
        port = <value optimized out>
        rport = <value optimized out>
        st = {st_dev = 0, __pad1 = 0, __st_ino = 0, st_mode = 0, st_nlink = 
0, st_uid = 0, st_gid = 0, st_rdev = 0, __pad2 = 0, st_size = 0, st_blksize 
= 0,
  st_blocks = 0, st_atim = {tv_sec = 0, tv_nsec = 0}, st_mtim = {tv_sec = 0, 
tv_nsec = 0}, st_ctim = {tv_sec = 0, tv_nsec = 0}, st_ino = 0}
        old_errno = <value optimized out>
#4  0x080c2d4a in fd_debug_verify_leaks (first_fd=0, last_fd=4) at 
fd-close-on-exec.c:44
        sa = {sun_family = 0,
  sun_path = 
"\210\t\017\btH¯¿E\000\000\000ÈG¯¿¶\025\f\b;\f\017\bäG¯¿@H¯¿Øvú·B\a\005\b\224\226g\000\224\002\000\001\000\000\000\000\030H¯¿\224\002\000\000èG¯¿ 
", '\0' <repeats 42 times>}
        socklen = <value optimized out>
        addr = {family = 48579, u = {ip6 = {in6_u = {u6_addr8 = 
"ÐO\021\b(I¯¿\000\000\000\000x\005\017\b", u6_addr16 = {20432, 2065, 18728, 
49071, 0, 0,
          1400, 2063}, u6_addr32 = {135352272, 3215935784, 0, 135202168}}}, 
ip4 = {s_addr = 135352272}}}
        raddr = {family = 18584, u = {ip6 = {in6_u = {u6_addr8 = 
"ý,\f\bAM\016\bx\005\017\bÌ_\r\b", u6_addr16 = {11517, 2060, 19777, 2062, 
1400, 2063,
          24524, 2061}, u6_addr32 = {135015677, 135155009, 135202168, 
135094220}}}, ip4 = {s_addr = 135015677}}}
        port = <value optimized out>
        rport = <value optimized out>
        st = {st_dev = 0, __pad1 = 0, __st_ino = 0, st_mode = 0, st_nlink = 
0, st_uid = 0, st_gid = 0, st_rdev = 0, __pad2 = 0, st_size = 0, st_blksize 
= 0,
  st_blocks = 0, st_atim = {tv_sec = 0, tv_nsec = 0}, st_mtim = {tv_sec = 0, 
tv_nsec = 0}, st_ctim = {tv_sec = 0, tv_nsec = 1}, st_ino = 
581465969751228416}
        old_errno = 135202168
#5  0x080c265c in default_handler (prefix=0x0, fd=6, format=0x6697 <Address 
0x6697 out of bounds>, args=0x80d5fcc "te.") at failures.c:111
        ret = 135015754
        old_errno = -1079031744
        recursed = 0
#6  0x080bbfa0 in message_parser_parse_header (ctx=0xbfaf4920, 
hdr_size=0xbfaf4920, callback=0, context=0x19) at message-parser.c:798
        block = {part = 0x80e3e80, hdr = 0x80e3d2c, data = 0x0, size = 0}
        ret = 135352584
        __PRETTY_FUNCTION__ = "message_parser_parse_header"
#7  0x08087172 in index_mail_cache_parse_continue (_mail=0x8115108) at 
index-mail.c:1292
        block = {part = 0x81173c0, hdr = 0x0, data = 0x0, size = 0}
        ret = <value optimized out>
#8  0x0807054c in mbox_save_continue (_ctx=0x8110e50) at mbox-save.c:580
        ctx = <value optimized out>
        data = (const unsigned char *) 0x810c978 "80\020\b Â\020\bb"
        i = <value optimized out>
        size = 135278648
        ret = 39
#9  0x08091684 in mail_storage_copy (t=0x810ba08, mail=0x810c978, 
flags=MAIL_SEEN, keywords=0x0, dest_mail=0x0) at mail-copy.c:28
        ctx = <value optimized out>
        input = (struct istream *) 0x8111078
        from_envelope = 0x8110ee8 "email at exampledomain.de"
        received_date = 1216159034
#10 0xb7f88d1a in mail_log_copy (t=0x810ba08, mail=0x810c978, 
flags=MAIL_SEEN, keywords=0x0, dest_mail=0x0) at mail-log-plugin.c:394
        name = <value optimized out>
#11 0x0805a1c2 in cmd_copy (cmd=0x80fa9c8) at cmd-copy.c:66
        client = (struct client *) 0x80f9548
        storage = (struct mail_storage *) 0x80fa108
        destbox = (struct mailbox *) 0x8107240
        t = (struct mailbox_transaction_context *) 0x810ba08
        search_arg = <value optimized out>
        messageset = 0x80feac0 "98"
        mailbox = 0x80feac8 "Trash"
        src_uidset = <value optimized out>
        msg = <value optimized out>
        sync_flags = <value optimized out>
        imap_flags = <value optimized out>
        copy_count = 1
        uid_validity = <value optimized out>
        uid1 = <value optimized out>
        uid2 = <value optimized out>
        ret = 1
        __PRETTY_FUNCTION__ = "cmd_copy"
#12 0x0805edfc in client_command_input (cmd=0x80fa9c8) at client.c:580
        client = (struct client *) 0x80f9548
        command = <value optimized out>
        __PRETTY_FUNCTION__ = "client_command_input"
#13 0x0805eea5 in client_command_input (cmd=0x80fa9c8) at client.c:629
        client = (struct client *) 0x80f9548
        command = (struct command *) 0x6697
        __PRETTY_FUNCTION__ = "client_command_input"
#14 0x0805f655 in client_handle_input (client=0x0) at client.c:677
        ret = <value optimized out>
        remove_io = <value optimized out>
        handled_commands = false
#15 0x0805f86e in client_input (client=0x80f9548) at client.c:724
        cmd = <value optimized out>
        output = (struct ostream *) 0x80fa904
        bytes = 22
        __PRETTY_FUNCTION__ = "client_input"
#16 0x080ca590 in nearest_power (num=6) at lib.c:13
        n = <value optimized out>
        __PRETTY_FUNCTION__ = "nearest_power"
#17 0x080c9738 in timeout_reset_timeval (timeout=0x2, tv_now=0x80fa960) at 
ioloop.c:153
        __PRETTY_FUNCTION__ = "timeout_reset_timeval"
#18 0x0806736b in main (argc=Cannot access memory at address 0x6697
) at main.c:244
No locals.


##############

i see you did a lot of patches, hope this helps  :)
Thank you
Andre



More information about the dovecot mailing list