catching up with sync logs
Rudy Gevaert
rudy.gevaert at ugent.be
Tue Jun 30 06:02:50 EDT 2009
About that specific user:
on the replica it was on a specific folder the sync was stopping.
When I reconstructed his mailbox on the replica I was able to
sync_client -u user at domain.
Then the user came in sync.
Citeren Rudy Gevaert <rudy.gevaert at ugent.be>:
> Hi Bron,
>
> Thanks for the quick reply.
>
> Citeren Bron Gondwana <brong at fastmail.fm>:
>
>> What's happening at the other end? It looks to me like you're either
>> waiting on locks, or the process at the other end has died.
>>
>> (worst case, some corruption isn't being handled correctly by sync_client,
>> and is causing protocol alignment issues, but I suspect locking or death)
>
> (I can also say that the file system check on the replica gave me some
> lost and found files.)
>
> I gave it an other shot and now when I process the 12MB sync log I get:
>
> on the cyrus master server:
>
>
>
> open("/mail/mail3/imap/domain/u/ugent.be/t/user/torsten^dhondt/Ongewenste
> e-mail/cyrus.index", O_RDWR) = 11
> fstat64(11, {st_mode=S_IFREG|0600, st_size=448, ...}) = 0
> mmap2(NULL, 16384, PROT_READ, MAP_SHARED, 11, 0) = 0xb7b88000
> open("/mail/mail3/imap/domain/u/ugent.be/t/user/torsten^dhondt/Ongewenste
> e-mail/cyrus.cache", O_RDWR) = 12
> fstat64(12, {st_mode=S_IFREG|0600, st_size=8428, ...}) = 0
> mmap2(NULL, 24576, PROT_READ, MAP_SHARED, 12, 0) = 0xb7b82000
> fstat64(11, {st_mode=S_IFREG|0600, st_size=448, ...}) = 0
> fcntl64(3, F_SETLKW, {type=F_RDLCK, whence=SEEK_SET, start=0, len=0}) = 0
> fstat64(3, {st_mode=S_IFREG|0600, st_size=4025524, ...}) = 0
> stat64("/mail/mail3/var/imap/mailboxes.db", {st_mode=S_IFREG|0600,
> st_size=4025524, ...}) = 0
> fcntl64(3, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0
> write(6,
> "\27\3\1\0p_V\22\0268\256\377\10\360E\257E^\371vV\353\304"..., 117) =
> 117
> time(NULL) = 1246354048
> read(6, "\27\3\1\0P", 5) = 5
> read(6, "<\374Ec\224\316\3259(\\\341\232\361\272D\275\30=\214\251"...,
> 80) = 80
> time([1246354048]) = 1246354048
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> send(7, "<179>Jun 30 11:27:28 mail3/sync_"..., 160, MSG_NOSIGNAL) = 160
> close(9) = 0
> munmap(0xb7f4a000, 199) = 0
> close(11) = 0
> munmap(0xb7b88000, 16384) = 0
> close(12) = 0
> munmap(0xb7b82000, 24576) = 0
> write(6,
> "\27\3\1\0000\20\241\375A\314R/\230l\362\224e\313\366s\322"..., 53) = 53
> time(NULL) = 1246354048
> read(6, "\27\3\1\0000", 5) = 5
> read(6, "\370\262\322\4\2003\300\213\204\231\322}Dx\324\250\374"..., 48) = 48
> time([1246354049]) = 1246354049
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> send(7, "<182>Jun 30 11:27:29 mail3/sync_"..., 71, MSG_NOSIGNAL) = 71
> time([1246354049]) = 1246354049
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> send(7, "<179>Jun 30 11:27:29 mail3/sync_"..., 79, MSG_NOSIGNAL) = 79
> close(8) = 0
> write(6,
> "\27\3\1\0000%Yw>\301,\4\241GJ\202\261\352G\225\224\304"..., 53) = 53
> time(NULL) = 1246354049
> read(6, "\27\3\1\0000", 5) = 5
> read(6, "\351\313\255\4\tH\24\375u_\21\206\0\3166\312yS\310\216"..., 48) = 48
> time(NULL) = 1246354049
> select(7, [6], NULL, NULL, {0, 0}) = 0 (Timeout)
> time(NULL) = 1246354049
> shutdown(6, 0 /* receive */) = 0
> close(6) = 0
> munmap(0xb6345000, 16384) = 0
> close(10) = 0
> munmap(0xb6477000, 16384) = 0
> close(5) = 0
> munmap(0xb605b000, 327680) = 0
> close(4) = 0
> munmap(0xb64c7000, 4038656) = 0
> close(3) = 0
> munmap(0xb68a1000, 32768) = 0
> munmap(0xb7a5d000, 98304) = 0
> munmap(0xb68a9000, 18563072) = 0
> munmap(0xb7a75000, 663552) = 0
> munmap(0xb7f4b000, 16384) = 0
> exit_group(-1904809439) = ?
> Process 16586 detached
>
> on the replica I straced the sync server that was handling that sync_client
>
> open("/mail/mail3r/imap/sync./8349.cache", O_RDWR|O_CREAT|O_TRUNC, 0666) = 16
> fcntl64(18, F_SETLKW, {type=F_UNLCK, whence=SEEK_SET, start=0, len=0}) = 0
> close(18) = 0
> time([1246354049]) = 1246354049
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> stat64("/etc/localtime", {st_mode=S_IFREG|0644, st_size=1067, ...}) = 0
> send(6, "<182>Jun 30 11:27:29 mail3r/sync"..., 64, MSG_NOSIGNAL) = 64
> write(1,
> "\27\3\1\0000\370\262\322\4\2003\300\213\204\231\322}Dx"..., 53) = 53
> time(NULL) = 1246354049
> read(0, "\27\3\1\0000", 5) = 5
> read(0, "%Yw>\301,\4\241GJ\202\261\352G\225\224\304x=\21+R6#z\254"...,
> 48) = 48
> write(1,
> "\27\3\1\0000\351\313\255\4\tH\24\375u_\21\206\0\3166\312"..., 53) = 53
> close(19) = 0
> munmap(0xb7f85000, 201) = 0
> close(20) = 0
> munmap(0xb6464000, 24576) = 0
> close(21) = 0
> munmap(0xb629a000, 548864) = 0
> close(16) = 0
> unlink("/mail/mail3r/imap/sync./8349.cache") = 0
> rmdir("") = -1 ENOENT (No such file or
> directory)
> close(15) = 0
> munmap(0xb6407000, 4096) = 0
> unlink("/mail/mail3r/var/imap/proc/8349") = 0
> time(NULL) = 1246354049
> select(1, [0], NULL, NULL, {0, 0}) = 0 (Timeout)
> time(NULL) = 1246354049
> open("/dev/null", O_RDWR) = 15
> shutdown(0, 0 /* receive */) = 0
> dup2(15, 0) = 0
> shutdown(1, 0 /* receive */) = 0
> dup2(15, 1) = 1
> shutdown(2, 0 /* receive */) = 0
> dup2(15, 2) = 2
> close(15) = 0
> write(3, "\1\0\0\0\235 \0\0", 8) = 8
> rt_sigaction(SIGALRM, {0x8072c20, [], SA_ONESHOT}, NULL, 8) = 0
> rt_sigaction(SIGHUP, {0x8072c20, [], SA_RESTART|SA_ONESHOT}, NULL, 8) = 0
> rt_sigaction(SIGINT, {0x8072c20, [], SA_RESTART|SA_ONESHOT}, NULL, 8) = 0
> rt_sigaction(SIGQUIT, {0x8072c20, [], SA_RESTART|SA_ONESHOT}, NULL, 8) = 0
> alarm(114) = 0
> fcntl64(14, F_SETLKW, {type=F_WRLCK, whence=SEEK_SET, start=0, len=0})
> = ? ERESTARTSYS (To be restarted)
> --- SIGALRM (Alarm clock) @ 0 (0) ---
> sigreturn() = ? (mask now [])
> munmap(0xb6320000, 32768) = 0
> close(22) = 0
> munmap(0xb6475000, 3735552) = 0
> close(8) = 0
> munmap(0xb6044000, 262144) = 0
> close(12) = 0
> munmap(0xb643d000, 16384) = 0
> close(13) = 0
> munmap(0xb639c000, 106496) = 0
> close(17) = 0
> munmap(0xb6933000, 32768) = 0
> munmap(0xb7aef000, 98304) = 0
> munmap(0xb693b000, 18563072) = 0
> munmap(0xb7b07000, 663552) = 0
> munmap(0xb7f86000, 16384) = 0
> exit_group(0) = ?
> Process 8349 detached
>
>
> Maybe this information is not enough, if you tell me what you need I
> can provide :)
>
> --
> -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- --
> Rudy Gevaert Rudy.Gevaert at UGent.be tel:+32 9 264 4734
> Directie ICT, afd. Infrastructuur Direction ICT, Infrastructure dept.
> Groep Systemen Systems group
> Universiteit Gent Ghent University
> Krijgslaan 281, gebouw S9, 9000 Gent, Belgie www.UGent.be
> -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- --
>
>
> ----
> Cyrus Home Page: http://cyrusimap.web.cmu.edu/
> Cyrus Wiki/FAQ: http://cyrusimap.web.cmu.edu/twiki
> List Archives/Info: http://asg.web.cmu.edu/cyrus/mailing-list.html
>
--
-- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- --
Rudy Gevaert Rudy.Gevaert at UGent.be tel:+32 9 264 4734
Directie ICT, afd. Infrastructuur Direction ICT, Infrastructure dept.
Groep Systemen Systems group
Universiteit Gent Ghent University
Krijgslaan 281, gebouw S9, 9000 Gent, Belgie www.UGent.be
-- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- -- --
More information about the Info-cyrus
mailing list