Hello,
Most of the work was done with dovecot 2.2.27 but I just upgraded to
2.3.2 and didn't see any change. Some debug logs are below, is there
something specific I could search them for?
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8299): Debug: Loading
modules from directory: /usr/lib/dovecot/modules/auth
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8299): Debug: Module
loaded: /usr/lib/dovecot/modules/auth/lib20_auth_var_expand_crypt.so
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8299): Debug: Module
loaded: /usr/lib/dovecot/modules/auth/libdriver_mysql.so
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(billing@edwardcsmith.ca,64.68.203.197,<x3/sZhl263lARMvF>): query:
select email as user, crypt_password as password,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'billing@edwardcsmith.ca' and banned = '0' and active = '1'
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: client passdb out:
OK#01158#011user=billing@edwardcsmith.ca#011home=/svmail/03/edwardcsmith.ca/billing#011uid=5000#011gid=5000#011quota_rule=*:storage=2G
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: master in:
REQUEST#0111314258945#0111045#01158#0117968dddd529039bd9545c6d15e171c19#011session_pid=8301#011request_auth_token
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(billing@edwardcsmith.ca,64.68.203.197,<x3/sZhl263lARMvF>): SELECT
CONCAT('maildir:/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1),'/Maildir')
AS mail,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'billing@edwardcsmith.ca' and banned = '0' and active = '1'
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: master userdb out:
USER#0111314258945#011billing@edwardcsmith.ca#011mail=maildir:/svmail/03/edwardcsmith.ca/billing/Maildir#011home=/svmail/03/edwardcsmith.ca/billing#011uid=5000#011gid=5000#011quota_rule=*:storage=2G#011auth_token=742b2329fc04dd160562ecaeed77c6b4ac784f3f
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8300): Debug: Loading
modules from directory: /usr/lib/dovecot/modules/auth
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Loading
modules from directory: /usr/lib/dovecot/modules
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8300): Debug: Module
loaded: /usr/lib/dovecot/modules/auth/lib20_auth_var_expand_crypt.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Module
loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Module
loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Module
loaded: /usr/lib/dovecot/modules/lib15_notify_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Module
loaded: /usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Added
userdb setting: mail=maildir:/svmail/03/edwardcsmith.ca/billing/Maildir
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Added
userdb setting: plugin/quota_rule=*:storage=2G
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Effective
uid=5000, gid=5000, home=/svmail/03/edwardcsmith.ca/billing
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: client in:
AUTH#01160#011PLAIN#011service=imap#011session=xevsZhl2jT5ARMvF#011lip=172.17.10.211#011rip=64.68.203.197#011lport=143#011rport=16013#011resp=<hidden>
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(ted@edwardcsmith.ca,64.68.203.197,<xevsZhl2jT5ARMvF>): query: select
email as user, crypt_password as password,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'ted@edwardcsmith.ca' and banned = '0' and active = '1'
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Quota
root: name=User quota backend=count args=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Quota
rule: root=User quota mailbox=* bytes=2147483648 messages=0
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Quota
warning: bytes=2040109465 (95%) messages=0 reverse=no
command=quota-warning 95 billing@edwardcsmith.ca
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Quota
warning: bytes=1932735283 (90%) messages=0 reverse=no
command=quota-warning 90 billing@edwardcsmith.ca
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Quota
warning: bytes=1717986918 (80%) messages=0 reverse=no
command=quota-warning 80 billing@edwardcsmith.ca
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Quota
grace: root=User quota bytes=214748364 (10%)
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Namespace
: type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes,
subscriptions=yes
location=maildir:/svmail/03/edwardcsmith.ca/billing/Maildir
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: maildir++:
root=/svmail/03/edwardcsmith.ca/billing/Maildir, index=, indexpvt=,
control=, inbox=/svmail/03/edwardcsmith.ca/billing/Maildir, alt=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: Namespace
: type=private, prefix=, sep=, inbox=no, hidden=yes, list=no,
subscriptions=no location=fail::LAYOUT=none
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: none:
root=, index=, indexpvt=, control=, inbox=, alt=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: client passdb out:
OK#01160#011user=ted@edwardcsmith.ca#011home=/svmail/03/edwardcsmith.ca/ted#011uid=5000#011gid=5000#011quota_rule=*:storage=2G
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8300): Debug: Module
loaded: /usr/lib/dovecot/modules/auth/libdriver_mysql.so
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: master in:
REQUEST#011770310145#0111045#01160#0117968dddd529039bd9545c6d15e171c19#011session_pid=8302#011request_auth_token
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(ted@edwardcsmith.ca,64.68.203.197,<xevsZhl2jT5ARMvF>): SELECT
CONCAT('maildir:/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1),'/Maildir')
AS mail,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'ted@edwardcsmith.ca' and banned = '0' and active = '1'
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: client in:
AUTH#01161#011PLAIN#011service=imap#011session=5f7sZhl2IxRARMvF#011lip=172.17.10.211#011rip=64.68.203.197#011lport=143#011rport=5155#011resp=<hidden>
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: master userdb out:
USER#011770310145#011ted@edwardcsmith.ca#011mail=maildir:/svmail/03/edwardcsmith.ca/ted/Maildir#011home=/svmail/03/edwardcsmith.ca/ted#011uid=5000#011gid=5000#011quota_rule=*:storage=2G#011auth_token=21114b3fb366b3868d3dbb5003156728ea5fdeb7
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Loading
modules from directory: /usr/lib/dovecot/modules
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib10_quota_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib15_notify_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Added userdb
setting: mail=maildir:/svmail/03/edwardcsmith.ca/ted/Maildir
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Added userdb
setting: plugin/quota_rule=*:storage=2G
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Effective
uid=5000, gid=5000, home=/svmail/03/edwardcsmith.ca/ted
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Quota root:
name=User quota backend=count args=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Quota rule:
root=User quota mailbox=* bytes=2147483648 messages=0
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Quota warning:
bytes=2040109465 (95%) messages=0 reverse=no command=quota-warning 95
ted@edwardcsmith.ca
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Quota warning:
bytes=1932735283 (90%) messages=0 reverse=no command=quota-warning 90
ted@edwardcsmith.ca
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Quota warning:
bytes=1717986918 (80%) messages=0 reverse=no command=quota-warning 80
ted@edwardcsmith.ca
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Quota grace:
root=User quota bytes=214748364 (10%)
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Namespace :
type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes,
subscriptions=yes location=maildir:/svmail/03/edwardcsmith.ca/ted/Maildir
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: maildir++:
root=/svmail/03/edwardcsmith.ca/ted/Maildir, index=, indexpvt=,
control=, inbox=/svmail/03/edwardcsmith.ca/ted/Maildir, alt=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: Namespace :
type=private, prefix=, sep=, inbox=no, hidden=yes, list=no,
subscriptions=no location=fail::LAYOUT=none
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: none: root=,
index=, indexpvt=, control=, inbox=, alt=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8300): Debug:
sql(other@quailmail.ca,64.68.203.197,<upDsZhl2+T5ARMvF>): query: select
email as user, crypt_password as password,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'other@quailmail.ca' and banned = '0' and active = '1'
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: client passdb out:
OK#01159#011user=other@quailmail.ca#011home=/svmail/04/quailmail.ca/other#011uid=5000#011gid=5000#011quota_rule=*:storage=1G
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: master in:
REQUEST#0111747189761#0111045#01159#0117968dddd529039bd9545c6d15e171c19#011session_pid=8304#011request_auth_token
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(other@quailmail.ca,64.68.203.197,<upDsZhl2+T5ARMvF>): SELECT
CONCAT('maildir:/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1),'/Maildir')
AS mail,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'other@quailmail.ca' and banned = '0' and active = '1'
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: master userdb out:
USER#0111747189761#011other@quailmail.ca#011mail=maildir:/svmail/04/quailmail.ca/other/Maildir#011home=/svmail/04/quailmail.ca/other#011uid=5000#011gid=5000#011quota_rule=*:storage=1G#011auth_token=93f39dddaa2ae363a337e9331172edd8fd900052
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Loading modules
from directory: /usr/lib/dovecot/modules
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib10_quota_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib15_notify_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Added userdb
setting: mail=maildir:/svmail/04/quailmail.ca/other/Maildir
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Added userdb
setting: plugin/quota_rule=*:storage=1G
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Effective
uid=5000, gid=5000, home=/svmail/04/quailmail.ca/other
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8303): Debug: Loading
modules from directory: /usr/lib/dovecot/modules/auth
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8303): Debug: Module
loaded: /usr/lib/dovecot/modules/auth/lib20_auth_var_expand_crypt.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Quota root:
name=User quota backend=count args=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Quota rule:
root=User quota mailbox=* bytes=1073741824 messages=0
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Quota warning:
bytes=1020054732 (95%) messages=0 reverse=no command=quota-warning 95
other@quailmail.ca
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Quota warning:
bytes=966367641 (90%) messages=0 reverse=no command=quota-warning 90
other@quailmail.ca
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Quota warning:
bytes=858993459 (80%) messages=0 reverse=no command=quota-warning 80
other@quailmail.ca
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Quota grace:
root=User quota bytes=107374182 (10%)
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Namespace :
type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes,
subscriptions=yes location=maildir:/svmail/04/quailmail.ca/other/Maildir
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: maildir++:
root=/svmail/04/quailmail.ca/other/Maildir, index=, indexpvt=, control=,
inbox=/svmail/04/quailmail.ca/other/Maildir, alt=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: Namespace :
type=private, prefix=, sep=, inbox=no, hidden=yes, list=no,
subscriptions=no location=fail::LAYOUT=none
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: none: root=,
index=, indexpvt=, control=, inbox=, alt=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8303): Debug: Module
loaded: /usr/lib/dovecot/modules/auth/libdriver_mysql.so
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8303): Debug:
sql(00@hosehead.ninja,64.68.203.197,<5f7sZhl2IxRARMvF>): query: select
email as user, crypt_password as password,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'00@hosehead.ninja' and banned = '0' and active = '1'
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: client passdb out:
OK#01161#011user=00@hosehead.ninja#011home=/svmail/03/hosehead.ninja/00#011uid=5000#011gid=5000#011quota_rule=*:storage=0G
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: master in:
REQUEST#0113512991745#0111045#01161#0117968dddd529039bd9545c6d15e171c19#011session_pid=8305#011request_auth_token
Sep 17 23:19:16 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(00@hosehead.ninja,64.68.203.197,<5f7sZhl2IxRARMvF>): SELECT
CONCAT('maildir:/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1),'/Maildir')
AS mail,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'00@hosehead.ninja' and banned = '0' and active = '1'
Sep 17 23:19:16 ezm11-pco dovecot: auth: Debug: master userdb out:
USER#0113512991745#01100@hosehead.ninja#011mail=maildir:/svmail/03/hosehead.ninja/00/Maildir#011home=/svmail/03/hosehead.ninja/00#011uid=5000#011gid=5000#011quota_rule=*:storage=0G#011auth_token=b431dc6c8cf37e624e300dab3e7195b4f1bdd02c
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Loading modules
from directory: /usr/lib/dovecot/modules
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib10_quota_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib15_notify_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Added userdb
setting: mail=maildir:/svmail/03/hosehead.ninja/00/Maildir
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Added userdb
setting: plugin/quota_rule=*:storage=0G
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Effective
uid=5000, gid=5000, home=/svmail/03/hosehead.ninja/00
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Quota root:
name=User quota backend=count args=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Quota rule:
root=User quota mailbox=* bytes=0 messages=0
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Quota warning:
bytes=0 (95%) messages=0 reverse=no command=quota-warning 95
00@hosehead.ninja
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Quota warning:
bytes=0 (90%) messages=0 reverse=no command=quota-warning 90
00@hosehead.ninja
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Quota warning:
bytes=0 (80%) messages=0 reverse=no command=quota-warning 80
00@hosehead.ninja
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Quota grace:
root=User quota bytes=0 (10%)
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Namespace :
type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes,
subscriptions=yes location=maildir:/svmail/03/hosehead.ninja/00/Maildir
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: maildir++:
root=/svmail/03/hosehead.ninja/00/Maildir, index=, indexpvt=, control=,
inbox=/svmail/03/hosehead.ninja/00/Maildir, alt=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: Namespace :
type=private, prefix=, sep=, inbox=no, hidden=yes, list=no,
subscriptions=no location=fail::LAYOUT=none
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: none: root=,
index=, indexpvt=, control=, inbox=, alt=
Sep 17 23:19:16 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8305><5f7sZhl2IxRARMvF>: Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: INBOX:
Mailbox opened because: STATUS
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: INBOX: Mailbox
opened because: STATUS
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: INBOX: Mailbox
opened because: STATUS
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8304><upDsZhl2+T5ARMvF>: Debug: INBOX: Mailbox
opened because: SELECT
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8301><x3/sZhl263lARMvF>: Debug: INBOX:
Mailbox opened because: SELECT
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8302><xevsZhl2jT5ARMvF>: Debug: INBOX: Mailbox
opened because: SELECT
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: client in:
AUTH#01162#011PLAIN#011service=imap#011session=Uvv6Zhl2MBJARMvF#011lip=172.17.10.211#011rip=64.68.203.197#011lport=143#011rport=4656#011resp=<hidden>
Sep 17 23:19:17 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(other@quailmail.ca,64.68.203.197,<Uvv6Zhl2MBJARMvF>): query: select
email as user, crypt_password as password,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'other@quailmail.ca' and banned = '0' and active = '1'
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: client passdb out:
OK#01162#011user=other@quailmail.ca#011home=/svmail/04/quailmail.ca/other#011uid=5000#011gid=5000#011quota_rule=*:storage=1G
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: client in:
AUTH#01163#011PLAIN#011service=imap#011session=TxD7Zhl23hJARMvF#011lip=172.17.10.211#011rip=64.68.203.197#011lport=143#011rport=4830#011resp=<hidden>
Sep 17 23:19:17 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(ted@edwardcsmith.ca,64.68.203.197,<TxD7Zhl23hJARMvF>): query: select
email as user, crypt_password as password,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'ted@edwardcsmith.ca' and banned = '0' and active = '1'
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: master in:
REQUEST#0113224240129#0111045#01162#0117968dddd529039bd9545c6d15e171c19#011session_pid=8306#011request_auth_token
Sep 17 23:19:17 ezm11-pco dovecot: auth-worker(8300): Debug:
sql(other@quailmail.ca,64.68.203.197,<Uvv6Zhl2MBJARMvF>): SELECT
CONCAT('maildir:/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1),'/Maildir')
AS mail,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'other@quailmail.ca' and banned = '0' and active = '1'
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: client passdb out:
OK#01163#011user=ted@edwardcsmith.ca#011home=/svmail/03/edwardcsmith.ca/ted#011uid=5000#011gid=5000#011quota_rule=*:storage=2G
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: master userdb out:
USER#0113224240129#011other@quailmail.ca#011mail=maildir:/svmail/04/quailmail.ca/other/Maildir#011home=/svmail/04/quailmail.ca/other#011uid=5000#011gid=5000#011quota_rule=*:storage=1G#011auth_token=4232c07d106c0080f7f4d8e8aaa43fcb73784f08
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Loading modules
from directory: /usr/lib/dovecot/modules
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib10_quota_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib15_notify_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: client in:
AUTH#01164#011PLAIN#011service=imap#011session=tx/7Zhl2tmBARMvF#011lip=172.17.10.211#011rip=64.68.203.197#011lport=143#011rport=24758#011resp=<hidden>
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Added userdb
setting: mail=maildir:/svmail/04/quailmail.ca/other/Maildir
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Added userdb
setting: plugin/quota_rule=*:storage=1G
Sep 17 23:19:17 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(billing@edwardcsmith.ca,64.68.203.197,<tx/7Zhl2tmBARMvF>): query:
select email as user, crypt_password as password,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'billing@edwardcsmith.ca' and banned = '0' and active = '1'
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Effective
uid=5000, gid=5000, home=/svmail/04/quailmail.ca/other
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Quota root:
name=User quota backend=count args=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Quota rule:
root=User quota mailbox=* bytes=1073741824 messages=0
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Quota warning:
bytes=1020054732 (95%) messages=0 reverse=no command=quota-warning 95
other@quailmail.ca
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Quota warning:
bytes=966367641 (90%) messages=0 reverse=no command=quota-warning 90
other@quailmail.ca
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Quota warning:
bytes=858993459 (80%) messages=0 reverse=no command=quota-warning 80
other@quailmail.ca
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Quota grace:
root=User quota bytes=107374182 (10%)
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Namespace :
type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes,
subscriptions=yes location=maildir:/svmail/04/quailmail.ca/other/Maildir
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: maildir++:
root=/svmail/04/quailmail.ca/other/Maildir, index=, indexpvt=, control=,
inbox=/svmail/04/quailmail.ca/other/Maildir, alt=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: Namespace :
type=private, prefix=, sep=, inbox=no, hidden=yes, list=no,
subscriptions=no location=fail::LAYOUT=none
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: none: root=,
index=, indexpvt=, control=, inbox=, alt=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(other@quailmail.ca)<8306><Uvv6Zhl2MBJARMvF>: Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: master in:
REQUEST#011819855361#0111045#01163#0117968dddd529039bd9545c6d15e171c19#011session_pid=8307#011request_auth_token
Sep 17 23:19:17 ezm11-pco dovecot: auth-worker(8300): Debug:
sql(ted@edwardcsmith.ca,64.68.203.197,<TxD7Zhl23hJARMvF>): SELECT
CONCAT('maildir:/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1),'/Maildir')
AS mail,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'ted@edwardcsmith.ca' and banned = '0' and active = '1'
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: client passdb out:
OK#01164#011user=billing@edwardcsmith.ca#011home=/svmail/03/edwardcsmith.ca/billing#011uid=5000#011gid=5000#011quota_rule=*:storage=2G
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: master userdb out:
USER#011819855361#011ted@edwardcsmith.ca#011mail=maildir:/svmail/03/edwardcsmith.ca/ted/Maildir#011home=/svmail/03/edwardcsmith.ca/ted#011uid=5000#011gid=5000#011quota_rule=*:storage=2G#011auth_token=0751d36dc0d274430348b40caa89049f5551c7af
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Loading
modules from directory: /usr/lib/dovecot/modules
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib10_quota_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib15_notify_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Added userdb
setting: mail=maildir:/svmail/03/edwardcsmith.ca/ted/Maildir
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Added userdb
setting: plugin/quota_rule=*:storage=2G
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: master in:
REQUEST#0111251213313#0111045#01164#0117968dddd529039bd9545c6d15e171c19#011session_pid=8308#011request_auth_token
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Effective
uid=5000, gid=5000, home=/svmail/03/edwardcsmith.ca/ted
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Quota root:
name=User quota backend=count args=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Quota rule:
root=User quota mailbox=* bytes=2147483648 messages=0
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Quota warning:
bytes=2040109465 (95%) messages=0 reverse=no command=quota-warning 95
ted@edwardcsmith.ca
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Quota warning:
bytes=1932735283 (90%) messages=0 reverse=no command=quota-warning 90
ted@edwardcsmith.ca
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Quota warning:
bytes=1717986918 (80%) messages=0 reverse=no command=quota-warning 80
ted@edwardcsmith.ca
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Quota grace:
root=User quota bytes=214748364 (10%)
Sep 17 23:19:17 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(billing@edwardcsmith.ca,64.68.203.197,<tx/7Zhl2tmBARMvF>): SELECT
CONCAT('maildir:/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1),'/Maildir')
AS mail,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'billing@edwardcsmith.ca' and banned = '0' and active = '1'
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Namespace :
type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes,
subscriptions=yes location=maildir:/svmail/03/edwardcsmith.ca/ted/Maildir
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: maildir++:
root=/svmail/03/edwardcsmith.ca/ted/Maildir, index=, indexpvt=,
control=, inbox=/svmail/03/edwardcsmith.ca/ted/Maildir, alt=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: Namespace :
type=private, prefix=, sep=, inbox=no, hidden=yes, list=no,
subscriptions=no location=fail::LAYOUT=none
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: none: root=,
index=, indexpvt=, control=, inbox=, alt=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(ted@edwardcsmith.ca)<8307><TxD7Zhl23hJARMvF>: Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: master userdb out:
USER#0111251213313#011billing@edwardcsmith.ca#011mail=maildir:/svmail/03/edwardcsmith.ca/billing/Maildir#011home=/svmail/03/edwardcsmith.ca/billing#011uid=5000#011gid=5000#011quota_rule=*:storage=2G#011auth_token=90acc0680ea51065bd01e5789c4d10453ef6a748
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Loading
modules from directory: /usr/lib/dovecot/modules
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Module
loaded: /usr/lib/dovecot/modules/lib10_quota_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Module
loaded: /usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Module
loaded: /usr/lib/dovecot/modules/lib15_notify_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Module
loaded: /usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Added
userdb setting: mail=maildir:/svmail/03/edwardcsmith.ca/billing/Maildir
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Added
userdb setting: plugin/quota_rule=*:storage=2G
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Effective
uid=5000, gid=5000, home=/svmail/03/edwardcsmith.ca/billing
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Quota
root: name=User quota backend=count args=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Quota
rule: root=User quota mailbox=* bytes=2147483648 messages=0
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Quota
warning: bytes=2040109465 (95%) messages=0 reverse=no
command=quota-warning 95 billing@edwardcsmith.ca
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Quota
warning: bytes=1932735283 (90%) messages=0 reverse=no
command=quota-warning 90 billing@edwardcsmith.ca
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Quota
warning: bytes=1717986918 (80%) messages=0 reverse=no
command=quota-warning 80 billing@edwardcsmith.ca
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Quota
grace: root=User quota bytes=214748364 (10%)
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Namespace
: type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes,
subscriptions=yes
location=maildir:/svmail/03/edwardcsmith.ca/billing/Maildir
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: maildir++:
root=/svmail/03/edwardcsmith.ca/billing/Maildir, index=, indexpvt=,
control=, inbox=/svmail/03/edwardcsmith.ca/billing/Maildir, alt=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: Namespace
: type=private, prefix=, sep=, inbox=no, hidden=yes, list=no,
subscriptions=no location=fail::LAYOUT=none
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: none:
root=, index=, indexpvt=, control=, inbox=, alt=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(billing@edwardcsmith.ca)<8308><tx/7Zhl2tmBARMvF>: Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: client in:
AUTH#01165#011PLAIN#011service=imap#011session=00z7Zhl211lARMvF#011lip=172.17.10.211#011rip=64.68.203.197#011lport=143#011rport=22999#011resp=<hidden>
Sep 17 23:19:17 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(00@hosehead.ninja,64.68.203.197,<00z7Zhl211lARMvF>): query: select
email as user, crypt_password as password,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'00@hosehead.ninja' and banned = '0' and active = '1'
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: client passdb out:
OK#01165#011user=00@hosehead.ninja#011home=/svmail/03/hosehead.ninja/00#011uid=5000#011gid=5000#011quota_rule=*:storage=0G
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: master in:
REQUEST#0114049862657#0111045#01165#0117968dddd529039bd9545c6d15e171c19#011session_pid=8309#011request_auth_token
Sep 17 23:19:17 ezm11-pco dovecot: auth-worker(8299): Debug:
sql(00@hosehead.ninja,64.68.203.197,<00z7Zhl211lARMvF>): SELECT
CONCAT('maildir:/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1),'/Maildir')
AS mail,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email =
'00@hosehead.ninja' and banned = '0' and active = '1'
Sep 17 23:19:17 ezm11-pco dovecot: auth: Debug: master userdb out:
USER#0114049862657#01100@hosehead.ninja#011mail=maildir:/svmail/03/hosehead.ninja/00/Maildir#011home=/svmail/03/hosehead.ninja/00#011uid=5000#011gid=5000#011quota_rule=*:storage=0G#011auth_token=4e2572405b7d42c5dc4f273ba1e8d0ed5545f123
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Loading modules
from directory: /usr/lib/dovecot/modules
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib10_quota_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib15_notify_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Added userdb
setting: mail=maildir:/svmail/03/hosehead.ninja/00/Maildir
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Added userdb
setting: plugin/quota_rule=*:storage=0G
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Effective
uid=5000, gid=5000, home=/svmail/03/hosehead.ninja/00
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Quota root:
name=User quota backend=count args=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Quota rule:
root=User quota mailbox=* bytes=0 messages=0
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Quota warning:
bytes=0 (95%) messages=0 reverse=no command=quota-warning 95
00@hosehead.ninja
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Quota warning:
bytes=0 (90%) messages=0 reverse=no command=quota-warning 90
00@hosehead.ninja
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Quota warning:
bytes=0 (80%) messages=0 reverse=no command=quota-warning 80
00@hosehead.ninja
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Quota grace:
root=User quota bytes=0 (10%)
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Namespace :
type=private, prefix=INBOX., sep=., inbox=yes, hidden=no, list=yes,
subscriptions=yes location=maildir:/svmail/03/hosehead.ninja/00/Maildir
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: maildir++:
root=/svmail/03/hosehead.ninja/00/Maildir, index=, indexpvt=, control=,
inbox=/svmail/03/hosehead.ninja/00/Maildir, alt=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: Namespace :
type=private, prefix=, sep=, inbox=no, hidden=yes, list=no,
subscriptions=no location=fail::LAYOUT=none
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: none: root=,
index=, indexpvt=, control=, inbox=, alt=
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: quota:
quota_over_flag check: quota_over_script unset - skipping
Sep 17 23:19:17 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: INBOX: Mailbox
opened because: STATUS
Sep 17 23:19:18 ezm11-pco dovecot:
imap(00@hosehead.ninja)<8309><00z7Zhl211lARMvF>: Debug: INBOX: Mailbox
opened because: SELECT
Thank you
Ted
easyDNS Technologies
On 2018-09-19 02:52 AM, Aki Tuomi
wrote:
Hi!
Can you provide dovecot version? Also output of mail_debug=yes logs
would be useful
Aki
On 19.09.2018 00:19, Ted wrote:
Hello,
I'm trying to implement quota enforcement in our mailservers, and it is
all working properly except that the quota warnings are not firing when
the quota levels are passed. the server stops accepting email when the
quota is reached, and you can see tyhe quota usage through the email
client connected through, but as the quota passes the set levels the
/usr/local/bin/quota-warning.sh script is not called. I checked from
the appropriate user and the script executes from the command line with
no problem, but dovecot does not invoke it when the quota levels are
crossed. The relevant configs are below, any ideas about what the
problem may be or how I should approach this?
/etc/dovecot/dovecot.conf
## Dovecot configuration file
# Protocols we want to be serving.
protocols = imap pop3 lmtp sieve
mailbox_list_index = yes
# Avoid spending excessive time waiting for the quota calculation to
finish when
# mails' vsizes aren't already cached. If this many mails are opened,
finish the
# quota calculation on background in indexer-worker process. Mail
deliveries will
# be assumed to succeed, and explicit quota lookups will return internal
error.
# (v2.2.28+)
# mail_vsize_bg_after_count = 100
plugin {
quota_grace = 10%%
# 10% is the default
# quota_status_success = DUNNO
# quota_status_nouser = DUNNO
quota_status_overquota = "552 5.2.2 Mailbox is full"
quota_vsizes = yes
}
service quota-status {
executable = quota-status -p postfix
inet_listener {
port = 10070
# You can choose any port you want
}
client_limit = 1
}
mail_plugins = $mail_plugins quota mail_log notify
protocol imap {
# Space separated list of plugins to load (default is global
mail_plugins).
mail_plugins = $mail_plugins imap_quota
}
# Greeting message for clients.
login_greeting = Welcome to easyMail.
# Show more verbose process titles (in ps). Currently shows user name and
# IP address. Useful for seeing who are actually using the IMAP processes
# (eg. shared mailboxes or if same uid is used for multiple accounts).
verbose_proctitle = yes
# Should all processes be killed when Dovecot master process shuts down.
# Setting this to "no" means that Dovecot can be upgraded without
# forcing existing client connections to close (although that could also be
# a problem if the upgrade is e.g. because of a security fix).
shutdown_clients = yes
# A config file can also tried to be included without giving an error if
# it's not found:
!include_try local.conf
service auth {
unix_listener auth-master {
mode = 0600
user = vmail
}
}
/etc/dovecot/dovecot-sql.conf.ext
# Database driver: mysql, pgsql, sqlite
driver = mysql
connect = host=redacted dbname=redacted user=redacted
password=reallyredacted
# Default password scheme.
#
# List of supported schemes is in
# http://wiki2.dovecot.org/Authentication/PasswordSchemes
#
default_pass_scheme = CRYPT
password_query = select email as user, crypt_password as password,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email = '%u' and banned =
'0' and active = '1'
user_query = SELECT
CONCAT('maildir:/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1),'/Maildir')
AS mail,
CONCAT('/',volume,'/',SUBSTRING_INDEX(email,'@',-1),'/',SUBSTRING_INDEX(email,'@',1))
AS home, 5000 AS uid, 5000 AS gid, concat('*:storage=', volume_limit
,'G') AS quota_rule from easymail_users where email = '%u' and banned =
'0' and active = '1'
/etc/dovecot/conf.d/90-quota.conf
##
## Quota configuration.
##
##
## Quota warnings
##
# You can execute a given command when user exceeds a specified quota limit.
# Each quota root has separate limits. Only the command for the first
# exceeded limit is excecuted, so put the highest limit first.
# The commands are executed via script service by connecting to the named
# UNIX socket (quota-warning below).
# Note that % needs to be escaped as %%, otherwise "% " expands to empty.
plugin {
quota_warning = storage=95%% quota-warning 95 %u
quota_warning2 = storage=90%% quota-warning 90 %u
quota_warning3 = storage=80%% quota-warning 80 %u
}
# Example quota-warning service. The unix listener's permissions should be
# set in a way that mail processes can connect to it. Below example assumes
# that mail processes run as vmail user. If you use mode=0666, all
system users
# can generate quota warnings to anyone.
service quota-warning {
executable = script /usr/local/bin/quota-warning.sh
user = dovecot
unix_listener quota-warning {
user = dovecot
mode = 0666
}
}
##
## Quota backends
##
# Multiple backends are supported:
# dirsize: Find and sum all the files found from mail directory.
# Extremely SLOW with Maildir. It'll eat your CPU and disk I/O.
# dict: Keep quota stored in dictionary (eg. SQL)
# maildir: Maildir++ quota
# fs: Read-only support for filesystem quota
plugin {
#quota = dirsize:User quota
#quota = maildir:User quota
#quota = dict:User quota::proxy::quota
quota = count:User quota
#quota = fs:User quota
}
/usr/local/bin/quota-warning.sh
#!/bin/sh
# warning email for approaching their quota
usage=$1
email=$2
/usr/bin/mailx -r "support@easydns.com" -s "Quota Usager Notification"
"${email:?}" < /home/vmail/quota"${usage:?}".txt
echo "$(date) ${usage} : ${email}" >> /var/log/quotatest.log
Thank you
Ted
easyDNS Technologies