[Dovecot] uid=error and BUG: Unknown internal error dovecot 2.0.13
Robert Schetterer
robert at schetterer.org
Tue Jun 7 22:30:04 EEST 2011
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 at user.de):
>>> DELlOoq+7U0aKwAAZA6IsQ: msgid=<4DEDD502.705020 at 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 at user.de): save:
>>> box=INBOX, uid=error,
>>> msgid=<OF671FDBE9.DD479224-ONC12578A8.00282832-C12578A8.0029C38D at 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 at 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 at user.de): Debug:
Effective uid=1001, gid=1001, home=/usr/local/virtual/user.de/user at user.de/
Jun 7 17:47:19 mail01 dovecot: lmtp(3554, user at user.de): save:
box=INBOX, uid=error,
msgid=<42002737.2472109201307461419534.JavaMail.beawl at server.com>,
size=11968
other ok logs look like i.e
Jun 7 07:24:57 mail01 dovecot: lmtp(24871, user at user.de): Debug:
Effective uid=1001, gid=1001, home=/usr/local/virtual/user.de/user at user.de/
Jun 7 07:24:57 mail01 dovecot: lmtp(24871, user at user.de): save:
box=INBOX/welcome, uid=1661,
msgid=<20110607052457.07E04780040 at www.server.com>, size=10059
perhaps this helps
--
Best Regards
MfG Robert Schetterer
Germany/Munich/Bavaria
More information about the dovecot
mailing list