[Dovecot] dsync replication errors

[Oli Schacher]

On Thu, 31 Jan 2013 17:09:20 +0200
Timo Sirainen <tss at iki.fi> wrote:


> 
> See if http://hg.dovecot.org/dovecot-2.2/rev/1d88f01ba2aa helps?
> 

I updated to the latest hg, including the "remote cmd exit wait" update.

It looks better now, but I still manage to break things :-)

#############
test 1: append 1000 messages messages with thunderbird, mdbox
-> ok, no more errors, sync ok  


#############
test 2: append only 100 messages, but use maildir again instead of
mdbox.
still produces errors and starts duplicating, even saw an
assertion error this time, but I can't reproduce it always

Jan 31 16:57:34 doco1 dovecot: imap-login: Login: user=<user1>,
method=PLAIN, rip=192.168.23.130, lip=192.168.23.61, mpid=2684,
session=<4tper5fU8gDAqBeC>
Jan 31 16:57:35 doco1 dovecot: doveadm: Error: dsync-remote(user1):
Panic: file dsync-mailbox-tree-fill.c: line 72
(dsync_mailbox_tree_add): assertion failed: (status.uidvalidity != 0)
Jan 31 16:57:35 doco1 dovecot: doveadm: Error: dsync-remote(user1):
Error: Raw backtrace: /usr/lib64/dovecot/libdovecot.so.0(+0x5ce8a) 
[0x7f65aa39de8a]
-> /usr/lib64/dovecot/libdovecot.so.0(default_fatal_handler+0x32)   
[0x7f65aa39df72] -> /usr/lib64/dovecot/libdovecot.so.0(+0x1f55a)
[0x7f65aa36055a] -> /usr/bin/doveadm(dsync_mailbox_tree_fill+0x4cf) 
[0x42f5cf] -> /usr/bin/doveadm(dsync_brain_mailbox_trees_init+0x180)
[0x428630] -> /usr/bin/doveadm(dsync_brain_run+0x393) 
[0x426033] -> /usr/bin/doveadm() [0x426331] -> /usr/bin/doveadm()
[0x434780] -> /usr/lib64/dovecot/libdovecot.so.0(io_loop_call_io+0x36) 
[0x7f65aa3aca16]
-> /usr/lib64/dovecot/libdovecot.so.0(io_loop_handler_run+0xa7)  
[0x7f65aa3adaa7]
-> /usr/lib64/dovecot/libdovecot.so.0(io_loop_run+0x28)   
[0x7f65aa3ac9b8] -> /usr/bin/doveadm() [0x424114] -> /usr/bin/doveadm()
[0x40fe4f] -> /usr/bin/doveadm() [0x41067d]
-> /usr/bin/doveadm(doveadm_mail_try_run+0x141)   
[0x410ba1] -> /usr/bin/doveadm(main+0x3f1) [0x417ba1]
-> /lib64/libc.so.6(__libc_start_main+0xfd) [0x7f65a9fcccdd]
-> /usr/bin/doveadm() [0x40f839]  
Jan 31 16:57:35 doco1 dovecot: dsync-local(user1): Error:
read(vmail at 192.168.23.62) failed: EOF
Jan 31 16:57:35 doco1 dovecot: dsync-local(user1): Error: Remote
command returned error 255
Jan 31 16:58:06 doco1 dovecot: dsync-local(user1): Error: Recent flags
state corrupted for mailbox INBOX
Jan 31 16:58:06 doco1 dovecot: doveadm(user1):
Warning: /mailstore/user1/maildir/dovecot-uidlist: Duplicate file entry
at line 59: 1359647883.M823994P2684.doco1,S=2483,W=2562 (uid 18 -> 58)
Jan 31 16:58:06 doco1 dovecot: doveadm(user1):
Warning: /mailstore/user1/maildir/dovecot-uidlist: Duplicate file entry
at line 60: 1359647883.M382644P2684.doco1,S=2533,W=2610 (uid 15 -> 59)
[...]



#############
test 3: mdbox again,  append 1000 messages with claws mail, but have
thunderbird connected at the same time to both accounts while doing so.
this leads to the same problem as before (duplication, errors). I guess
thunderbird wants to set a seen flag and modifying the mailbox while
it's being synced is probably is a bad idea, but you never know
what users are going to do :-)

Jan 31 17:13:11 doco1 dovecot: dsync-local(user1): Error: Mailbox
INBOX: Remote didn't send mail GUID=33dabe0f11980a51200c0000960042f4
(UID=104)
Jan 31 17:13:11 doco1 dovecot: dsync-local(user1): Error: Mailbox
INBOX: Remote didn't send mail GUID=33dabe0f11980a51200c0000960042f4
(UID=114)
Jan 31 17:13:11 doco1 dovecot: dsync-local(user1): Error: Mailbox
INBOX: Remote didn't send mail GUID=33dabe0f11980a51200c0000960042f4
(UID=118)
Jan 31 17:13:11 doco1 dovecot: dsync-local(user1): Error: Mailbox
INBOX: Remote didn't send mail GUID=33dabe0f11980a51200c0000960042f4
(UID=123)


Let me know if you need more info/tests.

-- 
message transmitted on 100% recycled electrons