[Dovecot] [Dovecot auth crash]

Jeremy SPIESSER jeremy at azuria.net
Thu Jan 16 04:09:21 EET 2014


Hi,
I have a problem with dovecot auth and i don't know what happen ..
running dovecot 2.1.7

When i try a login with user there is a crash in auth process:

Jan 16 02:56:52 az-mail14 dovecot: auth: Panic: file auth-request.c: 
line 618 (auth_request_is_disabled_master_user): assertion failed: 
(request->requested_login_user != NULL)
Jan 16 02:56:52 az-mail14 dovecot: auth: Error: Raw backtrace: 
/usr/lib/dovecot/libdovecot.so.0(+0x4414a) [0x7fcc4b30d14a] -> 
/usr/lib/dovecot/libdovecot.so.0(+0x4418e) [0x7fcc4b30d18e] -> 
/usr/lib/dovecot/libdovecot.so.0(i_fatal+0) [0x7fcc4b2e482a] -> 
dovecot/auth(+0x14af2) [0x7fcc4b78eaf2] -> 
dovecot/auth(auth_request_verify_plain+0x22) [0x7fcc4b790102] -> 
dovecot/auth(+0x1da10) [0x7fcc4b797a10] -> 
dovecot/auth(auth_request_handler_auth_continue+0xe2) [0x7fcc4b791cf2] 
-> dovecot/auth(+0x10420) [0x7fcc4b78a420] -> 
/usr/lib/dovecot/libdovecot.so.0(io_loop_call_io+0x36) [0x7fcc4b31a016] 
-> /usr/lib/dovecot/libdovecot.so.0(io_loop_handler_run+0xa7) 
[0x7fcc4b31acc7] -> /usr/lib/dovecot/libdovecot.so.0(io_loop_run+0x28) 
[0x7fcc4b319a28] -> 
/usr/lib/dovecot/libdovecot.so.0(master_service_run+0x13) 
[0x7fcc4b306483] -> dovecot/auth(main+0x323) [0x7fcc4b788863] -> 
/lib/x86_64-linux-gnu/libc.so.6(__libc_start_main+0xfd) [0x7fcc4a70cead] 
-> dovecot/auth(+0xea75) [0x7fcc4b788a75]
Jan 16 02:56:52 az-mail14 dovecot: auth: Fatal: master: service(auth): 
child 28622 killed with signal 6 (core dumps disabled)
Jan 16 02:56:52 az-mail14 dovecot: imap-login: Warning: Auth connection 
closed with 1 pending requests (max 0 secs, pid=28621, EOF)
Jan 16 02:56:53 az-mail14 dovecot: auth: Panic: file auth-request.c: 
line 618 (auth_request_is_disabled_master_user): assertion failed: 
(request->requested_login_user != NULL)
Jan 16 02:56:53 az-mail14 dovecot: auth: Error: Raw backtrace: 
/usr/lib/dovecot/libdovecot.so.0(+0x4414a) [0x7f262370d14a] -> 
/usr/lib/dovecot/libdovecot.so.0(+0x4418e) [0x7f262370d18e] -> 
/usr/lib/dovecot/libdovecot.so.0(i_fatal+0) [0x7f26236e482a] -> 
dovecot/auth(+0x14af2) [0x7f2623b8eaf2] -> 
dovecot/auth(auth_request_verify_plain+0x22) [0x7f2623b90102] -> 
dovecot/auth(+0x1da10) [0x7f2623b97a10] -> dovecot/auth(+0x127f3) 
[0x7f2623b8c7f3] -> /usr/lib/dovecot/libdovecot.so.0(+0x390e5) 
[0x7f26237020e5] -> 
/usr/lib/dovecot/libdovecot.so.0(io_loop_call_io+0x36) [0x7f262371a016] 
-> /usr/lib/dovecot/libdovecot.so.0(io_loop_handler_run+0xa7) 
[0x7f262371acc7] -> /usr/lib/dovecot/libdovecot.so.0(io_loop_run+0x28) 
[0x7f2623719a28] -> 
/usr/lib/dovecot/libdovecot.so.0(master_service_run+0x13) 
[0x7f2623706483] -> dovecot/auth(main+0x323) [0x7f2623b88863] -> 
/lib/x86_64-linux-gnu/libc.so.6(__libc_start_main+0xfd) [0x7f2622b0cead] 
-> dovecot/auth(+0xea75) [0x7f2623b88a75]
Jan 16 02:56:53 az-mail14 dovecot: auth: Fatal: master: service(auth): 
child 28632 killed with signal 6 (core dumps disabled)
Jan 16 02:56:53 az-mail14 dovecot: imap-login: Warning: Auth connection 
closed with 1 pending requests (max 0 secs, pid=28621, EOF)
Jan 16 02:57:13 az-mail14 dovecot: imap-login: Disconnected (auth 
process communication failure): user=<>, method=PLAIN, rip=172.16.21.3, 
lip=172.16.21.100, TLS, session=<yDZIvQzwogCsEBUD>

Dovecot run with this config file:

# 2.1.7: /etc/dovecot/dovecot.conf
# OS: Linux 3.2.0-4-amd64 x86_64 Debian 7.3 ext4
auth_anonymous_username = anonymous
auth_cache_negative_ttl = 1 hours
auth_cache_size = 0
auth_cache_ttl = 1 hours
auth_debug = no
auth_debug_passwords = no
auth_default_realm =
auth_failure_delay = 2 secs
auth_first_valid_uid = 500
auth_gssapi_hostname =
auth_krb5_keytab =
auth_last_valid_uid = 0
auth_master_user_separator =
auth_mechanisms = plain
auth_proxy_self =
auth_realms =
auth_socket_path = auth-userdb
auth_ssl_require_client_cert = no
auth_ssl_username_from_cert = no
auth_use_winbind = no
auth_username_chars = 
abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ01234567890.-_@
auth_username_format = %Lu
auth_username_translation =
auth_verbose = no
auth_verbose_passwords = no
auth_winbind_helper_path = /usr/bin/ntlm_auth
auth_worker_max_count = 30
base_dir = /var/run/dovecot
config_cache_size = 1 M
debug_log_path =
default_client_limit = 10000
default_idle_kill = 1 mins
default_internal_user = dovecot
default_login_user = dovenull
default_process_limit = 1000
default_vsz_limit = 1 G
deliver_log_format = msgid=%m: %$
dict_db_config =
director_doveadm_port = 0
director_mail_servers =
director_servers =
director_user_expire = 15 mins
director_username_hash = %u
disable_plaintext_auth = yes
dotlock_use_excl = no
doveadm_allowed_commands =
doveadm_password =
doveadm_proxy_port = 0
doveadm_socket_path = doveadm-server
doveadm_worker_count = 0
dsync_alt_char = _
dsync_remote_cmd = ssh -l%{login} %{host} doveadm dsync-server -u%u 
-l%{lock_timeout} -n%{namespace}
first_valid_gid = 1
first_valid_uid = 500
hostname =
imap_capability =
imap_client_workarounds =
imap_id_log =
imap_id_send =
imap_idle_notify_interval = 2 mins
imap_logout_format = in=%i out=%o
imap_max_line_length = 64 k
imapc_features =
imapc_host =
imapc_list_prefix =
imapc_master_user =
imapc_password =
imapc_port = 143
imapc_rawlog_dir =
imapc_ssl = no
imapc_ssl_ca_dir =
imapc_ssl_verify = yes
imapc_user = %u
import_environment = TZ
info_log_path =
instance_name = dovecot
last_valid_gid = 0
last_valid_uid = 0
lda_mailbox_autocreate = no
lda_mailbox_autosubscribe = no
lda_original_recipient_header =
libexec_dir = /usr/lib/dovecot
listen = *, ::
lmtp_proxy = no
lmtp_save_to_detail_mailbox = no
lock_method = fcntl
log_path = syslog
log_timestamp = "%b %d %H:%M:%S "
login_access_sockets =
login_greeting = Dovecot ready.
login_log_format = %$: %s
login_log_format_elements = user=<%u> method=%m rip=%r lip=%l mpid=%e %c 
session=<%{session}>
login_trusted_networks =
mail_access_groups =
mail_attachment_dir =
mail_attachment_fs = sis posix
mail_attachment_hash = %{sha1}
mail_attachment_min_size = 128 k
mail_cache_fields = flags
mail_cache_min_mail_count = 10
mail_chroot =
mail_debug = no
mail_fsync = optimized
mail_full_filesystem_access = no
mail_gid =
mail_home =
mail_location = maildir:/data/vmail/%d/%n/Maildir:INDEX=/dev/shm/dovindex/%u
mail_log_prefix = "%s(%u): "
mail_max_keyword_length = 50
mail_max_lock_timeout = 0
mail_max_userip_connections = 10
mail_never_cache_fields = imap.envelope
mail_nfs_index = no
mail_nfs_storage = no
mail_plugin_dir = /usr/lib/dovecot/modules
mail_plugins =
mail_prefetch_count = 100
mail_privileged_group =
mail_save_crlf = no
mail_shared_explicit_inbox = yes
mail_temp_dir = /tmp
mail_temp_scan_interval = 1 weeks
mail_uid =
mailbox_idle_check_interval = 30 secs
mailbox_list_index = no
maildir_broken_filename_sizes = no
maildir_copy_with_hardlinks = yes
maildir_stat_dirs = no
maildir_very_dirty_syncs = no
managesieve_client_workarounds =
managesieve_implementation_string = Dovecot Pigeonhole
managesieve_logout_format = bytes=%i/%o
managesieve_max_compile_errors = 5
managesieve_max_line_length = 65536
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
master_user_separator =
mbox_dirty_syncs = yes
mbox_dotlock_change_timeout = 2 mins
mbox_lazy_writes = yes
mbox_lock_timeout = 5 mins
mbox_md5 = apop3d
mbox_min_index_size = 0
mbox_read_locks = fcntl
mbox_very_dirty_syncs = no
mbox_write_locks = dotlock fcntl
mdbox_preallocate_space = no
mdbox_rotate_interval = 0
mdbox_rotate_size = 2 M
mmap_disable = yes
passdb {
   args = /data/vmail/conf/dovecot_shadow
   default_fields =
   deny = no
   driver = passwd-file
   master = yes
   override_fields =
   pass = no
}
plugin {
   sieve = ~/.dovecot.sieve
   sieve_dir = ~/sieve
}
pop3_client_workarounds =
pop3_enable_last = no
pop3_fast_size_lookups = no
pop3_lock_session = no
pop3_logout_format = top=%t/%p, retr=%r/%b, del=%d/%m, size=%s
pop3_no_flag_updates = no
pop3_reuse_xuidl = no
pop3_save_uidl = no
pop3_uidl_duplicates = allow
pop3_uidl_format = %08Xu%08Xv
pop3c_host =
pop3c_password =
pop3c_port = 110
pop3c_rawlog_dir =
pop3c_ssl = no
pop3c_ssl_ca_dir =
pop3c_ssl_verify = yes
pop3c_user = %u
postmaster_address =
protocols =
quota_full_tempfail = no
recipient_delimiter = +
rejection_reason = Your message to <%t> was automatically rejected:%n%r
rejection_subject = Rejected: %s
replication_full_sync_interval = 12 hours
replication_max_conns = 10
replicator_host = replicator
replicator_port = 0
sendmail_path = /usr/sbin/sendmail
service aggregator {
   chroot = .
   client_limit = 0
   drop_priv_before_exec = no
   executable = aggregator
   extra_groups =
   fifo_listener replication-notify-fifo {
     group =
     mode = 0600
     user =
   }
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener replication-notify {
     group =
     mode = 0600
     user =
   }
   user = $default_internal_user
   vsz_limit = 18446744073709551615 B
}
service anvil {
   chroot = empty
   client_limit = 0
   drop_priv_before_exec = no
   executable = anvil
   extra_groups =
   group =
   idle_kill = 4294967295 secs
   privileged_group =
   process_limit = 1
   process_min_avail = 1
   protocol =
   service_count = 0
   type = anvil
   unix_listener anvil-auth-penalty {
     group =
     mode = 0600
     user =
   }
   unix_listener anvil {
     group =
     mode = 0600
     user =
   }
   user = $default_internal_user
   vsz_limit = 18446744073709551615 B
}
service auth-worker {
   chroot =
   client_limit = 1
   drop_priv_before_exec = no
   executable = auth -w
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol =
   service_count = 1
   type =
   unix_listener auth-worker {
     group =
     mode = 0600
     user = $default_internal_user
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service auth {
   chroot =
   client_limit = 0
   drop_priv_before_exec = no
   executable = auth
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 1
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener auth-client {
     group =
     mode = 0600
     user =
   }
   unix_listener auth-login {
     group =
     mode = 0600
     user = $default_internal_user
   }
   unix_listener auth-master {
     group =
     mode = 0600
     user =
   }
   unix_listener auth-userdb {
     group =
     mode = 0666
     user = $default_internal_user
   }
   unix_listener login/login {
     group =
     mode = 0666
     user =
   }
   user = $default_internal_user
   vsz_limit = 18446744073709551615 B
}
service config {
   chroot =
   client_limit = 0
   drop_priv_before_exec = no
   executable = config
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol =
   service_count = 0
   type = config
   unix_listener config {
     group =
     mode = 0600
     user =
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service dict {
   chroot =
   client_limit = 1
   drop_priv_before_exec = no
   executable = dict
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener dict {
     group =
     mode = 0600
     user =
   }
   user = $default_internal_user
   vsz_limit = 18446744073709551615 B
}
service director {
   chroot = .
   client_limit = 0
   drop_priv_before_exec = no
   executable = director
   extra_groups =
   fifo_listener login/proxy-notify {
     group =
     mode = 00
     user =
   }
   group =
   idle_kill = 4294967295 secs
   privileged_group =
   process_limit = 1
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener director-admin {
     group =
     mode = 0600
     user =
   }
   unix_listener login/director {
     group =
     mode = 00
     user =
   }
   user = $default_internal_user
   vsz_limit = 18446744073709551615 B
}
service dns_client {
   chroot =
   client_limit = 1
   drop_priv_before_exec = no
   executable = dns-client
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener dns-client {
     group =
     mode = 0666
     user =
   }
   unix_listener login/dns-client {
     group =
     mode = 0666
     user =
   }
   user = $default_internal_user
   vsz_limit = 18446744073709551615 B
}
service doveadm {
   chroot =
   client_limit = 1
   drop_priv_before_exec = no
   executable = doveadm-server
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol =
   service_count = 1
   type =
   unix_listener doveadm-server {
     group =
     mode = 0600
     user =
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service imap-login {
   chroot = login
   client_limit = 0
   drop_priv_before_exec = no
   executable = imap-login
   extra_groups =
   group =
   idle_kill = 0
   inet_listener imap {
     address =
     port = 143
     ssl = no
   }
   inet_listener imaps {
     address =
     port = 993
     ssl = yes
   }
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol = imap
   service_count = 1
   type = login
   user = $default_login_user
   vsz_limit = 18446744073709551615 B
}
service imap {
   chroot =
   client_limit = 1
   drop_priv_before_exec = no
   executable = imap
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 4096
   process_min_avail = 0
   protocol = imap
   service_count = 1
   type =
   unix_listener login/imap {
     group =
     mode = 0666
     user =
   }
   user =
   vsz_limit = 1 G
}
service indexer-worker {
   chroot =
   client_limit = 1
   drop_priv_before_exec = no
   executable = indexer-worker
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 10
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener indexer-worker {
     group =
     mode = 0600
     user = $default_internal_user
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service indexer {
   chroot =
   client_limit = 0
   drop_priv_before_exec = no
   executable = indexer
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 1
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener indexer {
     group =
     mode = 0666
     user =
   }
   user = $default_internal_user
   vsz_limit = 18446744073709551615 B
}
service ipc {
   chroot = empty
   client_limit = 0
   drop_priv_before_exec = no
   executable = ipc
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 1
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener ipc {
     group =
     mode = 0600
     user =
   }
   unix_listener login/ipc-proxy {
     group =
     mode = 0600
     user = $default_login_user
   }
   user = $default_internal_user
   vsz_limit = 18446744073709551615 B
}
service lmtp {
   chroot =
   client_limit = 1
   drop_priv_before_exec = no
   executable = lmtp
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol = lmtp
   service_count = 0
   type =
   unix_listener lmtp {
     group =
     mode = 0666
     user =
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service log {
   chroot =
   client_limit = 0
   drop_priv_before_exec = no
   executable = log
   extra_groups =
   group =
   idle_kill = 4294967295 secs
   privileged_group =
   process_limit = 1
   process_min_avail = 0
   protocol =
   service_count = 0
   type = log
   unix_listener log-errors {
     group =
     mode = 0600
     user =
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service managesieve-login {
   chroot = login
   client_limit = 0
   drop_priv_before_exec = no
   executable = managesieve-login
   extra_groups =
   group =
   idle_kill = 0
   inet_listener sieve {
     address =
     port = 4190
     ssl = no
   }
   inet_listener sieve_deprecated {
     address =
     port = 2000
     ssl = no
   }
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol = sieve
   service_count = 1
   type = login
   user = $default_login_user
   vsz_limit = 18446744073709551615 B
}
service managesieve {
   chroot =
   client_limit = 1
   drop_priv_before_exec = no
   executable = managesieve
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol = sieve
   service_count = 1
   type =
   unix_listener login/sieve {
     group =
     mode = 0666
     user =
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service pop3-login {
   chroot = login
   client_limit = 0
   drop_priv_before_exec = no
   executable = pop3-login
   extra_groups =
   group =
   idle_kill = 0
   inet_listener pop3 {
     address =
     port = 110
     ssl = no
   }
   inet_listener pop3s {
     address =
     port = 995
     ssl = yes
   }
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol = pop3
   service_count = 1
   type = login
   user = $default_login_user
   vsz_limit = 18446744073709551615 B
}
service pop3 {
   chroot =
   client_limit = 1
   drop_priv_before_exec = no
   executable = pop3
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 1024
   process_min_avail = 0
   protocol = pop3
   service_count = 1
   type =
   unix_listener login/pop3 {
     group =
     mode = 0666
     user =
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service replicator {
   chroot =
   client_limit = 0
   drop_priv_before_exec = no
   executable = replicator
   extra_groups =
   group =
   idle_kill = 4294967295 secs
   privileged_group =
   process_limit = 1
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener replicator {
     group =
     mode = 0600
     user = $default_internal_user
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service ssl-params {
   chroot =
   client_limit = 0
   drop_priv_before_exec = no
   executable = ssl-params
   extra_groups =
   group =
   idle_kill = 0
   privileged_group =
   process_limit = 0
   process_min_avail = 0
   protocol =
   service_count = 0
   type = startup
   unix_listener login/ssl-params {
     group =
     mode = 0666
     user =
   }
   user =
   vsz_limit = 18446744073709551615 B
}
service stats {
   chroot = empty
   client_limit = 0
   drop_priv_before_exec = no
   executable = stats
   extra_groups =
   fifo_listener stats-mail {
     group =
     mode = 0600
     user =
   }
   group =
   idle_kill = 4294967295 secs
   privileged_group =
   process_limit = 1
   process_min_avail = 0
   protocol =
   service_count = 0
   type =
   unix_listener stats {
     group =
     mode = 0600
     user =
   }
   user = $default_internal_user
   vsz_limit = 18446744073709551615 B
}
shutdown_clients = yes
ssl = yes
ssl_ca = </etc/ssl/gandi.pem
ssl_cert = </etc/ssl/cert-azuria.net.crt
ssl_cert_username_field = commonName
ssl_cipher_list = ALL:!LOW:!SSLv2:!EXP:!aNULL
ssl_client_cert =
ssl_client_key =
ssl_crypto_device =
ssl_key = </etc/ssl/azuria.key
ssl_key_password =
ssl_parameters_regenerate = 1 weeks
ssl_protocols = !SSLv2
ssl_require_crl = yes
ssl_verify_client_cert = no
stats_command_min_time = 1 mins
stats_domain_min_time = 12 hours
stats_ip_min_time = 12 hours
stats_memory_limit = 16 M
stats_session_min_time = 15 mins
stats_user_min_time = 1 hours
submission_host =
syslog_facility = mail
userdb {
   args = uid=1003 gid=1003 home=/data/vmail/%d/%n/Maildir
   default_fields =
   driver = static
   override_fields =
}
valid_chroot_dirs =
verbose_proctitle = no
verbose_ssl = no
version_ignore = no
protocol imap {
   imap_idle_notify_interval = 2 mins
   imap_max_line_length = 1 M
   mail_max_userip_connections = 10000
}
protocol pop3 {
   pop3_enable_last = yes
   pop3_fast_size_lookups = no
   pop3_uidl_format = %08Xu%08Xv
}
protocol lda {
   auth_socket_path = /var/run/dovecot/auth-userdb
   log_path = /data/vmail/log/dovecot-deliver.log
   mail_plugins = cmusieve quota
   postmaster_address = postmaster at azuria.net
}


I try to find answers on forums and the internet but I found nothing.
Can you help me with this problem?

Thanks you!



-- 
-- 
*Jeremy SPIESSER
*
	34 bd des Italiens 75009 Paris
*tel:*01 44 54 30 00
*mob:*06 22 12 81 75
*fax:*01 70 24 83 67
www.azuria.net <http://www.azuria.net/>
prefix et peering <https://lg.azuria.net/>

-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: image/jpeg
Size: 2123 bytes
Desc: not available
URL: <http://dovecot.org/pipermail/dovecot/attachments/20140116/2fc43b83/attachment-0001.jpe>


More information about the dovecot mailing list