[Dovecot] Dovecot 2.0.beta3: Child killed with signal 11
Hi,
I'm seeing these after the latest Mercurial updates:
==> /var/log/dovecot.info <== Feb 28 16:07:00 spectre dovecot: master: service(lmtp): child 17322 killed with signal 11 (core dumps disabled)
Regards Thomas
On Sun, 2010-02-28 at 16:09 +0100, Thomas Leuxner wrote:
Feb 28 16:07:00 spectre dovecot: master: service(lmtp): child 17322 killed with signal 11 (core dumps disabled)
Could you get gdb backtrace? http://dovecot.org/bugreport.html
If you have trouble getting a core, an easy way should be to attach to existing lmtp process:
- telnet localhost <lmtp port> quit
- gdb -p
pidof lmtpcont - make it crash
- gdb: bt full
If you have trouble getting a core, an easy way should be to attach to existing lmtp process:
- telnet localhost <lmtp port> quit
- gdb -p
pidof lmtpcont- make it crash
- gdb: bt full
Not sure I'm doing this correctly. Core Dumps seem to be disabled in my vanilla Kernel. Running 'gdb' also seems not to produce the result wanted. As long as GDB is attached it does not crash the 'lmtp' process, only when I quit the debugger.
Feb 28 16:51:18 spectre dovecot: lmtp(17782): Disconnect from 188.138.0.199: Client quit
[16:50] root spectre:~# gdb -p 17782 GNU gdb 6.8-debian Copyright (C) 2008 Free Software Foundation, Inc. License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html> This is free software: you are free to change and redistribute it. There is NO WARRANTY, to the extent permitted by law. Type "show copying" and "show warranty" for details. This GDB was configured as "x86_64-linux-gnu". Attaching to process 17782 Reading symbols from /usr/lib/dovecot/lmtp...(no debugging symbols found)...done. Reading symbols from /usr/lib/dovecot/libdovecot-storage.so.0...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/libdovecot-storage.so.0 Reading symbols from /usr/lib/dovecot/libdovecot.so.0...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/libdovecot.so.0 Reading symbols from /lib/libdl.so.2...(no debugging symbols found)...done. Loaded symbols for /lib/libdl.so.2 Reading symbols from /lib/librt.so.1...(no debugging symbols found)...done. Loaded symbols for /lib/librt.so.1 Reading symbols from /lib/libc.so.6...(no debugging symbols found)...done. Loaded symbols for /lib/libc.so.6 Reading symbols from /lib/ld-linux-x86-64.so.2... (no debugging symbols found)...done. Loaded symbols for /lib64/ld-linux-x86-64.so.2 Reading symbols from /lib/libpthread.so.0...(no debugging symbols found)...done. [Thread debugging using libthread_db enabled] [New Thread 0x7f30067dd6e0 (LWP 17782)] Loaded symbols for /lib/libpthread.so.0 Reading symbols from /lib/libnss_files.so.2...(no debugging symbols found)...done. Loaded symbols for /lib/libnss_files.so.2 Reading symbols from /usr/lib/dovecot/modules/lib10_quota_plugin.so...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/modules/lib10_quota_plugin.so Reading symbols from /usr/lib/dovecot/modules/lib90_sieve_plugin.so...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/modules/lib90_sieve_plugin.so Reading symbols from /usr/lib/dovecot/libdovecot-sieve.so.0...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/libdovecot-sieve.so.0
(no debugging symbols found) 0x00007f3005a07b23 in epoll_wait () from /lib/libc.so.6 (gdb) cont Continuing.
Program received signal SIGINT, Interrupt. [Switching to Thread 0x7f30067dd6e0 (LWP 17782)] 0x00007f3005a07b23 in epoll_wait () from /lib/libc.so.6
(gdb) bt full #0 0x00007f3005a07b23 in epoll_wait () from /lib/libc.so.6 No symbol table info available. #1 0x00007f30060d9abb in io_loop_handler_run () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available. #2 0x00007f30060d8ca8 in io_loop_run () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available. #3 0x00007f30060c8eb3 in master_service_run () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available. #4 0x0000000000405b02 in main () No symbol table info available.
==> /var/log/dovecot.info <== Feb 28 16:58:30 spectre dovecot: master: service(lmtp): child 17782 killed with signal 11 (core not dumped)
Timo Sirainen <tss@iki.fi> wrote:
On Sun, 2010-02-28 at 16:09 +0100, Thomas Leuxner wrote:
Feb 28 16:07:00 spectre dovecot: master: service(lmtp): child 17322 kille= d with signal 11 (core dumps disabled) Could you get gdb backtrace? http://dovecot.org/bugreport.html
For the record, I see those too. I use Stephan Bosch's Debian packages. The issue has not been there with 2:2.0.beta3-0~auto+4 (hg 10807:ba19f3c077a8), but has appeared with 2:2.0.beta3-0~auto+6 (hg 10815:1a888e13bf7f).
#0 0x00007f525ef3dc93 in epoll_wait () from /lib/libc.so.6 No symbol table info available. #1 0x00007f525f85e07a in io_loop_handler_run (ioloop=0x18495d0) at ioloop-epoll.c:175 ctx = 0x18497e0 event = <value optimized out> list = <value optimized out> io = <value optimized out> tv = {tv_sec = 2147483, tv_usec = 0} t_id = 2 msecs = 2147483647 ret = 1 i = <value optimized out> call = <value optimized out> #2 0x00007f525f85d268 in io_loop_run (ioloop=0x18495d0) at ioloop.c:350 No locals. #3 0x00007f525f84d9d3 in master_service_run (service=0x18494b0, callback=0x1849850) at master-service.c:478 No locals.
I also see a signal 11 in pop3 on disconnect, backtrace:
(gdb) bt full #0 hash_table_destroy (_table=0x6ec7f0) at hash.c:110 table = 0x0 #1 0x00007f82b770b9d4 in settings_parser_deinit (_ctx=<value optimized out>) at settings-parser.c:231 ctx = 0x6ec7c8 #2 0x00007f82b7727681 in master_service_settings_cache_deinit ( _cache=<value optimized out>) at master-service-settings-cache.c:93 cache = 0x6ddaf8 entry = 0x0 next = 0x0
And managesieve segfaults immediately at TCP connect, but I have not managed to get a backtrace yet (it always says "core not dumped" regardless of ulimit -c setting. I also added -D to the executable, but no core file yet)
Feb 28 17:18:07 mail dovecot: master: service(managesieve-login): child 1168 killed with signal 11 (core not dumped)
Bernhard
Bernhard Schmidt <berni@birkenwald.de> wrote:
And managesieve segfaults immediately at TCP connect, but I have not managed to get a backtrace yet (it always says "core not dumped" regardless of ulimit -c setting. I also added -D to the executable, but no core file yet)
Feb 28 17:18:07 mail dovecot: master: service(managesieve-login): child 1168 killed with signal 11 (core not dumped)
(gdb) bt #0 setting_copy (type=SET_STR, src=0x0, dest=0x24f6620, pool=0x24f4d20) at settings-parser.c:1237 #1 0x00007f47bc2e860a in settings_dup (info=<value optimized out>, set=<value optimized out>, pool=0x24f4d20) at settings-parser.c:1285 #2 0x00007f47bc54d196 in login_settings_read (pool=0x24f4d20, local_ip=<value optimized out>, remote_ip=<value optimized out>, local_host=<value optimized out>, other_settings_r=<value optimized out>) at login-settings.c:219 #3 0x00007f47bc54d7b6 in client_connected_finish (conn=0x7fff7b6bc270) at main.c:112 #4 0x00007f47bc3008fd in master_service_listen (l=0x24d0188) at master-service.c:712 #5 0x00007f47bc3110e5 in io_loop_handler_run (ioloop=<value optimized out>) at ioloop-epoll.c:208
Bernhard
On Sun, 2010-02-28 at 18:34 +0000, Bernhard Schmidt wrote:
And managesieve segfaults immediately at TCP connect, but I have not managed to get a backtrace yet (it always says "core not dumped" regardless of ulimit -c setting. I also added -D to the executable, but no core file yet)
Feb 28 17:18:07 mail dovecot: master: service(managesieve-login): child 1168 killed with signal 11 (core not dumped)
Attached patch probably helps?
On 28.02.2010 20:24, Timo Sirainen wrote:
On Sun, 2010-02-28 at 18:34 +0000, Bernhard Schmidt wrote:
And managesieve segfaults immediately at TCP connect, but I have not managed to get a backtrace yet (it always says "core not dumped" regardless of ulimit -c setting. I also added -D to the executable, but no core file yet)
Feb 28 17:18:07 mail dovecot: master: service(managesieve-login): child 1168 killed with signal 11 (core not dumped)
Attached patch probably helps?
It does indeed, thank you very much.
The Thunderbird Sieve plugin is dead-slow with the new version on TLS connection setup (and doesn't work at all when you don't disable a Cyrus TLS workaround in it), but that needs more debugging.
Bernhard
Bernhard Schmidt <berni@birkenwald.de> wrote:
On Sun, 2010-02-28 at 16:09 +0100, Thomas Leuxner wrote:
Feb 28 16:07:00 spectre dovecot: master: service(lmtp): child 17322 kille= d with signal 11 (core dumps disabled) Could you get gdb backtrace? http://dovecot.org/bugreport.html
For the record, I see those too. I use Stephan Bosch's Debian packages. The issue has not been there with 2:2.0.beta3-0~auto+4 (hg 10807:ba19f3c077a8), but has appeared with 2:2.0.beta3-0~auto+6 (hg 10815:1a888e13bf7f).
#0 0x00007f525ef3dc93 in epoll_wait () from /lib/libc.so.6 No symbol table info available. #1 0x00007f525f85e07a in io_loop_handler_run (ioloop=0x18495d0) at ioloop-epoll.c:175 ctx = 0x18497e0 event = <value optimized out> list = <value optimized out> io = <value optimized out> tv = {tv_sec = 2147483, tv_usec = 0} t_id = 2 msecs = 2147483647 ret = 1 i = <value optimized out> call = <value optimized out> #2 0x00007f525f85d268 in io_loop_run (ioloop=0x18495d0) at ioloop.c:350 No locals. #3 0x00007f525f84d9d3 in master_service_run (service=0x18494b0, callback=0x1849850) at master-service.c:478 No locals.
Although the backtrace does not look like it, this problem also seems to be fixed by 10817:a5b4cbf46b9b . At least that's the only change between 2:2.0.beta3-0~auto+7 (broken) and 2:2.0.beta3-0~auto+8 (good).
Bernhard
Hopefully useful now...
GNU gdb 6.8-debian Copyright (C) 2008 Free Software Foundation, Inc. License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html> This is free software: you are free to change and redistribute it. There is NO WARRANTY, to the extent permitted by law. Type "show copying" and "show warranty" for details. This GDB was configured as "x86_64-linux-gnu"... (no debugging symbols found)
warning: Can't read pathname for load map: Input/output error. Reading symbols from /usr/lib/dovecot/libdovecot-storage.so.0...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/libdovecot-storage.so.0 Reading symbols from /usr/lib/dovecot/libdovecot.so.0...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/libdovecot.so.0 Reading symbols from /lib/libdl.so.2...(no debugging symbols found)...done. Loaded symbols for /lib/libdl.so.2 Reading symbols from /lib/librt.so.1...(no debugging symbols found)...done. Loaded symbols for /lib/librt.so.1 Reading symbols from /lib/libc.so.6...(no debugging symbols found)...done. Loaded symbols for /lib/libc.so.6 Reading symbols from /lib/ld-linux-x86-64.so.2...(no debugging symbols found)...done. Loaded symbols for /lib64/ld-linux-x86-64.so.2 Reading symbols from /lib/libpthread.so.0... (no debugging symbols found)...done. Loaded symbols for /lib/libpthread.so.0 Reading symbols from /usr/lib/dovecot/modules/lib01_acl_plugin.so...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/modules/lib01_acl_plugin.so Reading symbols from /usr/lib/dovecot/modules/lib02_imap_acl_plugin.so...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/modules/lib02_imap_acl_plugin.so Reading symbols from /usr/lib/dovecot/modules/lib10_quota_plugin.so...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/modules/lib10_quota_plugin.so Reading symbols from /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so Reading symbols from /usr/lib/dovecot/modules/lib20_fts_plugin.so...(no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/modules/lib20_fts_plugin.so Reading symbols from /usr/lib/dovecot/modules/lib21_fts_squat_plugin.so... (no debugging symbols found)...done. Loaded symbols for /usr/lib/dovecot/modules/lib21_fts_squat_plugin.so (no debugging symbols found) Core was generated by `dovecot/imap'. Program terminated with signal 11, Segmentation fault. [New process 17997] #0 0x00007f256d8c86ee in hash_table_destroy () from /usr/lib/dovecot/libdovecot.so.0 (gdb) bt full #0 0x00007f256d8c86ee in hash_table_destroy () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available. #1 0x00007f256d8a54c4 in settings_parser_deinit () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available. #2 0x00007f256d8c0bbc in master_service_settings_cache_deinit () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available. #3 0x00007f256db33709 in mail_storage_service_deinit () from /usr/lib/dovecot/libdovecot-storage.so.0 No symbol table info available. #4 0x0000000000418629 in main () No symbol table info available.
Feb 28 17:15:22 spectre dovecot: master: service(imap): child 17997 killed with signal 11 (core dumped)
On Sun, 2010-02-28 at 17:25 +0100, Thomas Leuxner wrote:
#0 0x00007f256d8c86ee in hash_table_destroy () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available. #1 0x00007f256d8a54c4 in settings_parser_deinit () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available.
Fixed now.
Am 28.02.2010 um 19:11 schrieb Timo Sirainen:
On Sun, 2010-02-28 at 17:25 +0100, Thomas Leuxner wrote:
#0 0x00007f256d8c86ee in hash_table_destroy () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available. #1 0x00007f256d8a54c4 in settings_parser_deinit () from /usr/lib/dovecot/libdovecot.so.0 No symbol table info available.
Fixed now.
Thanks. Looks good now.
participants (3)
-
Bernhard Schmidt
-
Thomas Leuxner
-
Timo Sirainen