[UPDATE]: Another Crash in service imap with version 2.2.13 - Debian Wheezy
Urban Loesch
bind at enas.net
Thu Jun 26 13:10:46 UTC 2014
Hi,
short update.
I switched back to Debian Squeeze. Same Dovecot Version 2.2.13.
The crash happens also on Squeeze.
Very strange is that the crash don't happened yesterday.
And it happens only to one certain user. Other users with the same iOS "os-version=7.1.1 (11D201)" aren't affected.
Also very strange is, that the crash doens't happen every time (I don't saw that before).
Logs in cronological order from the last attempt:
...
Jun 26 15:00:07 mailstore dovecot: imap-login: ID sent: x-session-id=1ji1xbz8fACXEq4b, x-originating-ip=CLIENT_IP, x-originating-port=51580,
x-connected-ip=PROXY_IP, x-connected-port=143, x-proxy-ttl=4: user=<>, rip=CLIENT_IP, lip=PROXY_IP, secured, session=<1ji1xbz8fACXEq4b>
Jun 26 15:00:08 mailstore dovecot: imap-login: Login: user=<user at domain.net>, method=PLAIN, rip=CLIENT_IP, lip=PROXY_IP, mpid=6407, secured,
session=<1ji1xbz8fACXEq4b>
Jun 26 15:00:08 mailstore dovecot: imap(user at domain.net pid:6407 session:<1ji1xbz8fACXEq4b>): ID sent: name=iPhone Mail, version=11D201, os=iOS,
os-version=7.1.1 (11D201)
Jun 26 15:00:09 mailstore dovecot: imap(user at domain.net pid:6407 session:<1ji1xbz8fACXEq4b>): Fatal: master: service(imap): child 6407 killed with
signal 11 (core dumped)
Jun 26 15:00:09 mailstore dovecot: imap-login: ID sent: x-session-id=hWTKxbz8gACXEq4b, x-originating-ip=CLIENT_IP, x-originating-port=51584,
x-connected-ip=PROXY_IP, x-connected-port=143, x-proxy-ttl=4: user=<>, rip=CLIENT_IP, lip=PROXY_IP, secured, session=<hWTKxbz8gACXEq4b>
Jun 26 15:00:09 mailstore dovecot: imap-login: Login: user=<user at domain.net>, method=PLAIN, rip=CLIENT_IP, lip=PROXY_IP, mpid=46064, secured,
session=<hWTKxbz8gACXEq4b>
Jun 26 15:00:09 mailstore dovecot: imap(user at domain.net pid:46064 session:<hWTKxbz8gACXEq4b>): ID sent: name=iPhone Mail, version=11D201, os=iOS,
os-version=7.1.1 (11D201)
Jun 26 15:00:09 mailstore dovecot: imap(user at domain.net pid:46064 session:<hWTKxbz8gACXEq4b>): Fatal: master: service(imap): child 46064 killed with
signal 11 (core dumped)
Jun 26 15:00:18 mailstore dovecot: imap-login: ID sent: x-session-id=M7BRxrz8iQCXEq4b, x-originating-ip=CLIENT_IP, x-originating-port=51593,
x-connected-ip=PROXY_IP, x-connected-port=143, x-proxy-ttl=4: user=<>, rip=CLIENT_IP, lip=PROXY_IP, secured, session=<M7BRxrz8iQCXEq4b>
Jun 26 15:00:18 mailstore dovecot: imap-login: Login: user=<user at domain.net>, method=PLAIN, rip=CLIENT_IP, lip=PROXY_IP, mpid=41143, secured,
session=<M7BRxrz8iQCXEq4b>
Jun 26 15:00:18 mailstore dovecot: imap(user at domain.net pid:41143 session:<M7BRxrz8iQCXEq4b>): ID sent: name=iPhone Mail, version=11D201, os=iOS,
os-version=7.1.1 (11D201)
Jun 26 15:02:17 mailstore dovecot: imap(user at domain.net pid:41143 session:<M7BRxrz8iQCXEq4b>): Connection closed bytes=341/1991 session=<M7BRxrz8iQCXEq4b>
...
The last session has been endet normallly. Very strange to me.
I think this is a problem only with that specific user and his Iphone.
On the other hand, the crash isn't fine at all.
Thanks
Urban Loesch
-------- Original-Nachricht --------
Betreff: Another Crash in service imap with version 2.2.13 - Debian Wheezy
Datum: Thu, 26 Jun 2014 09:25:27 +0200
Von: Urban Loesch <bind at enas.net>
Antwort an: Dovecot Mailing List <dovecot at dovecot.org>
An: Dovecot Mailing List <dovecot at dovecot.org>
Hi,
yesterday I updated my second server from Debian Squeeze to Debian Wheezy.
Since todaay I get the followinig errors in my logs:
Error-Log:
...
Jun 26 09:08:28 mailstore dovecot: imap(user at domain.net pid:28898 session:<iuMX3Lf8fACXLrFC>): Fatal: master: service(imap): child 28898 killed with
signal 11 (core dumped)
...
Mail-log
...
Jun 26 09:08:28 mailstore dovecot: imap-login: ID sent: x-session-id=iuMX3Lf8fACXLrFC, x-originating-ip=CLIENT_IP, x-originating-port=52092,
x-connected-ip=PROXY_IP, x-connected-port=143, x-proxy-ttl=4: user=<>, rip=CLIENT_IP, lip=PROXY_IP, secured, session=<iuMX3Lf8fACXLrFC>
Jun 26 09:08:28 mailstore dovecot: imap-login: Login: user=<user at domain.net>, method=PLAIN, rip=CLIENT_IP, lip=PROXY_IP, mpid=28898, secured,
session=<iuMX3Lf8fACXLrFC>
Jun 26 09:08:28 mailstore dovecot: imap(user at domain.net pid:28898 session:<iuMX3Lf8fACXLrFC>): ID sent: name=iPhone Mail, version=11D201, os=iOS,
os-version=7.1.1 (11D201)
Jun 26 09:08:28 mailstore dovecot: imap(user at domain.net pid:28898 session:<iuMX3Lf8fACXLrFC>): Fatal: master: service(imap): child 28898 killed with
signal 11 (core dumped)
...
I made a backtrace:
-----> start backtrace <-----
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Core was generated by `dovecot/imap'.
Program terminated with signal 11, Segmentation fault.
#0 0x0000000000000000 in ?? ()
(gdb) bt full
#0 0x0000000000000000 in ?? ()
No symbol table info available.
#1 0x00007fbf26650c44 in mailbox_save_cancel (_ctx=<optimized out>) at mail-storage.c:2116
ctx = 0xa95500
keywords = 0x0
mail = <optimized out>
#2 0x00007fbf2665104f in mailbox_save_begin (ctx=ctx at entry=0x7fff64b53048, input=0xaaaea0) at mail-storage.c:2041
box = 0xa6f800
ret = <optimized out>
#3 0x00007fbf26648bb6 in mail_storage_try_copy (mail=0xa90d20, _ctx=0x7fff64b53048) at mail-copy.c:76
ctx = 0xa95500
pmail = 0xa90d20
input = 0xaaaea0
#4 mail_storage_copy (ctx=0x0, mail=0xa90d20) at mail-copy.c:101
No locals.
#5 0x00007fbf24f12679 in notify_copy (ctx=0xa95500, mail=0xa90d20) at notify-storage.c:107
lt = 0xa8bdd0
lbox = 0xa70870
ret = <optimized out>
#6 0x00007fbf2573d06b in acl_copy (ctx=0xa95500, mail=0xa90d20) at acl-mailbox.c:435
t = <optimized out>
abox = 0xa6fe48
#7 0x00007fbf26650e8d in mailbox_copy (_ctx=_ctx at entry=0x7fff64b53190, mail=0xa90d20) at mail-storage.c:2152
ctx = 0xa95500
t = 0xa8de20
keywords = 0x0
pvt_flags = 0
backend_mail = 0xa90d20
ret = <optimized out>
__FUNCTION__ = "mailbox_copy"
#8 0x000000000040dd34 in fetch_and_copy (copy_count_r=<synthetic pointer>, src_uidset_r=<synthetic pointer>, search_args=<optimized out>,
src_trans_r=0x7fff64b53168, t=0xa8de20, move=false, client=0xa00f40) at cmd-copy.c:70
search_ctx = 0xa90a80
src_trans = 0xa8f3f0
srcset_ctx = {str = 0x9d4318, first_uid = 0, last_uid = 4294967295}
ret = 1
save_ctx = 0x0
mail = 0xa90d20
copy_count = 1
src_uidset = 0x9d4318
#9 cmd_copy_full (cmd=0xa01a50, move=false) at cmd-copy.c:123
client = 0xa00f40
dest_storage = <optimized out>
destbox = 0xa6f800
t = 0xa8de20
src_trans = <optimized out>
search_args = 0xa6e7f0
messageset = 0xa04410 "1309,1310"
mailbox = 0xa04420 "[rolmail]/Unseen"
src_uidset = <optimized out>
sync_flags = 0
imap_flags = 0
changes = {pool = 0x7fff64b53290, uid_validity = 1689596352, saved_uids = {arr = {buffer = 0x9dd0f0, element_size = 10492496}, v = 0x9dd0f0,
v_modifiable = 0x9dd0f0}, ignored_modseq_changes = 10492496, changed = false,
no_read_perm = false}
copy_count = <optimized out>
msg = <optimized out>
ret = <optimized out>
__FUNCTION__ = "cmd_copy_full"
#10 0x000000000041841c in command_exec (cmd=cmd at entry=0xa01a50) at imap-commands.c:158
hook = 0x9dd100
ret = <optimized out>
#11 0x0000000000417480 in client_command_input (cmd=cmd at entry=0xa01a50) at imap-client.c:778
client = 0xa00f40
---Type <return> to continue, or q <return> to quit---
command = <optimized out>
__FUNCTION__ = "client_command_input"
#12 0x0000000000417514 in client_command_input (cmd=0xa01a50) at imap-client.c:839
client = 0xa00f40
command = <optimized out>
__FUNCTION__ = "client_command_input"
#13 0x00000000004177f5 in client_handle_next_command (remove_io_r=<synthetic pointer>, client=0xa00f40) at imap-client.c:877
No locals.
#14 client_handle_input (client=client at entry=0xa00f40) at imap-client.c:889
_data_stack_cur_id = 3
ret = 2
remove_io = false
handled_commands = false
__FUNCTION__ = "client_handle_input"
#15 0x0000000000417ba2 in client_input (client=0xa00f40) at imap-client.c:931
cmd = <optimized out>
output = 0xa062d0
bytes = 39
__FUNCTION__ = "client_input"
#16 0x00007fbf2637478e in io_loop_call_io (io=0x9ffb60) at ioloop.c:439
ioloop = 0x9dc740
t_id = <optimized out>
__FUNCTION__ = "io_loop_call_io"
#17 0x00007fbf263757b7 in io_loop_handler_run_internal (ioloop=<optimized out>) at ioloop-epoll.c:206
ctx = 0x9dd3d0
events = 0xa955f0
event = 0x9de240
list = 0x9dee30
io = 0xa955f0
tv = {tv_sec = 29, tv_usec = 742827}
events_count = <optimized out>
msecs = <optimized out>
ret = 1
i = <optimized out>
call = <optimized out>
__FUNCTION__ = "io_loop_handler_run_internal"
#18 0x00007fbf26374819 in io_loop_call_io (io=0x9dc740) at ioloop.c:443
ioloop = 0x7fff64b533f0
t_id = 0
__FUNCTION__ = "io_loop_call_io"
#19 0x00007fbf26321a23 in master_service_run (service=0x9dc740, callback=callback at entry=0x420d20 <client_connected>) at master-service.c:566
No locals.
#20 0x000000000040c1e8 in main (argc=1, argv=0x9dc390) at main.c:410
set_roots = {0x428960, 0x0}
login_set = {auth_socket_path = 0x9d4048 "\001", postlogin_socket_path = 0x0, postlogin_timeout_secs = 60, callback = 0x420bb0
<login_client_connected>, failure_callback = 0x4208c0 <login_client_failed>, request_auth_token = 1}
service_flags = <optimized out>
storage_service_flags = <optimized out>
username = 0x9dc5d0 "@ǝ"
c = <optimized out>
-----> end backtrace <-----
Have you any idea how I can solve this?
Many thanks
Urban Loesch
doveconf -n:
# 2.2.13 (705fd8f3f485): /etc/dovecot/dovecot.conf
# OS: Linux 3.4.67-vs2.3.3.9-rol-em64t-efigpt x86_64 Debian 7.5 ext4
auth_cache_negative_ttl = 0
auth_cache_size = 40 M
auth_cache_ttl = 1 weeks
auth_mechanisms = plain login
deliver_log_format = msgid=%m: %$ %p %w
disable_plaintext_auth = no
info_log_path = syslog
login_trusted_networks = INTERNAL_IP
mail_gid = mailstore
mail_location = mdbox:/home/vmail/%d/%n
mail_log_prefix = "%s(%u pid:%p session:<%{session}>): "
mail_plugins = " quota mail_log notify acl zlib stats virtual"
mail_uid = mailstore
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 ihave duplicate imapflags notify
mdbox_rotate_size = 10 M
namespace {
list = children
location = mdbox:/home/vmail/%%d/%%n
prefix = shared/%%u/
separator = /
subscriptions = no
type = shared
}
namespace {
hidden = no
inbox = no
list = children
location = virtual:/home/virtual:INDEX=~/virtual
prefix = [mymail]/
separator = /
subscriptions = yes
type = private
}
namespace inbox {
inbox = yes
location =
mailbox Drafts {
special_use = \Drafts
}
mailbox Junk {
special_use = \Junk
}
mailbox Sent {
special_use = \Sent
}
mailbox "Sent Items" {
special_use = \Sent
}
mailbox "Sent Messages" {
special_use = \Sent
}
mailbox Trash {
special_use = \Trash
}
mailbox [mymail]/All {
auto = no
special_use = \All
}
prefix =
separator = /
type = private
}
passdb {
args = /etc/dovecot/dovecot-sql-account.conf
driver = sql
}
plugin {
acl = vfile
acl_shared_dict = file:/home/vmail/%d/shared-mailboxes
mail_log_events = delete undelete expunge copy mailbox_delete mailbox_rename flag_change save mailbox_create append
mail_log_fields = uid box msgid size from
mail_log_group_events = no
quota = dict:Storage used::file:%h/dovecot-quota
quota_rule2 = Trash:storage=+100M
quota_warning = storage=95%% quota-warning 95 %u
quota_warning2 = storage=80%% quota-warning 80 %u
sieve = ~/.dovecot.sieve
sieve_dir = ~/sieve
sieve_extensions = +notify +imapflags
sieve_max_redirects = 15
stats_command_min_time = 1 mins
stats_domain_min_time = 12 hours
stats_ip_min_time = 12 hours
stats_memory_limit = 16 M
stats_refresh = 30 secs
stats_session_min_time = 15 mins
stats_track_cmds = no
stats_user_min_time = 1 hours
zlib_save = gz
zlib_save_level = 9
}
protocols = imap pop3 lmtp sieve
service auth {
unix_listener auth-userdb {
group = mailstore
mode = 0660
user = root
}
}
service imap-login {
inet_listener imap {
port = 143
}
process_limit = 48
process_min_avail = 3
service_count = 1
}
service imap {
process_limit = 48
process_min_avail = 2
service_count = 1
}
service lmtp {
inet_listener lmtp {
port = 24
}
unix_listener /var/spool/postfix/private/dovecot-lmtp {
group = postfix
mode = 0666
user = postfix
}
}
service pop3-login {
inet_listener pop3 {
port = 110
}
process_limit = 16
process_min_avail = 2
service_count = 1
}
service pop3 {
process_limit = 16
process_min_avail = 2
service_count = 1
}
service quota-warning {
executable = script /usr/local/rol/dovecot/quota-warning.sh
unix_listener quota-warning {
user = mailstore
}
user = mailstore
}
service stats {
fifo_listener stats-mail {
mode = 0600
user = mailstore
}
}
ssl = no
ssl_cert = </etc/dovecot/certs/dovecot.pem
ssl_key = </etc/dovecot/private/dovecot.pem
userdb {
args = /etc/dovecot/dovecot-sql-account.conf
driver = sql
}
protocol lmtp {
mail_fsync = optimized
mail_plugins = " quota mail_log notify acl zlib stats virtual sieve zlib"
}
protocol imap {
imap_client_workarounds = tb-extra-mailbox-sep
imap_id_log = *
imap_logout_format = bytes=%i/%o session=<%{session}>
mail_max_userip_connections = 20
mail_plugins = " quota mail_log notify acl zlib stats virtual imap_quota imap_acl imap_zlib imap_stats"
}
protocol pop3 {
mail_plugins = " quota mail_log notify acl zlib stats virtual"
pop3_client_workarounds = outlook-no-nuls oe-ns-eoh
pop3_lock_session = yes
pop3_logout_format = bytes_sent=%o top=%t/%p, retr=%r/%b, del=%d/%m, size=%s uidl_hash=%u session=<%{session}>
pop3_reuse_xuidl = yes
}
More information about the dovecot
mailing list