thr3ads.net - dovecot - Extended logging / moved mails jumping back [Apr 2019]

If this information is useful, please help other people find it:
Share via:

Martin Müller

2019-Apr-13 21:54 UTC

Extended logging / moved mails jumping back

Hi!

About 4-6 MUA Thunderbird 60.6.1 are going to connect with dovecot
2.2.13/IMAP (debian 8) and are using the same user/password. This setup
works for years flawless (updated clients and serversoftware).

Since a few weeks there is one major trouble:

I one of the client moves a mail from the inbox to a another IMAP-Folder,
most of the moved mail are moved for the moment. But an unstable period
later, the mails are moved back to the inbox. In rarely cases, the moved
mail is copied (one in the inbox, one in the destinationfolder).

Now I have to check, if this a Thunderbird-Issue or is this a
dovecot-issue. For that reason, I will activate the extended logging of
dovecot.

### ### ### ###
dovecot -n
# 2.2.13: /etc/dovecot/dovecot.conf
# OS: Linux 3.16.0-6-amd64 x86_64 Debian 8.11
auth_mechanisms = plain login
debug_log_path = /var/log/mail.dovecot-debug
disable_plaintext_auth = no
info_log_path = /var/log/mail.dovecot-info
listen = *,[::]
log_path = /var/log/mail.dovecot-error
log_timestamp = "%Y-%m-%d %H:%M:%S "
mail_debug = yes
mail_max_userip_connections = 100
mail_privileged_group = vmail
passdb {
  args = /etc/dovecot/dovecot-sql.conf
  driver = sql
}
plugin {
  mail_log_events = delete undelete expunge copy mailbox_delete
mailbox_rename
  mail_log_fields = uid box msgid size
  quota = dict:user::file:/var/vmail/%d/%n/.quotausage
  sieve = /var/vmail/%d/%n/.sieve
  sieve_max_redirects = 25
}
protocols = imap pop3
service auth {
  unix_listener /var/spool/postfix/private/auth {
    group = postfix
    mode = 0660
    user = postfix
  }
  unix_listener auth-userdb {
    group = vmail
    mode = 0600
    user = vmail
  }
  user = root
}
service imap-login {
  client_limit = 1000
  process_limit = 512
}
service lmtp {
  unix_listener /var/spool/postfix/private/dovecot-lmtp {
    group = postfix
    mode = 0600
    user = postfix
  }
}
ssl_cert = </etc/postfix/smtpd.cert
ssl_key = </etc/postfix/smtpd.key
ssl_protocols = !SSLv3
userdb {
  driver = prefetch
}
userdb {
  args = /etc/dovecot/dovecot-sql.conf
  driver = sql
}
protocol imap {
  mail_plugins = quota imap_quota
}
protocol pop3 {
  mail_plugins = quota
  pop3_uidl_format = %08Xu%08Xv
}
protocol lda {
  mail_plugins = sieve quota
  postmaster_address = postmaster at monarch.products4more.at
}
protocol lmtp {
  mail_plugins = quota sieve
  postmaster_address = postmaster at monarch.products4more.at
}

### ### ### ### ### ### ### ###

It works: dovecot logs to three differnt logfiles /var/log/mail.dovecot-*
It doesnt work:

plugin {
  mail_log_events = delete undelete expunge copy mailbox_delete
mailbox_rename
  mail_log_fields = uid box msgid size
}

I cant see such events in the logfiles. Which switch is to turn on to log
all events?
Or do anyone know the reason for the annoying
"copy/move-the-mail-back"-issue?

Thank you in advance for all inputs.

regards, martin
-------------- next part --------------
An HTML attachment was scrubbed...
URL:
<https://dovecot.org/pipermail/dovecot/attachments/20190413/d3782ccd/attachment.html>

Aki Tuomi

2019-Apr-14 04:52 UTC

head link

Extended logging / moved mails jumping back

<!doctype html>
<html>
 <head> 
  <meta charset="UTF-8"> 
 </head>
 <body>
  <div>
   <br>
  </div>
  <blockquote type="cite">
   <div>
    On 14 April 2019 00:54 Martin Müller via dovecot <dovecot@dovecot.org>
wrote:
   </div>
   <div>
    <br>
   </div>
   <div>
    <br>
   </div>
   <div dir="ltr">
    <div dir="ltr">
     Hi!
     <div>
      <br>
     </div>
     <div>
      About 4-6 MUA Thunderbird 60.6.1 are going to connect with dovecot
2.2.13/IMAP (debian 8) and are using the same user/password. This setup works
for years flawless (updated clients and serversoftware).
     </div>
     <div>
      <br>
     </div>
     <div>
      Since a few weeks there is one major trouble:
     </div>
     <div>
      <br>
     </div>
     <div>
      I one of the client moves a mail from the inbox to a another IMAP-Folder,
most of the moved mail are moved for the moment. But an unstable period later,
the mails are moved back to the inbox. In rarely cases, the moved mail is copied
(one in the inbox, one in the destinationfolder).
     </div>
     <div>
      <br>
     </div>
     <div>
      Now I have to check, if this a Thunderbird-Issue or is this a
dovecot-issue. For that reason, I will activate the extended logging of dovecot.
     </div>
     <div></div>
    </div>
   </div>
  </blockquote>
  <div>
   <snip/>
  </div>
  <blockquote type="cite">
   <div dir="ltr">
    <div dir="ltr">
     <div></div>
     <div>
      I cant see such events in the logfiles. Which switch is to turn on to log
all events?
     </div>
     <div>
      Or do anyone know the reason for the annoying
"copy/move-the-mail-back"-issue?
     </div>
     <div>
      <br>
     </div>
     <div>
      Thank you in advance for all inputs.
     </div>
     <div>
      <br>
     </div>
     <div>
      regards, martin
     </div>
    </div>
   </div>
  </blockquote>
  <div>
   <br>
  </div>
  <div>
   You are missing
  </div>
  <div>
   <br>
  </div>
  <div>
   mail_plugins = $mail_plugins notify mail_log
  </div>
  <div class="io-ox-signature">
   <pre>---
Aki Tuomi</pre>
  </div> 
 </body>
</html>

Martin Müller

2019-Apr-14 10:04 UTC

head link

Extended logging / moved mails jumping back

>> Hi!
>> Now I have to check, if this a Thunderbird-Issue or is this a 
>> dovecot-issue. For that reason, I will activate the extended logging 
>> of dovecot.
> <snip/>
>> I cant see such events in the logfiles. Which switch is to turn on to 
>> log all events?
>> Or do anyone know the reason for the annoying 
>> "copy/move-the-mail-back"-issue?
>>
>> Thank you in advance for all inputs.
>>
>> regards, martin
> 
> You are missing
> 
> mail_plugins = $mail_plugins notify mail_log
Thank you - it didnt work for me (yet). But I think there is another 
problem which I have to solve first. I recognised that the maildelivery 
stops after turning on the logging to the three files.

The incomming mails are held in the mailq, in syslog appears

relay=dovecot, delay=0.13, delays=0.07/0/0/0.06, dsn=4.3.0, 
status=deferred (temporary failure. Command output: Can't open log file 
/var/log/mail.dovecot-error: Permission denied )

In /var/log/mail.dovecot-error are lines like
2019-04-14 10:16:18 auth: Warning: auth client 0 disconnected with 1 
pending requests: Connection reset by peer

Here the output of ls -la /var/log/mail.dovecot-error
-rw-r--r-- 1 root root   21259 Apr 14 11:24 /var/log/mail.dovecot-error


If I turn the extended logging off, all works fine.
`postqueue -f` releases all held mails to their boxes.

Any hints for me?


Thank you!

martin

Reasonably Related Threads

Search for more possibly parallel threads

dovecot - Apr 2019 - Extended logging / moved mails jumping back

Extended logging / moved mails jumping back

Extended logging / moved mails jumping back

Extended logging / moved mails jumping back

Reasonably Related Threads