(re-) dsync: INBOX Can't be deleted
24 Jul
2020
24 Jul
'20
5:34 p.m.
with
dovecot --version
2.3.10.1 (a3d0e1171)
exec of
doveadm -v -o mail_fsync=never backup -R -f -u testuser@example.com imapc:
currently fails, here, with
Error: Mailbox INBOX sync: mailbox_delete failed: INBOX can't be deleted
checking lists, this has been seen before
@ https://dovecot.org/pipermail/dovecot/2016-January/102988.html
On 24 Jan 2016, at 18:47, Timo Sirainen <tss at iki.fi> wrote:
> During Migration with dsync I get these Errors:
> Error: Mailbox INBOX sync: mailbox_delete failed: INBOX can't be deleted
> Is there a way to work around these Errors ?
With "doveadm backup" you have gotten into such a state that the INBOX needs to be deleted and recreated to preserve it exactly as it's in source. But you're using Maildir format, which doesn't allow deleting INBOX. So possibilities:
a) Don't use Maildir format
b) Delete the entire Maildir manually with rm -rf and the next doveadm backup should work (if not then something strange is going on)
per "b)", i explicitly 'rm' the Maildir
rm -rf /data/vmail/example.com/testuser/Maildir
tree /data/vmail/example.com/testuser/Maildir
/data/vmail/example.com/testuser/Maildir [error opening dir]
on re-exec, the backup still fails
dsync(testuser@example.com): Info: imapc(mx.example.com:993): Connected to 10.1.0.20:993 (local 10.1.0.114:42926)
dsync(testuser@example.com): Error: Mailbox INBOX sync: mailbox_delete failed: INBOX can't be deleted.
where
tree /data/vmail/example.com/testuser/Maildir
/data/vmail/example.com/testuser/Maildir
├── cur
├── new
├── sieve
│ └── tmp
└── tmp
and log detail,
Debug: Loading modules from directory: /usr/lib64/dovecot
Debug: Module loaded: /usr/lib64/dovecot/lib20_virtual_plugin.so
Debug: Loading modules from directory: /usr/lib64/dovecot/doveadm
doveadm(testuser@example.com)<>: Debug: auth-master: userdb lookup(testuser@example.com): Started userdb lookup
doveadm(testuser@example.com)<>: Debug: auth-master: conn unix:/run/dovecot/auth-userdb: Connecting
doveadm(testuser@example.com)<>: Debug: auth-master: conn unix:/run/dovecot/auth-userdb (pid=25419,uid=0): Client connected (fd=10)
doveadm(testuser@example.com)<>: Debug: auth-master: userdb lookup(testuser@example.com): auth USER input: testuser@example.com uid=5000 gid=5000 home=/data/vmail/example.com/testuser/Maildir
doveadm(testuser@example.com)<>: Debug: auth-master: userdb lookup(testuser@example.com): Finished userdb lookup (username=testuser@example.com uid=5000 gid=5000 home=/data/vmail/example.com/testuser/Maildir)
doveadm(testuser@example.com): Debug: Effective uid=5000, gid=5000, home=/data/vmail/example.com/testuser/Maildir
doveadm(testuser@example.com): Debug: Namespace inbox: type=private, prefix=, sep=/, inbox=yes, hidden=no, list=yes, subscriptions=yes location=maildir:/data/vmail/example.com/testuser/Maildir:CONTROL=/data/vmail/example.com/testuser/_control:INDEX=/var/vmail-index/example.com/testuser:LAYOUT=fs:UTF-8
doveadm(testuser@example.com): Debug: fs: root=/data/vmail/example.com/testuser/Maildir, index=/var/vmail-index/example.com/testuser, indexpvt=, control=/data/vmail/example.com/testuser/_control, inbox=/data/vmail/example.com/testuser/Maildir, alt=
doveadm(testuser@example.com): Debug: Namespace shared: type=shared, prefix=shared/%u/, sep=/, inbox=no, hidden=no, list=children, subscriptions=yes location=maildir:/data/vmail/example.com/testuser/Maildir:INDEXPVT=/var/vmail-index/shared/%u
doveadm(testuser@example.com): Debug: shared: root=/run/dovecot/, index=, indexpvt=, control=, inbox=, alt=
doveadm(testuser@example.com): Debug: Namespace virtual: type=private, prefix=virtual/, sep=/, inbox=no, hidden=no, list=yes, subscriptions=yes location=virtual:/data/vmail/virtual:INDEX=MEMORY
doveadm(testuser@example.com): Debug: fs: root=/data/vmail/virtual, index=, indexpvt=, control=, inbox=, alt=
doveadm(testuser@example.com): Debug: brain M: Namespace has location maildir:/data/vmail/example.com/testuser/Maildir:CONTROL=/data/vmail/example.com/testuser/_control:INDEX=/var/vmail-index/example.com/testuser:LAYOUT=fs:UTF-8
doveadm(testuser@example.com): Debug: Namespace : Using permissions from /data/vmail/example.com/testuser/Maildir: mode=0700 gid=default
dsync(testuser@example.com): Debug: Effective uid=5000, gid=5000, home=/data/vmail/example.com/testuser/Maildir
dsync(testuser@example.com): Debug: Namespace inbox: type=private, prefix=, sep=/, inbox=yes, hidden=no, list=yes, subscriptions=yes location=imapc:
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): Created new connection
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): Looking up IP address (reconnect_ok=true, last_connect=1595599741)
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): Connecting to 10.1.0.20:993
dsync(testuser@example.com): Info: imapc(mx.example.com:993): Connected to 10.1.0.20:993 (local 10.1.0.114:42924)
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): Starting SSL handshake
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): SSL handshake successful
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): Server capabilities: IMAP4rev1 AUTH=PLAIN ACL BINARY CATENATE CHILDREN CONDSTORE ENABLE ESEARCH ESORT I18NLEVEL=1 ID IDLE LIST-EXTENDED LIST-STATUS LITERAL+ LOGIN-REFERRALS MULTIAPPEND NAMESPACE QRESYNC QUOTA RIGHTS=ektx SASL-IR SEARCHRES SORT THREAD=ORDEREDSUBJECT UIDPLUS UNSELECT WITHIN XLIST
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): Authenticating as testuser@example.com
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): Server capabilities: IMAP4rev1 ACL BINARY CATENATE CHILDREN CONDSTORE ENABLE ESEARCH ESORT I18NLEVEL=1 ID IDLE LIST-EXTENDED LIST-STATUS LITERAL+ LOGIN-REFERRALS MULTIAPPEND NAMESPACE QRESYNC QUOTA RIGHTS=ektx SASL-IR SEARCHRES SORT THREAD=ORDEREDSUBJECT UIDPLUS UNSELECT WITHIN XLIST
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): Authenticated successfully
dsync(testuser@example.com): Debug: imapc: root=, index=, indexpvt=, control=, inbox=, alt=
dsync(testuser@example.com): Debug: Namespace shared: type=shared, prefix=shared/%u/, sep=/, inbox=no, hidden=no, list=children, subscriptions=yes location=maildir:/data/vmail/example.com/testuser/Maildir:INDEXPVT=/var/vmail-index/shared/%u
dsync(testuser@example.com): Debug: shared: root=/run/dovecot/, index=, indexpvt=, control=, inbox=, alt=
dsync(testuser@example.com): Debug: Namespace virtual: type=private, prefix=virtual/, sep=/, inbox=no, hidden=no, list=yes, subscriptions=yes location=virtual:/data/vmail/virtual:INDEX=MEMORY
dsync(testuser@example.com): Debug: fs: root=/data/vmail/virtual, index=, indexpvt=, control=, inbox=, alt=
dsync(testuser@example.com): Debug: brain S: Namespace has location imapc:
dsync(testuser@example.com): Debug: brain M: Local mailbox tree: Sent guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=yes last_change=0 last_subs=1595535189
dsync(testuser@example.com): Debug: brain S: Local mailbox tree: Trash guid=7f5af7ba291b2df1a11d573bdb55d7e9 uid_validity=1 uid_next=89207 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Local mailbox tree: Drafts guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=yes last_change=0 last_subs=1595535189
dsync(testuser@example.com): Debug: brain S: Local mailbox tree: Templates guid=d9f092123a43acb205a6869342cf9dd6 uid_validity=126054 uid_next=22295 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Local mailbox tree: Trash guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=yes last_change=0 last_subs=1595534293
dsync(testuser@example.com): Debug: brain S: Local mailbox tree: Sent guid=bfb2e03fdce327671e82bf173b1ccb8b uid_validity=1 uid_next=89068 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Local mailbox tree: INBOX guid=6f51443ad5eb195f9f4400005439fba4 uid_validity=1595534294 uid_next=1 subs=no last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Local mailbox tree: Junk guid=6e51443ad5eb195f9f4400005439fba4 uid_validity=1595534293 uid_next=1 subs=yes last_change=0 last_subs=1595534293
dsync(testuser@example.com): Debug: brain S: Local mailbox tree: Junk guid=87680557f26fcb26843f739f7427e8c4 uid_validity=1 uid_next=88649 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain S: Local mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1 uid_next=89209 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Remote mailbox tree: Trash guid=7f5af7ba291b2df1a11d573bdb55d7e9 uid_validity=1 uid_next=89207 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Remote mailbox tree: Templates guid=d9f092123a43acb205a6869342cf9dd6 uid_validity=126054 uid_next=22295 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Remote mailbox tree: Sent guid=bfb2e03fdce327671e82bf173b1ccb8b uid_validity=1 uid_next=89068 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Remote mailbox tree: Junk guid=87680557f26fcb26843f739f7427e8c4 uid_validity=1 uid_next=88649 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Remote mailbox tree: INBOX guid=c92f64f79f0d1ed01e6d5b314f04886c uid_validity=1 uid_next=89209 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain S: Local mailbox tree: Drafts guid=e0187b65e763143666d22094cedfe6a4 uid_validity=1 uid_next=88914 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Remote mailbox tree: Drafts guid=e0187b65e763143666d22094cedfe6a4 uid_validity=1 uid_next=88914 subs=yes last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain M: Mailbox Drafts: local=00000000000000000000000000000000/0/2, remote=e0187b65e763143666d22094cedfe6a4/0/1: mailbox not selectable yet
dsync(testuser@example.com): Debug: brain M: Mailbox INBOX: local=6f51443ad5eb195f9f4400005439fba4/0/1, remote=c92f64f79f0d1ed01e6d5b314f04886c/0/1: GUIDs conflict - will be merged later
dsync(testuser@example.com): Debug: brain M: Mailbox Junk: local=6e51443ad5eb195f9f4400005439fba4/0/1, remote=87680557f26fcb26843f739f7427e8c4/0/1: GUIDs conflict - will be merged later
dsync(testuser@example.com): Debug: brain M: Mailbox Sent: local=00000000000000000000000000000000/0/0, remote=bfb2e03fdce327671e82bf173b1ccb8b/0/1: mailbox not selectable yet
dsync(testuser@example.com): Debug: brain M: Mailbox Templates: local=00000000000000000000000000000000/0/0, remote=d9f092123a43acb205a6869342cf9dd6/0/1: mailbox not selectable yet
dsync(testuser@example.com): Debug: brain M: Mailbox Trash: local=00000000000000000000000000000000/0/0, remote=7f5af7ba291b2df1a11d573bdb55d7e9/0/1: mailbox not selectable yet
dsync(testuser@example.com): Debug: brain M: Deleting mailbox 'INBOX' (GUID 6f51443ad5eb195f9f4400005439fba4): UIDVALIDITY changed (1 -> 1595534294)
dsync(testuser@example.com): Debug: brain M: Deleting mailbox 'Junk' (GUID 6e51443ad5eb195f9f4400005439fba4): UIDVALIDITY changed (1 -> 1595534293)
dsync(testuser@example.com): Error: Mailbox INBOX sync: mailbox_delete failed: INBOX can't be deleted.
dsync(testuser@example.com): Debug: brain S: Remote mailbox tree: Sent guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=yes last_change=0 last_subs=1595535189
dsync(testuser@example.com): Debug: brain S: Remote mailbox tree: Drafts guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=yes last_change=0 last_subs=1595535189
dsync(testuser@example.com): Debug: brain S: Remote mailbox tree: Trash guid=00000000000000000000000000000000 uid_validity=0 uid_next=0 subs=yes last_change=0 last_subs=1595534293
dsync(testuser@example.com): Debug: brain S: Remote mailbox tree: INBOX guid=6f51443ad5eb195f9f4400005439fba4 uid_validity=1595534294 uid_next=1 subs=no last_change=0 last_subs=0
dsync(testuser@example.com): Debug: brain S: Remote mailbox tree: Junk guid=6e51443ad5eb195f9f4400005439fba4 uid_validity=1595534293 uid_next=1 subs=yes last_change=0 last_subs=1595534293
dsync(testuser@example.com): Debug: imapc(mx.example.com:993): Disconnected
dsync(testuser@example.com): Debug: auth-master: conn unix:/run/dovecot/auth-userdb (pid=25419,uid=0): Disconnected: Connection closed (fd=10)
given the error again on "next doveadm backup", it indeed appears "something strange is going on" ...
hints/suggestions as to what?
24 Jul
24 Jul
6:01 p.m.
hints/suggestions as to what?
for anyone interested, the causal issue is NOT directly the one reported in the non-verbose output
Error: Mailbox INBOX sync: mailbox_delete failed: INBOX can't be deleted.
rather, the relevant 'hint' is the
Debug: brain M: Mailbox INBOX: ... GUIDs conflict - will be merged later
message seen only in the debug output.
In addition to
rm -rf /data/vmail/example.com/testuser/Maildir
clearing the index data, configured here in a separate tree,
rm -rf /var/vmail-index/example.com/testuser/*
does the trick.
backup, now, appears to complete.
1612
Age (days ago)
1612
Last active (days ago)
1 comments
1 participants
participants (1)
-
PGNet Dev