search for: mbox_sync_handle_eof_updates

...s daily. :) I've just had a look, and among the usual "IMAP(username): FETCH for mailbox Sent UID xx got too little data: xx vs xx" messages (that means that unfortunately sometimes some messages are still written truncated) I saw this assertion failure: file mbox-sync.c: line 1305 (mbox_sync_handle_eof_updates): assertion failed: (file_size >= sync_ctx->expunged_space + trailer_size) Regards, Diego. ---- (gdb) bt full #0 0x008a9402 in __kernel_vsyscall () No symbol table info available. #1 0x00a2fd20 in raise () from /lib/libc.so.6 No symbol table info available. #2 0x00a31631 in abort () fr...

First of all apologies for using such an old version - I am trying to upgrade slowly and have had to go through this version first. As you can see I am getting an error in the log file as : file mbox-sync.c: line 1371 (mbox_sync_handle_eof_updates): assertion failed: (trailer_size <= 2) Raw backtrace: imap [0x80acdc1] -> imap [0x80accdc] -> imap(mbox_sync+0x14e9) [0x8079a29] -> imap(mbox_storage_sync_init+0x3e) [0x8079d8e] -> imap(imap_sync_nonselected+0x1c) [0x806183c] -> imap(_cmd_select_full+0xc3) [0x8059983] -> i...

...filesystem to GFS2, occasional corruptions in the users' INBOXes started appearing, where a new incoming message would be appended directly after a block of NUL bytes, and be scanned by dovecot as being glued to the preceding message. I traced this to the file extension operation performed in mbox_sync_handle_eof_updates, where the 'file_set_size' call is used. If available, file_set_size will use the posix_fallocate call. In GFS2 posix_fallocate increases the file size in 4 kB chunks (there seems to be no guarantee anyway that posix_allocate will extend a file by the exact size requested). After a success...

...xx.xx] dovecot: Jun 09 15:00:19 Info: info-cipani,ip=xx.xx.xx.xx: Logout. top=0, retr=0, del=0/122 dovecot: Jun 09 15:04:05 Info: pop3-login: Login: info-xxx, auth: PLAIN, lip: [151.8.36.12], rip: [xx.xx.xx.xx] dovecot: Jun 09 15:04:18 Error: info-xxx,ip=xx.xx.xx.xx: file mbox-sync.c: line 1129 (mbox_sync_handle_eof_updates): assertion failed: (offset == 0 || offset > 31) dovecot: Jun 09 15:07:19 Info: pop3-login: Login: info-xxx, auth: PLAIN, lip: [151.8.36.12], rip: [xx.xx.xx.xx] dovecot: Jun 09 15:07:19 Info: info-xxx,ip=xx.xx.xx.xx: Logout. top=0, retr=0, del=0/0 Where is the 122 messages of first login????...

...myhostname dovecot: imap-login: Login: user=<username>, method=PLAIN, rip=#.#.#.#, lip=#.#.#.#, TLS Jul 2 19:40:37 myhostname dovecot: IMAP(username): unlink(/var/mail/username.lock) failed: Permission denied Jul 2 19:40:48 myhostname dovecot: IMAP(username): file mbox-sync.c: line 1372 (mbox_sync_handle_eof_updates): assertion failed: (trailer_size <= 2) Jul 2 19:40:48 myhostname dovecot: IMAP(username): Raw backtrace: imap [0x80b2081] -> imap [0x80b1f99] -> imap [0x807a536] -> imap [0x807ae71] -> imap(mbox_sync+0x422) [0x807d3c2] -> imap(mbox_storage_sync_init+0x3e) [0x807d8de] -> i...

...elivery. We're using a combination of dotlock and fcntl style locking. The output of "dovecot -n" for this system appears below my signature. Periodically we see errors like the following in our logs: Oct 21 19:36:01 postoffice1 dovecot: POP3(someuser): file mbox-sync.c: line 1433 (mbox_sync_handle_eof_updates): assertion failed: (file_size >= sync_ctx->expunged_space + trailer_size) Oct 21 19:36:01 postoffice1 dovecot: POP3(someuser): Raw backtrace: pop3 [0x809eda1] -> pop3 [0x809ecbc] -> pop3(mbox_sync+0x1088) [0x806c4e8] -> pop3(mbox_storage_sync_init+0x3e) [0x806cb6e] -> pop3(client...

...on a couple different mboxes. This is using the CVS version as of May 14. So far, these are the only errors and it looks like most/all of the older ones are gone. (maybe I shouldn't say that ;-) dovecot: May 16 17:41:07 Error: 20973 IMAP(todd.bluegenesis.com): file mbox-sync.c: line 1165 (mbox_sync_handle_eof_updates): assertion failed: (file_size >= sync_ctx->file_input->v_offset) dovecot: May 16 17:41:10 Error: child 20973 (imap) killed with signal 6 (gdb) bt full #0 0xffffe410 in ?? () No symbol table info available. #1 0xbffff518 in ?? () No symbol table info available. #2 0x00000006 in ?? ()...

http://dovecot.org/test/ Just mbox fixes since 1.0-test16. The logic is simpler and more correct now. Can anyone break it anymore? I actually tested it a while with Evolution and several mailboxes and it didn't break at least immediately. :) Now maybe a few more days and I dare trying this thing myself with my real mboxes (yes, I'm still using them). Dovecot mailing list archives could

..."mails" is not available. ) at mbox-sync-rewrite.c:353 #6 0x0003e0dc in mbox_sync_rewrite (sync_ctx=0xffbff708, end_offset=The value of variable 'end_offset' is distributed across several locations, and GDB cannot access its value. ) at mbox-sync-rewrite.c:473 #7 0x0003a328 in mbox_sync_handle_eof_updates (sync_ctx=0xffbff708, mail_ctx=0xffbff5d8) at mbox-sync.c:1265 #8 0x0003a9f4 in mbox_sync_do (sync_ctx=0xffbff708, flags=Variable "flags" is not available. ) at mbox-sync.c:1465 #9 0x0003b040 in mbox_sync (mbox=0xa6758, flags=MBOX_SYNC_REWRITE) at mbox-sync.c:1692 #10 0x0003361c in mbox...

...rgument (FETCH for mailbox INBOX UID 1247) Mar 26 09:40:05 raspberrypi dovecot: imap(info): Disconnected: Internal error occurred. Refer to server log for more information. [2015-03-26 09:40:05] in= 2693 out=172626 Mar 26 09:40:07 raspberrypi dovecot: imap(info): Panic: file mbox-sync.c: line 1286 (mbox_sync_handle_eof_updates): assertion failed: (trailer_size <= 2) Mar 26 09:40:07 raspberrypi dovecot: imap(info): Fatal: master: service(imap): child 26341 killed with signal 6 (core dumps disabled) Mar 26 09:40:51 raspberrypi dovecot: imap-login: Login: user=<info>, method=PLAIN, rip=192.168.100.27, lip=192.168.1...

...7 imap(paco_mcs): Error: Next message unexpectedly corrupted in mbox file /var/spool/mail/paco_mcs at 639279728 Jun 06 12:28:47 imap(paco_mcs): Error: Unexpectedly lost From-line from mbox file /var/spool/mail/paco_mcs at 639279728 Jun 06 12:28:47 imap(paco_mcs): Panic: file mbox-sync.c: line 1338 (mbox_sync_handle_eof_updates): assertion failed: (trailer_size <= 2) Jun 06 12:28:47 imap(paco_mcs): Error: Raw backtrace: /usr/lib/dovecot/libdovecot.so.0(+0x9cd16) [0xb75e7d16] -> /usr/lib/dovecot/libdovecot.so.0(+0x9cd9f) [0xb75e7d9f] -> /usr/lib/dovecot/libdovecot.so.0(i_fatal+0) [0xb757104e] -> /usr/lib/doveco...

...ather than via IMAP. This log message is more or less saying that the indices are out of sync with respect to the mailbox, and the message that it expected to find at a file offset is not there anymore. > Mar 26 09:40:07 raspberrypi dovecot: imap(info): Panic: file > mbox-sync.c: line 1286 (mbox_sync_handle_eof_updates): assertion failed: > (trailer_size <= 2) This, though, should not happen. Your version of dovecot is rather old, so maybe an update will solve this. Joseph Tam <jtam.home at gmail.com>

...o_mcs): Error: Next message unexpectedly corrupted in mbox file /var/spool/mail/paco_mcs at 639279728 > Jun 06 12:28:47 imap(paco_mcs): Error: Unexpectedly lost From-line from mbox file /var/spool/mail/paco_mcs at 639279728 > Jun 06 12:28:47 imap(paco_mcs): Panic: file mbox-sync.c: line 1338 (mbox_sync_handle_eof_updates): assertion failed: (trailer_size <= 2) > Jun 06 12:28:47 imap(paco_mcs): Error: Raw backtrace: /usr/lib/dovecot/libdovecot.so.0(+0x9cd16) [0xb75e7d16] -> /usr/lib/dovecot/libdovecot.so.0(+0x9cd9f) [0xb75e7d9f] -> /usr/lib/dovecot/libdovecot.so.0(i_fatal+0) [0xb757104e] -> /usr/lib/d...

...age.pool') maildir-storage.c:926: warning: missing initializer maildir-storage.c:926: warning: (near initialization for `maildir_mailbox.pool') mbox-sync.c: In function `mbox_sync_seek_to_uid': mbox-sync.c:921: warning: assignment from incompatible pointer type mbox-sync.c: In function `mbox_sync_handle_eof_updates': mbox-sync.c:1228: warning: assignment from incompatible pointer type mbox-sync.c:1287: warning: assignment from incompatible pointer type mbox-sync.c: In function `mbox_sync_update_index_header': mbox-sync.c:1330: warning: assignment from incompatible pointer type mbox-sync.c: In function...

...0) at ioloop-poll.c:189 #14 0x00078650 in io_loop_run (ioloop=0xad970) at ioloop.c:235 #15 0x0002a7d8 in main (argc=1, argv=0xffbffb54, envp=0xffbffb5c) at main.c:238 (gdb) up 4 #4 0x0003c2b4 in mbox_sync_do (sync_ctx=0xffbff580, flags=MBOX_SYNC_UNDIRTY) at mbox-sync.c:1473 1473 if (mbox_sync_handle_eof_updates(sync_ctx, &mail_ctx) < 0) (gdb) print *sync_ctx $1 = {mbox = 0xb6a58, flags = MBOX_SYNC_UNDIRTY, input = 0xba5d0, file_input = 0xbcde8, write_fd = 6, index_sync_ctx = 0xb6f38, sync_view = 0xbd2b0, t = 0xba0d8, hdr = 0xbd2f8, header = 0xaee78, from_line = 0xaeae0, base_uid_validity = 10...

..._kill () from /lib/libc.so.1 #1 0xff15ff38 in raise () from /lib/libc.so.1 #2 0xff140160 in abort () from /lib/libc.so.1 #3 0x00089cd4 in i_internal_panic_handler () #4 0x00089728 in i_panic () #5 0x00046e58 in mbox_sync_read_and_move () #6 0x00047418 in mbox_sync_rewrite () #7 0x000426dc in mbox_sync_handle_eof_updates () #8 0x00042d68 in mbox_sync_do () #9 0x000438b8 in mbox_sync () #10 0x00043b40 in mbox_storage_sync_init () #11 0x0002a830 in imap_sync_init () #12 0x0002adac in cmd_sync () #13 0x000231e4 in client_handle_input () #14 0x00023370 in client_handle_input () #15 0x00023458 in _client_input () #16...

The actual alpha4 release this time. With a few changes since the pre-release. The important changes again: - Default lock_method changed to flock instead of the old fcntl. Solaris users will need to set it back to fcntl. This makes sure that Dovecot's indexes aren't accidentally used with NFS. - IMAP: We might have sent extra EXPUNGE messages when output buffer got full. This could

...ails" is not available. ) at mbox-sync-rewrite.c:353 #6 0x0003e07c in mbox_sync_rewrite (sync_ctx=0xffbff708, end_offset=The value of variable 'end_offset' is distributed across several locations, and GDB cannot access its value. ) at mbox-sync-rewrite.c:473 #7 0x0003a2c8 in mbox_sync_handle_eof_updates (sync_ctx=0xffbff708, mail_ctx=0xffbff5d8) at mbox-sync.c:1265 #8 0x0003a994 in mbox_sync_do (sync_ctx=0xffbff708, flags=Variable "flags" is not available. ) at mbox-sync.c:1465 #9 0x0003afe0 in mbox_sync (mbox=0xaa438, flags=MBOX_SYNC_REWRITE) at mbox-sync.c:1692 #10 0x0003...

...t () from /lib/libc.so.1 No symbol table info available. #3 0xff1cb984 in default_fatal_finish () from /opt/local/lib/dovecot/libdovecot.so.0 No symbol table info available. #4 0xff1cbc38 in i_panic () from /opt/local/lib/dovecot/libdovecot.so.0 No symbol table info available. #5 0xff31954c in mbox_sync_handle_eof_updates () from /opt/local/lib/dovecot/libdovecot-storage.so.0 No symbol table info available. #6 0xff319fb0 in mbox_sync_do () from /opt/local/lib/dovecot/libdovecot-storage.so.0 No symbol table info available. #7 0xff31ade0 in mbox_sync_int () from /opt/local/lib/dovecot/libdovecot-storage.so.0 N...

...box_lock_type $1 = 0 -------------- next part -------------- dovecot: Apr 27 15:16:23 Error: 27291 IMAP(support): mbox sync: UID inserted in the middle of mailbox /mailhome/new/s/b/support/DONE (122769 > 119000) dovecot: Apr 27 15:16:27 Error: 27291 IMAP(support): file mbox-sync.c: line 1154 (mbox_sync_handle_eof_updates): assertion failed: (file_size >= sync_ctx->file_input->v_offset) dovecot: Apr 27 15:16:36 Error: child 27291 (imap) killed with signal 6 Core was generated by `imap'. Program terminated with signal 6, Aborted. (gdb) bt full #0 0xffffe410 in ?? () No symbol table info available. #1...