Bug: Dovecot index loosing sync with FTS despite "fts_autoindex = yes"

kadafax at gmail.com kadafax at gmail.com
Thu Apr 19 11:30:44 EEST 2018 

I think I'm progressing: if I create a brand new user, send her an
email, it will not be indexed right away. I need to doveadm rescan /
index the Inbox before.
At the end of this email, a dovecot's debug log snipset (grep'ed on this
user). In it I can read: "Debug: fts: Indexes disabled for namespace ''
Can this be a problem ?

Thanks

doveconf -n output:
# 2.2.34 (874deae): /usr/local/etc/dovecot/dovecot.conf
# Pigeonhole version 0.4.22 (22940fb7)
# OS: Linux 3.10.0-693.17.1.el7.x86_64 x86_64 CentOS Linux release
7.4.1708 (Core)  ext4
# Hostname: mailServer.myDomain
auth_master_user_separator = *
auth_socket_path = /var/run/dovecot/auth-userdb
auth_username_chars =
abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ01234567890.-_@*
auth_verbose = yes
base_dir = /var/run/dovecot/
debug_log_path = /var/log/dovecot-debug.log
default_client_limit = 5120
default_process_limit = 1024
default_vsz_limit = 2 G
hostname = myDomain
info_log_path = /var/log/dovecot.log
lda_mailbox_autocreate = yes
lda_mailbox_autosubscribe = yes
listen = *
log_path = /var/log/dovecot-error.log
login_greeting = Welcome
login_log_format_elements = user=<%u> method=%m rip=%r lip=%l mpid=%e %c
mail_gid = vmail
mail_location = maildir:/var/vmail/%Ln
mail_plugins = " quota stats fts fts_solr"
mail_uid = vmail
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 index ihave duplicate mime foreverypart extracttext
namespace {
  inbox = yes
  location = maildir:/var/vmail/%Ln
  mailbox Drafts {
    auto = subscribe
    special_use = \Drafts
  }
  mailbox Sent {
    auto = subscribe
    special_use = \Sent
  }
  mailbox "Sent Messages" {
    special_use = \Sent
  }
  mailbox Trash {
    auto = subscribe
    special_use = \Trash
  }
  prefix =
  type = private
}
passdb {
  args = /usr/local/etc/dovecot/deny-users
  deny = yes
  driver = passwd-file
}
passdb {
  args = /usr/local/etc/dovecot/master-users
  driver = passwd-file
  master = yes
}
passdb {
  args = /usr/local/etc/dovecot/dovecot-ldap.conf.ext
  driver = ldap
}
plugin {
  fts = solr
  fts_autoindex = yes
  fts_solr = url=http://localhost:8983/solr/dovecot/ break-imap-search
  quota = maildir:User quota
  quota_rule = *:storage=20GB
  quota_rule2 = Trash:storage=+200M
  quota_warning = storage=95%% quota-warning 95 %u
  quota_warning2 = storage=80%% quota-warning 80 %u
  sieve = /var/sieve-scripts/%Ln.sieve
  sieve_dir = /var/vmail/%Ln/home/sieve
  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 = yes
  stats_user_min_time = 1 hours
}
postmaster_address = postmaster at myDomain
protocols = imap pop3 sieve sieve
service auth-worker {
  user = root
}
service auth {
  unix_listener /var/spool/postfix/private/auth {
    mode = 0777
    user = vmail
  }
}
service imap-login {
  inet_listener imaps {
    port = 993
    ssl = yes
  }
  process_min_avail = 10
}
service imap {
  process_limit = 2128
}
service managesieve-login {
  inet_listener sieve {
    port = 4190
  }
}
service pop3-login {
  inet_listener pop3s {
    port = 995
    ssl = yes
  }
}
service quota-warning {
  executable = script /usr/local/bin/quota-warning.sh
  user = nobody
}
service stats {
  fifo_listener stats-mail {
    mode = 0600
    user = vmail
  }
}
ssl_cert = </etc/letsencrypt/live/mailServer.myDomain/fullchain.pem
ssl_key =  # hidden, use -P to show it
userdb {
  args = /usr/local/etc/dovecot/dovecot-ldap-userdb.conf.ext
  driver = ldap
  override_fields = uid=vmail gid=vmail home=/var/vmail/%Ln/home
}
verbose_proctitle = yes
protocol lda {
  mail_plugins = " quota stats fts fts_solr sieve virtual"
}
protocol imap {
  mail_max_userip_connections = 20
  mail_plugins = " quota stats fts fts_solr imap_quota virtual imap_stats"
}
protocol sieve {
  mail_max_userip_connections = 20
}

DEBUG LOG:
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Loading modules from
directory: /usr/local/lib/dovecot
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_sieve_plugin.so
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: auth USER input:
NewUser at myDomain uid=992 gid=989 home=/var/vmail/NewUser/home
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Effective uid=992,
gid=989, home=/var/vmail/NewUser/home
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota root: name=User
quota backend=maildir args=
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota rule: root=User
quota mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota rule: root=User
quota mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota warning:
bytes=20401094656 (95%) messages=0 reverse=no command=quota-warning 95
NewUser at myDomain
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota warning:
bytes=17179869184 (80%) messages=0 reverse=no command=quota-warning 80
NewUser at myDomain
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota grace: root=User
quota bytes=2147483648 (10%)
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Namespace : type=private,
prefix=, sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: quota: quota_over_flag
check: quota_over_script unset - skipping
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota root: name=User
quota backend=maildir args=
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota rule: root=User
quota mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota rule: root=User
quota mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota warning:
bytes=20401094656 (95%) messages=0 reverse=no command=quota-warning 95
raw mail user
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota warning:
bytes=17179869184 (80%) messages=0 reverse=no command=quota-warning 80
raw mail user
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Quota grace: root=User
quota bytes=2147483648 (10%)
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: none: root=, index=,
indexpvt=, control=, inbox=, alt=
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: fts: Indexes disabled for
namespace ''
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: quota: quota_over_flag
check: quota_over_script unset - skipping
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Destination address:
NewUser at myDomain (source: -a parameter)
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: sieve: Pigeonhole version
0.4.22 (22940fb7) initializing
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: sieve: include:
sieve_global is not set; it is currently not possible to include
`:global' scripts.
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: sieve: file storage:
Storage path `/var/vmail/NewUser/home/sieve' not found
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: sieve: file storage: Using
Sieve script path: /var/sieve-scripts/NewUser.sieve
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: sieve: file storage:
Storage path `/var/sieve-scripts/NewUser.sieve' not found
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: sieve: storage: No default
script location configured
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: sieve: User has no
personal script
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: sieve: No scripts to
execute: reverting to default delivery.
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: INBOX: Mailbox opened
because: lib-lda delivery
Apr 19 10:23:26 lda(NewUser at myDomain): Debug: Mailbox stdin: Opened mail
UID=1 because: copying
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: auth USER
input: NewUser at myDomain uid=992 gid=989 home=/var/vmail/NewUser/home
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Effective
uid=992, gid=989, home=/var/vmail/NewUser/home
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Quota root:
name=User quota backend=maildir args=
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Quota rule:
root=User quota mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Quota rule:
root=User quota mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Quota warning:
bytes=20401094656 (95%) messages=0 reverse=no command=quota-warning 95
NewUser at myDomain
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Quota warning:
bytes=17179869184 (80%) messages=0 reverse=no command=quota-warning 80
NewUser at myDomain
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Quota grace:
root=User quota bytes=2147483648 (10%)
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Namespace :
type=private, prefix=, sep=, inbox=yes, hidden=no, list=yes,
subscriptions=yes location=maildir:/var/vmail/NewUser
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: INBOX: Mailbox
opened because: indexing
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Mailbox INBOX:
Opened mail UID=6 because: prefetch
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Mailbox INBOX:
Opened mail UID=6 because: access
Apr 19 10:23:26 indexer-worker(NewUser at myDomain): Debug: Mailbox INBOX:
Opened mail UID=6 because: fts indexing
Apr 19 10:23:50 imap(NewUser): Debug: Loading modules from directory:
/usr/local/lib/dovecot
Apr 19 10:23:50 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:23:50 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib11_imap_quota_plugin.so
Apr 19 10:23:50 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:23:50 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:23:50 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:23:50 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:23:50 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib95_imap_stats_plugin.so
Apr 19 10:23:50 imap(NewUser): Debug: Effective uid=992, gid=989,
home=/var/vmail/NewUser/home
Apr 19 10:23:50 imap(NewUser): Debug: Quota root: name=User quota
backend=maildir args=
Apr 19 10:23:50 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:50 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:50 imap(NewUser): Debug: Quota warning: bytes=20401094656
(95%) messages=0 reverse=no command=quota-warning 95 NewUser
Apr 19 10:23:50 imap(NewUser): Debug: Quota warning: bytes=17179869184
(80%) messages=0 reverse=no command=quota-warning 80 NewUser
Apr 19 10:23:50 imap(NewUser): Debug: Quota grace: root=User quota
bytes=2147483648 (10%)
Apr 19 10:23:50 imap(NewUser): Debug: Namespace : type=private, prefix=,
sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:23:50 imap(NewUser): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:50 imap(NewUser): Debug: quota: quota_over_flag check:
quota_over_script unset - skipping
Apr 19 10:23:50 imap(NewUser): Debug: INBOX: Mailbox opened because: SELECT
Apr 19 10:23:52 imap(NewUser): Debug: Loading modules from directory:
/usr/local/lib/dovecot
Apr 19 10:23:52 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:23:52 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib11_imap_quota_plugin.so
Apr 19 10:23:52 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:23:52 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:23:52 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:23:52 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:23:52 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib95_imap_stats_plugin.so
Apr 19 10:23:52 imap(NewUser): Debug: Effective uid=992, gid=989,
home=/var/vmail/NewUser/home
Apr 19 10:23:52 imap(NewUser): Debug: Quota root: name=User quota
backend=maildir args=
Apr 19 10:23:52 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:52 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:52 imap(NewUser): Debug: Quota warning: bytes=20401094656
(95%) messages=0 reverse=no command=quota-warning 95 NewUser
Apr 19 10:23:52 imap(NewUser): Debug: Quota warning: bytes=17179869184
(80%) messages=0 reverse=no command=quota-warning 80 NewUser
Apr 19 10:23:52 imap(NewUser): Debug: Quota grace: root=User quota
bytes=2147483648 (10%)
Apr 19 10:23:52 imap(NewUser): Debug: Namespace : type=private, prefix=,
sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:23:52 imap(NewUser): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:52 imap(NewUser): Debug: quota: quota_over_flag check:
quota_over_script unset - skipping
Apr 19 10:23:52 imap(NewUser): Debug: INBOX: Mailbox opened because: STATUS
Apr 19 10:23:52 imap(NewUser): Debug: INBOX: Mailbox opened because: SELECT
Apr 19 10:23:53 imap(NewUser): Debug: Loading modules from directory:
/usr/local/lib/dovecot
Apr 19 10:23:53 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:23:53 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib11_imap_quota_plugin.so
Apr 19 10:23:53 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:23:53 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:23:53 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:23:53 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:23:53 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib95_imap_stats_plugin.so
Apr 19 10:23:53 imap(NewUser): Debug: Effective uid=992, gid=989,
home=/var/vmail/NewUser/home
Apr 19 10:23:53 imap(NewUser): Debug: Quota root: name=User quota
backend=maildir args=
Apr 19 10:23:53 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:53 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:53 imap(NewUser): Debug: Quota warning: bytes=20401094656
(95%) messages=0 reverse=no command=quota-warning 95 NewUser
Apr 19 10:23:53 imap(NewUser): Debug: Quota warning: bytes=17179869184
(80%) messages=0 reverse=no command=quota-warning 80 NewUser
Apr 19 10:23:53 imap(NewUser): Debug: Quota grace: root=User quota
bytes=2147483648 (10%)
Apr 19 10:23:53 imap(NewUser): Debug: Namespace : type=private, prefix=,
sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:23:53 imap(NewUser): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:53 imap(NewUser): Debug: quota: quota_over_flag check:
quota_over_script unset - skipping
Apr 19 10:23:53 imap(NewUser): Debug: INBOX: Mailbox opened because: SELECT
Apr 19 10:23:53 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=3
because: prefetch
Apr 19 10:23:53 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=3
because: access
Apr 19 10:23:53 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=3
because: MIME part
Apr 19 10:23:54 imap(NewUser): Debug: Loading modules from directory:
/usr/local/lib/dovecot
Apr 19 10:23:54 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:23:54 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib11_imap_quota_plugin.so
Apr 19 10:23:54 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:23:54 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:23:54 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:23:54 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:23:54 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib95_imap_stats_plugin.so
Apr 19 10:23:54 imap(NewUser): Debug: Effective uid=992, gid=989,
home=/var/vmail/NewUser/home
Apr 19 10:23:54 imap(NewUser): Debug: Quota root: name=User quota
backend=maildir args=
Apr 19 10:23:54 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:54 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:54 imap(NewUser): Debug: Quota warning: bytes=20401094656
(95%) messages=0 reverse=no command=quota-warning 95 NewUser
Apr 19 10:23:54 imap(NewUser): Debug: Quota warning: bytes=17179869184
(80%) messages=0 reverse=no command=quota-warning 80 NewUser
Apr 19 10:23:54 imap(NewUser): Debug: Quota grace: root=User quota
bytes=2147483648 (10%)
Apr 19 10:23:54 imap(NewUser): Debug: Namespace : type=private, prefix=,
sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:23:54 imap(NewUser): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:54 imap(NewUser): Debug: quota: quota_over_flag check:
quota_over_script unset - skipping
Apr 19 10:23:54 imap(NewUser): Debug: INBOX: Mailbox opened because: SELECT
Apr 19 10:23:54 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=4
because: prefetch
Apr 19 10:23:54 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=4
because: access
Apr 19 10:23:54 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=4
because: MIME part
Apr 19 10:23:55 imap(NewUser): Debug: Loading modules from directory:
/usr/local/lib/dovecot
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib11_imap_quota_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib95_imap_stats_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Effective uid=992, gid=989,
home=/var/vmail/NewUser/home
Apr 19 10:23:55 imap(NewUser): Debug: Quota root: name=User quota
backend=maildir args=
Apr 19 10:23:55 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:55 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:55 imap(NewUser): Debug: Quota warning: bytes=20401094656
(95%) messages=0 reverse=no command=quota-warning 95 NewUser
Apr 19 10:23:55 imap(NewUser): Debug: Quota warning: bytes=17179869184
(80%) messages=0 reverse=no command=quota-warning 80 NewUser
Apr 19 10:23:55 imap(NewUser): Debug: Quota grace: root=User quota
bytes=2147483648 (10%)
Apr 19 10:23:55 imap(NewUser): Debug: Namespace : type=private, prefix=,
sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:23:55 imap(NewUser): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:55 imap(NewUser): Debug: quota: quota_over_flag check:
quota_over_script unset - skipping
Apr 19 10:23:55 imap(NewUser): Debug: INBOX: Mailbox opened because: SELECT
Apr 19 10:23:55 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=5
because: prefetch
Apr 19 10:23:55 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=5
because: access
Apr 19 10:23:55 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=5
because: MIME part
Apr 19 10:23:55 imap(NewUser): Debug: Loading modules from directory:
/usr/local/lib/dovecot
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib11_imap_quota_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib95_imap_stats_plugin.so
Apr 19 10:23:55 imap(NewUser): Debug: Effective uid=992, gid=989,
home=/var/vmail/NewUser/home
Apr 19 10:23:55 imap(NewUser): Debug: Quota root: name=User quota
backend=maildir args=
Apr 19 10:23:55 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:55 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:55 imap(NewUser): Debug: Quota warning: bytes=20401094656
(95%) messages=0 reverse=no command=quota-warning 95 NewUser
Apr 19 10:23:55 imap(NewUser): Debug: Quota warning: bytes=17179869184
(80%) messages=0 reverse=no command=quota-warning 80 NewUser
Apr 19 10:23:55 imap(NewUser): Debug: Quota grace: root=User quota
bytes=2147483648 (10%)
Apr 19 10:23:55 imap(NewUser): Debug: Namespace : type=private, prefix=,
sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:23:55 imap(NewUser): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:55 imap(NewUser): Debug: quota: quota_over_flag check:
quota_over_script unset - skipping
Apr 19 10:23:55 imap(NewUser): Debug: INBOX: Mailbox opened because: SELECT
Apr 19 10:23:55 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=6
because: prefetch
Apr 19 10:23:55 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=6
because: access
Apr 19 10:23:55 imap(NewUser): Debug: Mailbox INBOX: Opened mail UID=6
because: MIME part
Apr 19 10:23:57 imap(NewUser): Debug: Loading modules from directory:
/usr/local/lib/dovecot
Apr 19 10:23:57 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:23:57 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib11_imap_quota_plugin.so
Apr 19 10:23:57 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:23:57 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:23:57 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:23:57 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:23:57 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib95_imap_stats_plugin.so
Apr 19 10:23:57 imap(NewUser): Debug: Effective uid=992, gid=989,
home=/var/vmail/NewUser/home
Apr 19 10:23:57 imap(NewUser): Debug: Quota root: name=User quota
backend=maildir args=
Apr 19 10:23:57 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:57 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:57 imap(NewUser): Debug: Quota warning: bytes=20401094656
(95%) messages=0 reverse=no command=quota-warning 95 NewUser
Apr 19 10:23:57 imap(NewUser): Debug: Quota warning: bytes=17179869184
(80%) messages=0 reverse=no command=quota-warning 80 NewUser
Apr 19 10:23:57 imap(NewUser): Debug: Quota grace: root=User quota
bytes=2147483648 (10%)
Apr 19 10:23:57 imap(NewUser): Debug: Namespace : type=private, prefix=,
sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:23:57 imap(NewUser): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:57 imap(NewUser): Debug: quota: quota_over_flag check:
quota_over_script unset - skipping
Apr 19 10:23:57 imap(NewUser): Debug: INBOX: Mailbox opened because: STATUS
Apr 19 10:23:57 imap(NewUser): Debug: INBOX: Mailbox opened because: SELECT
Apr 19 10:23:59 imap(NewUser): Debug: Loading modules from directory:
/usr/local/lib/dovecot
Apr 19 10:23:59 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:23:59 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib11_imap_quota_plugin.so
Apr 19 10:23:59 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:23:59 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:23:59 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:23:59 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:23:59 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib95_imap_stats_plugin.so
Apr 19 10:23:59 imap(NewUser): Debug: Effective uid=992, gid=989,
home=/var/vmail/NewUser/home
Apr 19 10:23:59 imap(NewUser): Debug: Quota root: name=User quota
backend=maildir args=
Apr 19 10:23:59 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=* bytes=21474836480 messages=0
Apr 19 10:23:59 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:23:59 imap(NewUser): Debug: Quota warning: bytes=20401094656
(95%) messages=0 reverse=no command=quota-warning 95 NewUser
Apr 19 10:23:59 imap(NewUser): Debug: Quota warning: bytes=17179869184
(80%) messages=0 reverse=no command=quota-warning 80 NewUser
Apr 19 10:23:59 imap(NewUser): Debug: Quota grace: root=User quota
bytes=2147483648 (10%)
Apr 19 10:23:59 imap(NewUser): Debug: Namespace : type=private, prefix=,
sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:23:59 imap(NewUser): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:23:59 imap(NewUser): Debug: quota: quota_over_flag check:
quota_over_script unset - skipping
Apr 19 10:23:59 imap(NewUser): Debug: INBOX: Mailbox opened because: SELECT
Apr 19 10:24:07 imap(NewUser): Debug: Loading modules from directory:
/usr/local/lib/dovecot
Apr 19 10:24:07 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib10_quota_plugin.so
Apr 19 10:24:07 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib11_imap_quota_plugin.so
Apr 19 10:24:07 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_fts_plugin.so
Apr 19 10:24:07 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib20_virtual_plugin.so
Apr 19 10:24:07 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib21_fts_solr_plugin.so
Apr 19 10:24:07 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib90_stats_plugin.so
Apr 19 10:24:07 imap(NewUser): Debug: Module loaded:
/usr/local/lib/dovecot/lib95_imap_stats_plugin.so
Apr 19 10:24:07 imap(NewUser): Debug: Effective uid=992, gid=989,
home=/var/vmail/NewUser/home
Apr 19 10:24:07 imap(NewUser): Debug: Quota root: name=User quota
backend=maildir args=
Apr 19 10:24:07 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=* bytes=21474836480 messages=0
Apr 19 10:24:07 imap(NewUser): Debug: Quota rule: root=User quota
mailbox=Trash bytes=+209715200 messages=0
Apr 19 10:24:07 imap(NewUser): Debug: Quota warning: bytes=20401094656
(95%) messages=0 reverse=no command=quota-warning 95 NewUser
Apr 19 10:24:07 imap(NewUser): Debug: Quota warning: bytes=17179869184
(80%) messages=0 reverse=no command=quota-warning 80 NewUser
Apr 19 10:24:07 imap(NewUser): Debug: Quota grace: root=User quota
bytes=2147483648 (10%)
Apr 19 10:24:07 imap(NewUser): Debug: Namespace : type=private, prefix=,
sep=, inbox=yes, hidden=no, list=yes, subscriptions=yes
location=maildir:/var/vmail/NewUser
Apr 19 10:24:07 imap(NewUser): Debug: maildir++:
root=/var/vmail/NewUser, index=, indexpvt=, control=,
inbox=/var/vmail/NewUser, alt=
Apr 19 10:24:07 imap(NewUser): Debug: quota: quota_over_flag check:
quota_over_script unset - skipping
Apr 19 10:24:07 imap(NewUser): Debug: INBOX: Mailbox opened because: STATUS
Apr 19 10:24:07 imap(NewUser): Debug: INBOX: Mailbox opened because: SELECT

More information about the dovecot mailing list