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