Hello everybody,
I have a question about lazy_expunge plugin.
I set up Dovecot with lazy_expunge plugin on a Debian Wheezy machine; I
setup also a global acl to keep .expunged namespace readonly for all
users. Imap client is Horde Webmail Edition 5.2.3
When I try to delete folders containing subfolders, lazy_expunge copies
into expunged private namespace only the upper level folder. The
subfolder and all messages inside it are lost. Quota is also corrupted
(subfolder messages are still accounted in the Message counter and disk
quota) and a recalc is needed to fix.
Problem can be reproduced this way:
1)Create with horde a folder "extern"
2)Create a subfolder "extern/subfolder"
3) copy some messages into extern and some into subfolder (in my test 5
messages each)
4) verify quota usage:
root at gold:# doveadm quota get -u testimap2.csia at unipd.it
Quota name Type Value Limit
%
User quota STORAGE 4 1126400
0
User quota MESSAGE 10 -
0
3)Delete extern with option to delete all subfolders.
4)verify that all folders and messages have been deleted
5)verify that only extern folder has been copied into .expunged
namespace and verify that quota still reports the 5 messages that were
in subfolder:
root at gold:# doveadm quota get -u testimap2.csia at unipd.it
Quota name Type Value Limit
%
User quota STORAGE 2 1126400
0
User quota MESSAGE 5 -
0
6) recalc quota and check again that quota has benne corrected:
# doveadm quota recalc -u testimap2.csia at unipd.it
root at gold:# doveadm quota get -u testimap2.csia at unipd.it
Quota name Type Value Limit
%
User quota STORAGE 0 1126400
0
User quota MESSAGE 0 -
0
Is there anything I am missing?
Thanks in advance.
Best regards.
Giorgio Paolucci
===============================================
dovecot version 2.2.13
OS :Linux bronze 3.2.0-4-amd64 #1 SMP Debian 3.2.65-1+deb7u1 x86_64
GNU/Linux
================================================root at
bronze:/etc/dovecot/conf.d# more ../dovecot-acl
_PostaCancellataPerErrore* owner lrik
================================================root at
bronze:/etc/dovecot/conf.d# dovecot -n
# 2.2.13: /etc/dovecot/dovecot.conf
# OS: Linux 3.2.0-4-amd64 x86_64 Debian 7.8
auth_default_realm = unipd.it
disable_plaintext_auth = no
log_path = /var/log/dovecot/dovecot.log
mail_debug = yes
mail_fsync = always
mail_nfs_index = yes
mail_nfs_storage = yes
mail_plugins = quota listescape lazy_expunge acl mail_log notify
mdbox_rotate_interval = 1 days
mdbox_rotate_size = 10 M
mmap_disable = yes
namespace {
hidden = no
inbox = no
list = yes
location = maildir:/SYSTEM/USERS/mailbox/%d/%1n/%u/expunged
mailbox .LEGGIMI {
auto = subscribe
}
mailbox INBOX.Trash {
auto = subscribe
special_use = \Trash
}
prefix = _PostaCancellataPerErrore/
separator = /
subscriptions = yes
type = private
}
namespace inbox {
inbox = yes
location mailbox Drafts {
special_use = \Drafts
}
mailbox Junk {
special_use = \Junk
}
mailbox Sent {
special_use = \Sent
}
mailbox "Sent Messages" {
special_use = \Sent
}
mailbox Trash {
special_use = \Trash
}
prefix separator = /
}
passdb {
args = /etc/dovecot/conf.d/dovecot-sql.conf.ext
driver = sql
}
passdb {
args = /etc/dovecot/conf.d/dovecot-sqlSSO.conf.ext
driver = sql
}
plugin {
acl = vfile:/etc/dovecot/dovecot-acl
lazy_expunge = _PostaCancellataPerErrore/
lazy_expunge_only_last_instance = yes
mail_log_events = delete undelete expunge copy mailbox_delete
mailbox_rename
mail_log_fields = uid box msgid size
pop3_migration_mailbox = INBOX
quota = dict:User quota::file:/SYSTEM/USERS/homes/%d/%1u/%u/%u.quota
quota_rule = *:storage=1100M
quota_rule2 = Trash:storage=+100M
quota_warning = storage=95%% quota-warning 95 %u
quota_warning2 = storage=80%% quota-warning 80 %u
sieve = ~/.dovecot.sieve
sieve_dir = ~/sieve
}
pop3c_host = 147.162.10.68
protocols = imap pop3 lmtp
service auth {
unix_listener /var/spool/postfix/private/auth {
group = postfix
mode = 0660
user = postfix
}
unix_listener auth-userdb {
group = vmail
mode = 0600
user = vmail
}
}
service imap-login {
inet_listener imaps {
ssl = no
}
process_min_avail = 20
service_count = 1
}
service imap {
executable = imap postlogin
}
service lmtp {
executable = lmtp
inet_listener lmtp {
port = 2223
}
process_min_avail = 15
}
service pop3-login {
inet_listener pop3s {
ssl = no
}
}
service postlogin {
executable = script-login -d rawlog
user = vmail
}
service quota-warning {
executable = script /SYSTEM/DOVECOT/scripts/quota-warning.sh
unix_listener quota-warning {
user = vmail
}
user = vmail
}
ssl = no
userdb {
driver = prefetch
}
userdb {
args = /etc/dovecot/conf.d/dovecot-sql.conf.ext
driver = sql
}
userdb {
driver = prefetch
}
userdb {
args = /etc/dovecot/conf.d/dovecot-sqlSSO.conf.ext
driver = sql
}
protocol lmtp {
info_log_path = /tmp/dovecot-lmtp-info.log
log_path = /tmp/dovecot-lmtp.log
mail_plugins = quota listescape lazy_expunge acl mail_log notify
}
protocol imap {
imap_max_line_length = 128 k
mail_plugins = quota listescape lazy_expunge acl mail_log notify
imap_quota acl imap_acl
}
protocol doveadm {
mail_plugins = quota listescape lazy_expunge acl mail_log notify
pop3_migration
}
protocol pop3 {
pop3_no_flag_updates = yes
pop3_uidl_format = %10v.%09u
}
==================================root at gold:# doveadm user -u testimap2.csia
at unipd.it
userdb: testimap2.csia at unipd.it
uid : 1003
gid : 1003
home : /SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at unipd.it
mail :
sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
-------------------------------
Here follows IMAP transaction in and out from rawlog
IN:
2 ENABLE QRESYNC
3 NAMESPACE
4 LIST () "" (extern/*)
5 DELETE extern
6 UNSUBSCRIBE extern
7 DELETE extern/subfolder
8 UNSUBSCRIBE extern/subfolder
9 LOGOUT
OUT:
root at gold:/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at
unipd.it/dovecot.rawlog#
more 20150326-095943-1773.out
1 OK [CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE
IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=OR
DEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN
NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARC
H ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS SPECIAL-USE BINARY
MOVE QUOTA ACL RIGHTS=texk] Logged in
* ENABLED QRESYNC
2 OK Enabled.
* NAMESPACE (("" "/")("_PostaCancellataPerErrore/"
"/")) NIL NIL
3 OK Namespace completed.
* LIST () "/" extern/subfolder
4 OK List completed.
5 OK Delete completed.
6 OK Unsubscribe completed.
7 OK Delete completed.
8 OK Unsubscribe completed.
* BYE Logging out
9 OK Logout completed.
=================================
Here follows debug log from dovecot.
Mar 26 09:59:43 imap-login: Info: Login: user=<testimap2.csia at
unipd.it>,
method=PLAIN, rip=147.162.10.141, lip=147.162.10.84, mpid=1771,
session=<DXefPC0SWQCTogqN>
Mar 26 09:59:43 script-login: Debug: Added userdb setting:
mail_location=sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:43 imap: Debug: Loading modules from directory:
/usr/lib/dovecot/modules
Mar 26 09:59:43 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib01_acl_plugin.so
Mar 26 09:59:43 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib02_imap_acl_plugin.so
Mar 26 09:59:43 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib02_lazy_expunge_plugin.so
Mar 26 09:59:43 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib10_quota_plugin.so
Mar 26 09:59:43 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Mar 26 09:59:43 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib15_notify_plugin.so
Mar 26 09:59:43 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_listescape_plugin.so
Mar 26 09:59:43 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Mar 26 09:59:43 imap: Debug: Added userdb setting:
mail_location=sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Effective
uid=1003, gid=1003,
home=/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl: No
acl_shared_dict setting - shared mailbox listing is disabled
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Quota root:
name=User quota backend=dict
args=:file:/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at
unipd.it/testimap2.csia at unipd.it.quota
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Quota rule:
root=User quota mailbox=* bytes=1153433600 messages=0
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Quota rule:
root=User quota mailbox=Trash bytes=+104857600 messages=0
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Quota warning:
bytes=1095761920 (95%) messages=0 reverse=no command=quota-warning 95
testimap2.csia at unipd.it
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Quota warning:
bytes=922746880 (80%) messages=0 reverse=no command=quota-warning 80
testimap2.csia at unipd.it
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Quota grace:
root=User quota bytes=115343360 (10%)
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: dict quota:
user=testimap2.csia at unipd.it,
uri=file:/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at
unipd.it/testimap2.csia at unipd.it.quota,
noenforcing=0
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Namespace inbox:
type=private, prefix=, sep=/, inbox=yes, hidden=no, list=yes,
subscriptions=yes
location=sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: fs:
root=/NAS1/unipd.it/mailbox/t/testimap2.csia at unipd.it/sdbox,
index=/INDEX1/unipd.it/t/testimap2.csia at unipd.it, indexpvt=, control=,
inbox=, alt=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl: initializing
backend with data: vfile:/etc/dovecot/dovecot-acl
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl: acl username
= testimap2.csia at unipd.it
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl: owner = 1
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl vfile: Global
ACL file: /etc/dovecot/dovecot-acl
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Namespace :
type=private, prefix=_PostaCancellataPerErrore/, sep=/, inbox=no,
hidden=no, list=yes, subscriptions=yes
location=maildir:/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at
unipd.it/expunged
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: maildir++:
root=/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at unipd.it/expunged,
index=, indexpvt=, control=, inbox=, altMar 26 09:59:43 imap(testimap2.csia at
unipd.it): Debug: acl: initializing
backend with data: vfile:/etc/dovecot/dovecot-acl
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl: acl username
= testimap2.csia at unipd.it
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl: owner = 1
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl vfile: Global
ACL file: /etc/dovecot/dovecot-acl
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/NAS1/unipd.it/mailbox/t/testimap2.csia at unipd.it/sdbox/mailboxes/dovecot-acl
not found
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox/mailboxes/extern/subfolder/dbox-Mails/dovecot-acl
not found
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox/mailboxes/extern/dbox-Mails/dovecot-acl
not found
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at
unipd.it/expunged/.extern/dovecot-acl
not found
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at unipd.it/expunged/dovecot-acl
not found
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Namespace
_PostaCancellataPerErrore/:
/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at unipd.it/expunged/.extern
doesn't
exist yet, using default permissions
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Namespace
_PostaCancellataPerErrore/: Using permissions from
/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at unipd.it/expunged:
mode=0700 gid=default
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at unipd.it/expunged/dovecot-acl
not found
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at
unipd.it/expunged/.extern/dovecot-acl
not found
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: copy from extern:
box=_PostaCancellataPerErrore/extern, uid=1, msgid=, size=523
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: copy from extern:
box=_PostaCancellataPerErrore/extern, uid=2, msgid=, size=523
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: copy from extern:
box=_PostaCancellataPerErrore/extern, uid=3, msgid=, size=523
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: copy from extern:
box=_PostaCancellataPerErrore/extern, uid=4, msgid=, size=523
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: copy from extern:
box=_PostaCancellataPerErrore/extern, uid=5, msgid=, size=524
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: expunge:
box=extern, uid=1, msgid=, size=523
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: expunge:
box=extern, uid=2, msgid=, size=523
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: expunge:
box=extern, uid=3, msgid=, size=523
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: expunge:
box=extern, uid=4, msgid=, size=523
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: expunge:
box=extern, uid=5, msgid=, size=524
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Debug: Namespace : Using
permissions from /NAS1/unipd.it/mailbox/t/testimap2.csia at unipd.it/sdbox:
mode=0755 gid=default
Mar 26 09:59:43 imap(testimap2.csia at unipd.it): Info: Mailbox deleted: extern
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Info: Mailbox deleted:
extern/subfolder
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Info: Disconnected:
Logged out in=162 out=704
Mar 26 09:59:44 imap-login: Info: Login: user=<testimap2.csia at
unipd.it>,
method=PLAIN, rip=147.162.10.141, lip=147.162.10.84, mpid=1778,
session=<vUqqPC0SXACTogqN>
Mar 26 09:59:44 script-login: Debug: Added userdb setting:
mail_location=sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:44 imap: Debug: Loading modules from directory:
/usr/lib/dovecot/modules
Mar 26 09:59:44 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib01_acl_plugin.so
Mar 26 09:59:44 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib02_imap_acl_plugin.so
Mar 26 09:59:44 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib02_lazy_expunge_plugin.so
Mar 26 09:59:44 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib10_quota_plugin.so
Mar 26 09:59:44 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Mar 26 09:59:44 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib15_notify_plugin.so
Mar 26 09:59:44 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_listescape_plugin.so
Mar 26 09:59:44 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Mar 26 09:59:44 imap: Debug: Added userdb setting:
mail_location=sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: Effective
uid=1003, gid=1003,
home=/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: acl: No
acl_shared_dict setting - shared mailbox listing is disabled
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: Quota root:
name=User quota backend=dict
args=:file:/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at
unipd.it/testimap2.csia at unipd.it.quota
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: Quota rule:
root=User quota mailbox=* bytes=1153433600 messages=0
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: Quota rule:
root=User quota mailbox=Trash bytes=+104857600 messages=0
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: Quota warning:
bytes=1095761920 (95%) messages=0 reverse=no command=quota-warning 95
testimap2.csia at unipd.it
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: Quota warning:
bytes=922746880 (80%) messages=0 reverse=no command=quota-warning 80
testimap2.csia at unipd.it
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: Quota grace:
root=User quota bytes=115343360 (10%)
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: dict quota:
user=testimap2.csia at unipd.it,
uri=file:/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at
unipd.it/testimap2.csia at unipd.it.quota,
noenforcing=0
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: Namespace inbox:
type=private, prefix=, sep=/, inbox=yes, hidden=no, list=yes,
subscriptions=yes
location=sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: fs:
root=/NAS1/unipd.it/mailbox/t/testimap2.csia at unipd.it/sdbox,
index=/INDEX1/unipd.it/t/testimap2.csia at unipd.it, indexpvt=, control=,
inbox=, alt=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: acl: initializing
backend with data: vfile:/etc/dovecot/dovecot-acl
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: acl: acl username
= testimap2.csia at unipd.it
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: acl: owner = 1
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: acl vfile: Global
ACL file: /etc/dovecot/dovecot-acl
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: Namespace :
type=private, prefix=_PostaCancellataPerErrore/, sep=/, inbox=no,
hidden=no, list=yes, subscriptions=yes
location=maildir:/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at
unipd.it/expunged
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: maildir++:
root=/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at unipd.it/expunged,
index=, indexpvt=, control=, inbox=, altMar 26 09:59:44 imap(testimap2.csia at
unipd.it): Debug: acl: initializing
backend with data: vfile:/etc/dovecot/dovecot-acl
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: acl: acl username
= testimap2.csia at unipd.it
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: acl: owner = 1
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: acl vfile: Global
ACL file: /etc/dovecot/dovecot-acl
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox/mailboxes/INBOX/dbox-Mails/dovecot-acl
not found
Mar 26 09:59:44 imap(testimap2.csia at unipd.it): Info: Disconnected:
Logged out in=77 out=1009
Mar 26 10:01:50 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at
unipd.it/expunged/.INBOX\2eTrash/dovecot-acl
not found
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at
unipd.it/expunged/.\2eLEGGIMI/dovecot-acl
not found
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox/mailboxes/INBOX.Trash/dbox-Mails/dovecot-acl
not found
Mar 26 10:01:51 imap-login: Info: Login: user=<testimap2.csia at
unipd.it>,
method=PLAIN, rip=147.162.200.67, lip=147.162.10.86, mpid=2474,
session=<VWBCRC0SugCToshD>
Mar 26 10:01:51 script-login: Debug: Added userdb setting:
mail_location=sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 10:01:51 imap: Debug: Loading modules from directory:
/usr/lib/dovecot/modules
Mar 26 10:01:51 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib01_acl_plugin.so
Mar 26 10:01:51 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib02_imap_acl_plugin.so
Mar 26 10:01:51 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib02_lazy_expunge_plugin.so
Mar 26 10:01:51 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib10_quota_plugin.so
Mar 26 10:01:51 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib11_imap_quota_plugin.so
Mar 26 10:01:51 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib15_notify_plugin.so
Mar 26 10:01:51 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_listescape_plugin.so
Mar 26 10:01:51 imap: Debug: Module loaded:
/usr/lib/dovecot/modules/lib20_mail_log_plugin.so
Mar 26 10:01:51 imap: Debug: Added userdb setting:
mail_location=sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: Effective
uid=1003, gid=1003,
home=/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at unipd.it
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl: No
acl_shared_dict setting - shared mailbox listing is disabled
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: Quota root:
name=User quota backend=dict
args=:file:/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at
unipd.it/testimap2.csia at unipd.it.quota
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: Quota rule:
root=User quota mailbox=* bytes=1153433600 messages=0
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: Quota rule:
root=User quota mailbox=Trash bytes=+104857600 messages=0
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: Quota warning:
bytes=1095761920 (95%) messages=0 reverse=no command=quota-warning 95
testimap2.csia at unipd.it
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: Quota warning:
bytes=922746880 (80%) messages=0 reverse=no command=quota-warning 80
testimap2.csia at unipd.it
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: Quota grace:
root=User quota bytes=115343360 (10%)
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: dict quota:
user=testimap2.csia at unipd.it,
uri=file:/SYSTEM/USERS/homes/unipd.it/t/testimap2.csia at
unipd.it/testimap2.csia at unipd.it.quota,
noenforcing=0
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: Namespace inbox:
type=private, prefix=, sep=/, inbox=yes, hidden=no, list=yes,
subscriptions=yes
location=sdbox:/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox:INDEX=/INDEX1/unipd.it/t/testimap2.csia at
unipd.it:ALT=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: fs:
root=/NAS1/unipd.it/mailbox/t/testimap2.csia at unipd.it/sdbox,
index=/INDEX1/unipd.it/t/testimap2.csia at unipd.it, indexpvt=, control=,
inbox=, alt=/ALTSTORAGE1/unipd.it/t/testimap2.csia at unipd.it
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl: initializing
backend with data: vfile:/etc/dovecot/dovecot-acl
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl: acl username
= testimap2.csia at unipd.it
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl: owner = 1
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl vfile: Global
ACL file: /etc/dovecot/dovecot-acl
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: Namespace :
type=private, prefix=_PostaCancellataPerErrore/, sep=/, inbox=no,
hidden=no, list=yes, subscriptions=yes
location=maildir:/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at
unipd.it/expunged
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: maildir++:
root=/SYSTEM/USERS/mailbox/unipd.it/t/testimap2.csia at unipd.it/expunged,
index=, indexpvt=, control=, inbox=, altMar 26 10:01:51 imap(testimap2.csia at
unipd.it): Debug: acl: initializing
backend with data: vfile:/etc/dovecot/dovecot-acl
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl: acl username
= testimap2.csia at unipd.it
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl: owner = 1
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl vfile: Global
ACL file: /etc/dovecot/dovecot-acl
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox/mailboxes/INBOX.Trash/dbox-Mails/dovecot-acl
not found
Mar 26 10:01:51 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox/mailboxes/Drafts/dbox-Mails/dovecot-acl
not found
Mar 26 10:01:52 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox/mailboxes/Spam/dbox-Mails/dovecot-acl
not found
Mar 26 10:01:52 imap(testimap2.csia at unipd.it): Debug: acl vfile: file
/NAS1/unipd.it/mailbox/t/testimap2.csia at
unipd.it/sdbox/mailboxes/Templates/dbox-Mails/dovecot-acl
not found
