[Dovecot] uid=error and BUG: Unknown internal error dovecot 2.0.13
Hi Timo, i have a few ( not really many ) errors like this with lmtp
Jun 7 09:41:23 mail02 dovecot: lmtp(11034, user@user.de): DELlOoq+7U0aKwAAZA6IsQ: msgid=<4DEDD502.705020@ameriton.com>: save failed to INBOX: BUG: Unknown internal error
Jun 7 09:36:22 mail01 dovecot: lmtp(26456, user@user.de): save: box=INBOX, uid=error, msgid=<OF671FDBE9.DD479224-ONC12578A8.00282832-C12578A8.0029C38D@hella.com>, size=7192
any idea ? is it critical, possible to loose mails with this ?
system are two postfix/dovecot servers with drbd and ocfs2 store behind load balancers
-- Best Regards
MfG Robert Schetterer
Germany/Munich/Bavaria
On Tue, 2011-06-07 at 15:23 +0200, Robert Schetterer wrote:
Hi Timo, i have a few ( not really many ) errors like this with lmtp
Jun 7 09:41:23 mail02 dovecot: lmtp(11034, user@user.de): DELlOoq+7U0aKwAAZA6IsQ: msgid=<4DEDD502.705020@ameriton.com>: save failed to INBOX: BUG: Unknown internal error
Something went wrong. Really shouldn't be happening.
Jun 7 09:36:22 mail01 dovecot: lmtp(26456, user@user.de): save: box=INBOX, uid=error, msgid=<OF671FDBE9.DD479224-ONC12578A8.00282832-C12578A8.0029C38D@hella.com>, size=7192
Did this also get some error before that log line? Something went wrong with finding the message's UID during saving..
any idea ?
dovecot -n output would help guessing the reason.
is it critical, possible to loose mails with this ?
Shouldn't be possible to lose mails.
Am 07.06.2011 16:28, schrieb Timo Sirainen:
On Tue, 2011-06-07 at 15:23 +0200, Robert Schetterer wrote:
Hi Timo, i have a few ( not really many ) errors like this with lmtp
Jun 7 09:41:23 mail02 dovecot: lmtp(11034, user@user.de): DELlOoq+7U0aKwAAZA6IsQ: msgid=<4DEDD502.705020@ameriton.com>: save failed to INBOX: BUG: Unknown internal error
Something went wrong. Really shouldn't be happening.
Jun 7 09:36:22 mail01 dovecot: lmtp(26456, user@user.de): save: box=INBOX, uid=error, msgid=<OF671FDBE9.DD479224-ONC12578A8.00282832-C12578A8.0029C38D@hella.com>, size=7192
Did this also get some error before that log line? Something went wrong with finding the message's UID during saving..
havent super verbose logging enabled yet, this servers are massive in production with huge logs, lines found out by grep looking deeper by editor to the log i would say mail is stored whatever uid error was before and wasnt reported before ( with this small verbose )
any idea ?
dovecot -n output would help guessing the reason.
# 2.0.13 (e76a3313a46c): /etc/dovecot/dovecot.conf # OS: Linux 2.6.35-25-generic x86_64 Ubuntu 10.04.2 LTS auth_mechanisms = plain login auth_socket_path = /var/run/dovecot/auth-userdb auth_verbose = yes auth_verbose_passwords = plain auth_worker_max_count = 300 default_client_limit = 1024 default_process_limit = 512 dict { quotadict = mysql:/etc/dovecot/dovecot-dict-quota-sql.conf.ext } disable_plaintext_auth = no first_valid_gid = 1001 first_valid_uid = 1001 hostname = host.host.de last_valid_gid = 1001 last_valid_uid = 1001 listen = * login_greeting = imap, pop ready mail_access_groups = vmail mail_fsync = always mail_gid = 1001 mail_location = maildir:~/ mail_nfs_index = yes mail_nfs_storage = yes mail_plugins = fts fts_squat mail_log autocreate notify mail_privileged_group = vmail mail_uid = 1001 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 mmap_disable = yes namespace default { hidden = no inbox = yes list = yes location = prefix = separator = / subscriptions = yes type = private } passdb { args = /etc/dovecot/dovecot-sql.conf.ext driver = sql } plugin { autocreate = Trash autocreate2 = Junk autocreate3 = Sent autocreate4 = Drafts autocreate5 = Templates autocreate6 = Archives autosubscribe = Trash autosubscribe2 = Junk autosubscribe3 = Sent autosubscribe4 = Drafts autosubscribe5 = Templates autosubscribe6 = Archives fts = squat home = /usr/local/virtual/%d/%u mail_log_events = delete undelete expunge copy mailbox_delete mailbox_rename mail_log_fields = uid box msgid size mail_log_group_events = yes quota = dict:::proxy::quotadict quota_warning = storage=95%% quota-warning 95 %u quota_warning2 = storage=80%% quota-warning 80 %u sieve = /usr/local/virtual/%d/%u/dovecot.sieve sieve_dir = /usr/local/virtual/%d/%u/sieve } postmaster_address = hostmaster@host.host.de protocols = imap pop3 lmtp sieve sendmail_path = /usr/lib/sendmail service anvil { client_limit = 10000 } service auth-worker { user = root } service auth { client_limit = 10000 unix_listener /var/spool/postfix/private/auth { group = postfix mode = 0666 user = postfix } unix_listener auth-userdb { group = vmail mode = 0666 user = vmail } } service dict { extra_groups = vmail unix_listener dict { group = vmail mode = 0660 } } service imap-login { inet_listener imap { port = 143 } inet_listener imaps { port = 993 ssl = yes } process_min_avail = 64 service_count = 1 } service imap-postlogin { executable = script-login /usr/local/bin/postlogin_imap.sh user = root } service imap { executable = imap imap-postlogin process_limit = 1024 vsz_limit = 256 M } service lmtp { unix_listener /var/spool/postfix/private/dovecot-lmtp { group = postfix mode = 0660 user = postfix } vsz_limit = 256 M } service managesieve-login { inet_listener { address = 127.0.0.1 port = 2000 } vsz_limit = 256 M } service pop3-login { inet_listener pop3 { port = 110 } inet_listener pop3s { port = 995 ssl = yes } } service pop3-postlogin { executable = script-login /usr/local/bin/postlogin_pop3.sh user = root } service pop3 { executable = pop3 pop3-postlogin process_limit = 1024 } service quota-warning { executable = script /usr/local/bin/quota-warning.sh unix_listener quota-warning { mode = 0666 user = vmail } user = vmail } ssl_ca = </etc/postfix/wildcard.pem ssl_cert = </etc/postfix/wildcard.pem ssl_key = </etc/postfix/wildcard.pem userdb { args = /etc/dovecot/dovecot-sql.conf.ext driver = sql } verbose_proctitle = yes protocol lda { mail_plugins = quota sieve mail_log notify } protocol imap { imap_client_workarounds = delay-newmail imap_id_log = * imap_id_send = * imap_idle_notify_interval = 2 mins imap_logout_format = bytes=%i/%o imap_max_line_length = 128 k mail_max_userip_connections = 100 mail_plugins = fts fts_squat mail_log autocreate notify quota imap_quota } protocol lmtp { mail_plugins = quota sieve fts fts_squat mail_log notify } protocol sieve { mail_max_userip_connections = 100 managesieve_implementation_string = Dovecot managesieve_logout_format = bytes=%i/%o } protocol pop3 { mail_max_userip_connections = 100 mail_plugins = quota mail_log fts fts_squat notify pop3_client_workarounds = outlook-no-nuls oe-ns-eoh pop3_enable_last = yes pop3_logout_format = top=%t/%p, retr=%r/%b, del=%d/%m, size=%s pop3_reuse_xuidl = no pop3_uidl_format = %g }
is it critical, possible to loose mails with this ?
Shouldn't be possible to lose mails.
nobody reported it so far
-- Best Regards
MfG Robert Schetterer
Germany/Munich/Bavaria
Am 07.06.2011 17:22, schrieb Robert Schetterer:
Am 07.06.2011 16:28, schrieb Timo Sirainen:
On Tue, 2011-06-07 at 15:23 +0200, Robert Schetterer wrote:
Hi Timo, i have a few ( not really many ) errors like this with lmtp
Jun 7 09:41:23 mail02 dovecot: lmtp(11034, user@user.de): DELlOoq+7U0aKwAAZA6IsQ: msgid=<4DEDD502.705020@ameriton.com>: save failed to INBOX: BUG: Unknown internal error
Something went wrong. Really shouldn't be happening.
Jun 7 09:36:22 mail01 dovecot: lmtp(26456, user@user.de): save: box=INBOX, uid=error, msgid=<OF671FDBE9.DD479224-ONC12578A8.00282832-C12578A8.0029C38D@hella.com>, size=7192
Did this also get some error before that log line? Something went wrong with finding the message's UID during saving..
havent super verbose logging enabled yet, this servers are massive in production with huge logs, lines found out by grep looking deeper by editor to the log i would say mail is stored whatever uid error was before and wasnt reported before ( with this small verbose )
any idea ?
dovecot -n output would help guessing the reason.
# 2.0.13 (e76a3313a46c): /etc/dovecot/dovecot.conf # OS: Linux 2.6.35-25-generic x86_64 Ubuntu 10.04.2 LTS auth_mechanisms = plain login auth_socket_path = /var/run/dovecot/auth-userdb auth_verbose = yes auth_verbose_passwords = plain auth_worker_max_count = 300 default_client_limit = 1024 default_process_limit = 512 dict { quotadict = mysql:/etc/dovecot/dovecot-dict-quota-sql.conf.ext } disable_plaintext_auth = no first_valid_gid = 1001 first_valid_uid = 1001 hostname = host.host.de last_valid_gid = 1001 last_valid_uid = 1001 listen = * login_greeting = imap, pop ready mail_access_groups = vmail mail_fsync = always mail_gid = 1001 mail_location = maildir:~/ mail_nfs_index = yes mail_nfs_storage = yes mail_plugins = fts fts_squat mail_log autocreate notify mail_privileged_group = vmail mail_uid = 1001 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 mmap_disable = yes namespace default { hidden = no inbox = yes list = yes location = prefix = separator = / subscriptions = yes type = private } passdb { args = /etc/dovecot/dovecot-sql.conf.ext driver = sql } plugin { autocreate = Trash autocreate2 = Junk autocreate3 = Sent autocreate4 = Drafts autocreate5 = Templates autocreate6 = Archives autosubscribe = Trash autosubscribe2 = Junk autosubscribe3 = Sent autosubscribe4 = Drafts autosubscribe5 = Templates autosubscribe6 = Archives fts = squat home = /usr/local/virtual/%d/%u mail_log_events = delete undelete expunge copy mailbox_delete mailbox_rename mail_log_fields = uid box msgid size mail_log_group_events = yes quota = dict:::proxy::quotadict quota_warning = storage=95%% quota-warning 95 %u quota_warning2 = storage=80%% quota-warning 80 %u sieve = /usr/local/virtual/%d/%u/dovecot.sieve sieve_dir = /usr/local/virtual/%d/%u/sieve } postmaster_address = hostmaster@host.host.de protocols = imap pop3 lmtp sieve sendmail_path = /usr/lib/sendmail service anvil { client_limit = 10000 } service auth-worker { user = root } service auth { client_limit = 10000 unix_listener /var/spool/postfix/private/auth { group = postfix mode = 0666 user = postfix } unix_listener auth-userdb { group = vmail mode = 0666 user = vmail } } service dict { extra_groups = vmail unix_listener dict { group = vmail mode = 0660 } } service imap-login { inet_listener imap { port = 143 } inet_listener imaps { port = 993 ssl = yes } process_min_avail = 64 service_count = 1 } service imap-postlogin { executable = script-login /usr/local/bin/postlogin_imap.sh user = root } service imap { executable = imap imap-postlogin process_limit = 1024 vsz_limit = 256 M } service lmtp { unix_listener /var/spool/postfix/private/dovecot-lmtp { group = postfix mode = 0660 user = postfix } vsz_limit = 256 M } service managesieve-login { inet_listener { address = 127.0.0.1 port = 2000 } vsz_limit = 256 M } service pop3-login { inet_listener pop3 { port = 110 } inet_listener pop3s { port = 995 ssl = yes } } service pop3-postlogin { executable = script-login /usr/local/bin/postlogin_pop3.sh user = root } service pop3 { executable = pop3 pop3-postlogin process_limit = 1024 } service quota-warning { executable = script /usr/local/bin/quota-warning.sh unix_listener quota-warning { mode = 0666 user = vmail } user = vmail } ssl_ca = </etc/postfix/wildcard.pem ssl_cert = </etc/postfix/wildcard.pem ssl_key = </etc/postfix/wildcard.pem userdb { args = /etc/dovecot/dovecot-sql.conf.ext driver = sql } verbose_proctitle = yes protocol lda { mail_plugins = quota sieve mail_log notify } protocol imap { imap_client_workarounds = delay-newmail imap_id_log = * imap_id_send = * imap_idle_notify_interval = 2 mins imap_logout_format = bytes=%i/%o imap_max_line_length = 128 k mail_max_userip_connections = 100 mail_plugins = fts fts_squat mail_log autocreate notify quota imap_quota } protocol lmtp { mail_plugins = quota sieve fts fts_squat mail_log notify } protocol sieve { mail_max_userip_connections = 100 managesieve_implementation_string = Dovecot managesieve_logout_format = bytes=%i/%o } protocol pop3 { mail_max_userip_connections = 100 mail_plugins = quota mail_log fts fts_squat notify pop3_client_workarounds = outlook-no-nuls oe-ns-eoh pop3_enable_last = yes pop3_logout_format = top=%t/%p, retr=%r/%b, del=%d/%m, size=%s pop3_reuse_xuidl = no pop3_uidl_format = %g }
is it critical, possible to loose mails with this ?
Shouldn't be possible to lose mails.
nobody reported it so far
i have a nearly equal setup with same errors but more rare ( not so much traffic/mailboxes )
here i found with more verbose logging
Jun 7 17:47:19 mail01 dovecot: lmtp(3554, user@user.de): Debug: Effective uid=1001, gid=1001, home=/usr/local/virtual/user.de/user@user.de/ Jun 7 17:47:19 mail01 dovecot: lmtp(3554, user@user.de): save: box=INBOX, uid=error, msgid=<42002737.2472109201307461419534.JavaMail.beawl@server.com>, size=11968
other ok logs look like i.e
Jun 7 07:24:57 mail01 dovecot: lmtp(24871, user@user.de): Debug: Effective uid=1001, gid=1001, home=/usr/local/virtual/user.de/user@user.de/ Jun 7 07:24:57 mail01 dovecot: lmtp(24871, user@user.de): save: box=INBOX/welcome, uid=1661, msgid=<20110607052457.07E04780040@www.server.com>, size=10059
perhaps this helps
-- Best Regards
MfG Robert Schetterer
Germany/Munich/Bavaria
participants (2)
-
Robert Schetterer
-
Timo Sirainen