Andreas Fischer
2018-Feb-19 22:14 UTC
[bt full included] imap-login: Panic: file client-common.c: line 272 (client_destroy): assertion failed: (client->create_finished)
Hi,
as discussed with cmouse on freenode two days ago please find attached
necessary debug information on a crashing imap-login process, that
appeared after upgrading to v2.3 (+ sieve). It is a standard setup in
combination with postfix and thunderbird, roundcube and K9(Android) as
imap clients. Panic happens 5-6 times a day, but no influence on user
experience. Unfortunately i have no idea what might be causing it.
Let me know if you need more information.
Andreas
syslog: Feb 19 21:09:37 hafnium.d9c.eu dovecot[14324]: imap-login:
Fatal: master: service(imap-login): child 30653 killed with signal 6
(core dumped)
dovecot.log:
Feb 19 20:57:07 imap(user at d9c.eu)<30655><7C/91pVl0q3CJ7cC>: Info:
Connection closed (IDLE running for 0.001 + waiting input for 1109.126
secs, 2 B in + 10 B out, state=wait-input) in=699 outFeb 19 20:57:24 imap(user
at d9c.eu)<30656><PuD+1pVl1a3CJ7cC>: Info:
Connection closed (IDLE running for 0.001 + waiting input for 1123.798
secs, 2 B in + 10 B out, state=wait-input) in=91 out=1
Feb 19 21:02:15 imap(user at d9c.eu)<30999><IS1w55VlKKrDJbhD>: Info:
Connection closed (IDLE running for 0.001 + waiting input for 1143.235
secs, 2 B in + 10 B out, state=wait-input) in=686 outFeb 19 21:02:23 imap(user
at d9c.eu)<30998><5B5v55VlJqrDJbhD>: Info:
Connection closed (IDLE running for 0.001 + waiting input for 1147.566
secs, 2 B in + 10 B out, state=wait-input) in=99 out=1
Feb 19 21:08:36 imap(user at d9c.eu)<30657><D7QC15Vl1q3CJ7cC>: Info:
Disconnected for inactivity in=91 out=919 deleted=0 expunged=0 trashed=0
hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
Feb 19 21:08:37 imap(user at d9c.eu)<30658><n6EG15Vl163CJ7cC>: Info:
Disconnected for inactivity in=719 out=5345 deleted=0 expunged=0
trashed=0 hdr_count=0 hdr_bytes=0 body_count=0 body_bytes=0
dovecot -n
# 2.3.0 (c8b89eb): /etc/dovecot/dovecot.conf
# Pigeonhole version 0.5.0.1 (d33dca20)
# OS: Linux 4.15.3-2-ARCH x86_64
auth_debug = yes
auth_mechanisms = plain login
auth_verbose = yes
debug_log_path = /var/log/dovecot-debug.log
info_log_path = /var/log/dovecot.log
login_log_format_elements = user=<%u> method=%m rip=%r lip=%l mpid=%e %c
%k
mail_gid = vmail
mail_home = /app/vmail/%d/%n
mail_location = sdbox:%h/sdbox
mail_plugins = " quota"
mail_uid = vmail
managesieve_notify_capability = mailto
managesieve_sieve_capability = fileinto reject envelope
encoded-character vacation subaddress comparator-i;ascii-numeric
relational regex imap4flags copy include variables body enotify
environment mailbox date index ihave duplicate mime foreverypart
extracttext editheader
mdbox_rotate_interval = 1 days
mdbox_rotate_size = 8 M
namespace inbox {
inbox = yes
location mailbox Drafts {
special_use = \Drafts
}
mailbox Junk {
special_use = \Junk
}
mailbox Sent {
special_use = \Sent
}
mailbox "Sent Messages" {
special_use = \Sent
}
mailbox Trash {
special_use = \Trash
}
prefix }
passdb {
args = /etc/dovecot/dovecot-sql.conf.ext
driver = sql
}
plugin {
quota = dict:user::file:%h/mdbox/dovecot-quota
sieve = ~/.dovecot.sieve
sieve_dir = ~/sieve
sieve_extensions = +editheader
}
protocols = imap pop3 lmtp sieve
service auth-worker {
user = $default_internal_user
}
service auth {
unix_listener /var/spool/postfix-sasl/private/auth {
group = postfix
mode = 0660
user = postfix
}
}
service imap-login {
chroot executable = imap-login -D
inet_listener imap {
port = 143
}
inet_listener imaps {
port = 0
}
service_count = 0
}
service lmtp {
unix_listener /var/spool/postfix-mail/private/dovecot-lmtp {
group = postfix
mode = 0660
user = postfix
}
}
service managesieve-login {
inet_listener sieve {
port = 4190
}
process_min_avail = 1
}
service pop3-login {
inet_listener pop3 {
port = 0
}
inet_listener pop3s {
port = 995
ssl = yes
}
}
ssl = required
ssl_cert = </etc/cert.ec.crt
ssl_cipher_list =
ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES128-GCM-SHA256
ssl_dh = # hidden, use -P to show it
ssl_key = # hidden, use -P to show it
ssl_min_protocol = TLSv1.2
ssl_prefer_server_ciphers = yes
userdb {
driver = prefetch
}
userdb {
driver = static
}
protocol lmtp {
mail_plugins = " quota sieve"
}
protocol imap {
imap_client_workarounds = tb-extra-mailbox-sep
mail_max_userip_connections = 25
mail_plugins = " quota imap_quota"
}
(gdb) bt full
#0 0x00007fddd9433860 in raise () from /usr/lib/libc.so.6
No symbol table info available.
#1 0x00007fddd9434ec9 in abort () from /usr/lib/libc.so.6
No symbol table info available.
#2 0x00007fddd987a521 in default_fatal_finish (type=LOG_TYPE_PANIC,
status=status at entry=0) at failures.c:228
backtrace = 0x561a9c8612f0
"/usr/lib/dovecot/libdovecot.so.0(+0xc4567) [0x7fddd987a567] ->
/usr/lib/dovecot/libdovecot.so.0(+0xc462a) [0x7fddd987a62a] ->
/usr/lib/dovecot/libdovecot.so.0(i_fatal+0) [0x7fddd97e9df9] ->
/usr/lib/d"...
recursed = 0
#3 0x00007fddd987a62a in i_internal_fatal_handler (ctx=0x7ffdbd74cd70,
format=<optimized out>, args=<optimized out>) at failures.c:718
status = 0
#4 0x00007fddd97e9df9 in i_panic (format=format at entry=0x7fddd9b35a88
"file %s: line %d (%s): assertion failed: (%s)") at failures.c:306
ctx = {type = LOG_TYPE_PANIC, exit_status = 0, timestamp = 0x0,
timestamp_usecs = 0, log_prefix = 0x0}
args = {{gp_offset = 40, fp_offset = 48, overflow_arg_area =
0x7ffdbd74ce70, reg_save_area = 0x7ffdbd74cdb0}}
#5 0x00007fddd9b2e2e9 in client_destroy (client=<optimized out>,
reason=reason at entry=0x7fddd9b35e21 "Disconnected: Shutting down")
at
client-common.c:272
__func__ = "client_destroy"
#6 0x00007fddd9b2e624 in clients_destroy_all_reason
(reason=0x7fddd9b35e21 "Disconnected: Shutting down") at
client-common.c:430
client = <optimized out>
next = 0x0
#7 0x0000561a9aeeb12a in imap_login_deinit () at
imap-login-client.c:764
No locals.
#8 0x00007fddd9b34587 in main_deinit () at main.c:475
strp = <optimized out>
strp = <optimized out>
strp_end = <optimized out>
#9 login_binary_run (binary=<optimized out>, argc=<optimized out>,
argv=<optimized out>) at main.c:550
set_pool = 0x561a9c86b100
login_socket = 0x7fddd9b37ab9 "login"
c = <optimized out>
#10 0x00007fddd941ff4a in __libc_start_main () from /usr/lib/libc.so.6
No symbol table info available.
#11 0x0000561a9aeeaeaa in _start ()
No symbol table info available.
(gdb)
Possibly Parallel Threads
Wisdom of the Ancients
