- dovecot - dovecot.org

[Dovecot] lazy_expunge and moving messages
by Lutz Preßler 14 Oct '10

14 Oct '10

Hello, testing the lazy_expunge plugin (with 2.0.5), I realized the following effect, which users may not expect/understand: As moving messages from one folder to another has to be done by clients with the IMAP command sequence COPY STORE EXPUNGE, every moved message is also put into the "shadow folder" of the source folder. Maybe it's possible to extend the plugin to optionally hook into the COPY operation, remember it somewhere with the message (simply as special/ configurable IMAP flag?), and then really expunge messages with this flag set. What do you think? I haven't looked into the plugin interface yet. Of course, if a user manually copies a message and deletes the source message later (maybe having the copy deleted inbetween...), the consequence may not be expected either... Greetings, Lutz -- Lutz Preßler <Lutz.Pressler(a)SerNet.DE> http://www.SerNet.DE/ SerNet Service Network GmbH, Bahnhofsallee 1b, D-37081 Göttingen Tel.: +49-551-370000-2, FAX: +49-551-370000-9 AG Göttingen, HRB 2816, GF: Dr. Johannes Loxen

2 2

[Dovecot] limits to serve sure a number of users
by Schmidt 14 Oct '10

14 Oct '10

Hi, lets say dovcot should serve 1000 user (only imaps) without rejecting a users connection because of to short resources. With version 1.x I had to increase login_max_processes_count = ... With 2.x I'm not sure which parameters I have to set. So Thunderbird 3.x has a default value of 5 connections to cache. "dovadm who" shows quite often 5 connections: userx 5 imap (11154 11152 11158 11156 11150) ... So dovecot has to be configured for 5000 connections/imap-login's? Within 10-master.conf these defaults are shown #default_process_limit = 100 #default_client_limit = 1000 Is it right process_limit is not generally a problem because oldest imap-login process(?) will be closed? (With this expected number of users this value should be increased too.) But what about client_limit? Does it has to be increased to 5000? (There have been some hints by Timo concerning "doveconf -a service" to see how limits will be used for different services.) Any advices? thanks -- Mit freundlichen Gruessen --- Burckhard Schmidt

2 1

[Dovecot] userdb syntax
by suzuki 14 Oct '10

14 Oct '10

Hello, I have a question about userdb lookup when using expire-tool. Dovecot version 1.2.15 In dovecot.conf, mail_location = maildir:/var/mail/%u:INDEX=/var/indexes/%u I run dovecot expire-tool, target user's directory becomes executing user's one. According to wiki, userdb setting overrides mail_location. userdb passwd { mail=maildir:/var/mail/%u:INDEX=/var/indexes/%u } With this setting, it seems working. But, there are no examples with ":INDEX=.." setting. Is this syntax right? Regards

2 1

[Dovecot] Problem with dovecot-acl was not solved
by dss 14 Oct '10

14 Oct '10

Problems with acl in dovecot-1.2.15 was not solved! See my configs below. And I see the new bug - still something wrong with configs: cat dovecot-acl: user=t1 lrwsti #user=oper-olegs lrwsti #user=oper-antona lrwsti user=operdss lr #user=operdss lrwsti User t1 can't create subfolers in inbox. He can only create subfolders in the first levels: Inbox test3 test4 Outbox Sent Trash Test1 - test folder created by t1 user Folders test3 and test4 can't be deleted by t1 - why? Owner of the test3 and test4 - annother user, but but with group rights everething is fine. User operdss also can create folders in the same level with such permissions. What's wrong? imap:/home/t1/Maildir# ls -la total 252 drwxrws--- 35 t1 mshare 4096 2010-10-07 15:59 . drwxr-sr-x 3 root mail 4096 2010-09-22 16:02 .. drwxrws--- 5 t1 mshare 4096 2010-09-15 12:28 .&BB0ENQQ2BDUEOwQwBEIENQQ7BEwEPQQwBE8- &BD8EPgRHBEIEMA- drwxrws--- 2 t1 mshare 4096 2010-10-07 15:41 cur -rw-rw---- 1 t1 mshare 15 2010-10-07 15:59 dovecot-acl -rw-rw---- 1 t1 mshare 383 2010-10-07 15:59 dovecot-acl-list -rw-r----- 1 root mshare 12288 2010-10-07 15:59 .dovecot-acl.swp -rw-rw---- 1 operolegs mshare 1144 2010-09-24 12:16 dovecot.index -rw-rw---- 1 t1 mshare 41984 2010-10-07 11:48 dovecot.index.cache -rw-rw---- 1 t1 mshare 26380 2010-10-07 15:41 dovecot.index.log -rw-rw---- 1 operantona mshare 17 2010-09-23 16:41 dovecot-keywords -rw-rw---- 1 operantona mshare 1941 2010-09-27 10:46 dovecot-uidlist -rw-rw---- 1 t1 mshare 8 2010-10-07 15:45 dovecot-uidvalidity -rw-rw---- 1 t1 mshare 0 2010-09-22 10:54 dovecot-uidvalidity.4c99a838 drwxrws--- 5 t1 mshare 4096 2010-09-23 15:52 .Drafts drwxrws--- 5 t1 mshare 4096 2010-09-22 11:44 .INBOX.1 drwxrws--- 5 t1 mshare 4096 2010-09-28 16:39 .INBOX.processed drwxrws--- 5 operolegs mshare 4096 2010-09-27 17:14 .INBOX.!processed_olegs drwxrws--- 5 t1 mshare 4096 2010-09-23 15:30 .INBOX.test drwxrws--- 5 operdss mshare 4096 2010-09-28 16:39 .INBOX.test1 drwxrws--- 5 operdss mshare 4096 2010-10-05 15:33 .INBOX.test10 drwxrws--- 5 operdss mshare 4096 2010-10-06 16:42 .INBOX.test11 drwxrws--- 5 operdss mshare 4096 2010-10-07 10:35 .INBOX.test12 drwxrws--- 5 operdss mshare 4096 2010-10-07 11:26 .INBOX.test13 drwxrws--- 5 t1 mshare 4096 2010-09-28 16:39 .INBOX.test2 drwxrws--- 5 operdss mshare 4096 2010-09-29 13:52 .INBOX.test3 drwxrws--- 5 operdss mshare 4096 2010-09-29 13:52 .INBOX.test4 drwxrws--- 5 operdss mshare 4096 2010-09-29 15:56 .INBOX.test5 drwxrws--- 5 operdss mshare 4096 2010-09-29 15:57 .INBOX.test6 drwxrws--- 5 operdss mshare 4096 2010-09-29 15:57 .INBOX.test7 drwxrws--- 5 operdss mshare 4096 2010-09-29 16:43 .INBOX.test8 drwxrws--- 5 t1 mshare 4096 2010-10-05 15:30 .INBOX.test9 drwxrws--- 5 t1 mshare 4096 2010-09-28 17:24 .INBOX.tmp drwxrws--- 2 t1 mshare 4096 2010-09-27 10:46 new drwxrws--- 5 t1 mshare 4096 2010-10-07 11:48 .Sent drwxrws--- 5 operdss mshare 4096 2010-09-29 15:55 .Sent.test -rw-rw---- 1 operdss mshare 418 2010-10-07 15:44 subscriptions drwxrws--- 5 t1 mshare 4096 2010-09-15 12:17 .Templates drwxrws--- 5 operdss mshare 4096 2010-10-07 15:42 .test16 drwxrws--- 5 operdss mshare 4096 2010-10-07 15:45 .test17 drwxrws--- 2 t1 mshare 4096 2010-09-27 10:46 tmp drwxrws--- 5 t1 mshare 4096 2010-10-07 15:42 .Trash drwxrws--- 5 t1 mshare 4096 2010-09-23 15:30 .Trash.11 drwxrws--- 5 operantona mshare 4096 2010-09-23 16:39 .Trash.&BD4EMQRABDAEMQQ+BEIEMAQ9BD4-_antona drwxrws--- 5 t1 mshare 4096 2010-10-07 15:42 .Trash.test16 drwxrws--- 5 operdss mshare 4096 2010-09-29 16:01 .Trash.test8 ===================================================================== Old bug in new version 1.2.15: --------------------------------- I have a problem with dovecot-acl. Some of our users need to use the same Mailbox with all folders: Inbox (with subfolders), Outbox, Send and Deleted, (some users need in full righs, some - readonly) so I choosed Symlinking mailboxes and tried to use dovecot-acl file. cat dovecot-acl: user=t1 lrwsti user=operolegs lrwsti user=operantona lrwsti user=operdss lr User operdss have lrwsti rights in this shared mailbox unstead of lr! But if I comment out other users in the dovecot-acl: #user=t1 lrwsti #user=operolegs lrwsti #user=operantona lrwsti user=operdss lr User operdss have lr rights. Whats wrong? It seems, that dovecot-acl is working only for one user and for one line in config. How can I fix it? === Here is my configs. imap:/usr/local/dovecot# /usr/local/dovecot/sbin/dovecot -n # 1.2.15: /etc/dovecot/dovecot.conf # OS: Linux 2.6.26-2-686 i686 Debian 5.0.6 log_path: /var/log/dovecot.log log_timestamp: %Y-%m-%d %H:%M:%S disable_plaintext_auth: no login_dir: /usr/local/dovecot-1.2.15/var/run/dovecot/login login_executable: /usr/local/dovecot-1.2.15/libexec/dovecot/imap-login mail_privileged_group: mail mail_plugins: acl imap_acl auth default: debug: yes passdb: driver: pam userdb: driver: passwd ---- imap:~# ls -l /home/t1/Maildir lrwxrwxrwx 1 root root 21 2010-09-22 16:03 /home/t1/Maildir -> /var/mail/720/Maildir imap:~# ls -l /home/operolegs/Maildir lrwxrwxrwx 1 root root 21 2010-09-23 16:00 /home/operolegs/Maildir -> /var/mail/720/Maildir imap:~# ls -l /home/operantona/Maildir lrwxrwxrwx 1 root root 21 2010-09-23 16:00 /home/operantona/Maildir -> /var/mail/720/Maildir imap:~# ls -l /home/operdss/Maildir lrwxrwxrwx 1 root root 16 2010-09-28 16:32 /home/operdss/Maildir -> /home/t1/Maildir --- imap:/home/t1/Maildir# ls -l total 112 drwxrws--- 2 t1 mshare 4096 2010-09-27 10:46 cur -rw-rw---- 1 t1 mshare 99 2010-09-29 15:56 dovecot-acl -rw-rw---- 1 operdss mshare 312 2010-09-29 16:43 dovecot-acl-list -rw-rw---- 1 operolegs mshare 1144 2010-09-24 12:16 dovecot.index -rw-rw---- 1 t1 mshare 41984 2010-09-28 16:39 dovecot.index.cache -rw-rw---- 1 t1 mshare 25068 2010-09-28 16:38 dovecot.index.log -rw-rw---- 1 operantona mshare 17 2010-09-23 16:41 dovecot-keywords -rw-rw---- 1 operantona mshare 1941 2010-09-27 10:46 dovecot-uidlist -rw-rw---- 1 t1 mshare 8 2010-09-29 16:43 dovecot-uidvalidity -rw-rw---- 1 t1 mshare 0 2010-09-22 10:54 dovecot-uidvalidity.4c99a82f drwxrws--- 2 t1 mshare 4096 2010-09-27 10:46 new -rw-rw---- 1 operdss mshare 327 2010-09-29 16:43 subscriptions drwxrws--- 2 t1 mshare 4096 2010-09-27 10:46 tmp ----- dovecot packages - dovecot-1.2.15 --- Linux: Debian Lenny up2date

2 1

[Dovecot] patch for mysterious maildir symlink error
by Mike Abbott 14 Oct '10

14 Oct '10

This may resolve the mysterious "Maildir: Symlink destination doesn't exist" errors. --- a/src/lib-storage/index/maildir/maildir-util.c +++ b/src/lib-storage/index/maildir/maildir-util.c @@ -91,7 +91,7 @@ { struct stat st; - if (lstat(path, &st) == 0 && (st.st_mode & S_IFLNK) != 0) { + if (lstat(path, &st) == 0 && (st.st_mode & S_IFMT) == S_IFLNK) { /* most likely a symlink pointing to a nonexistent file */ mail_storage_set_critical(&mbox->storage->storage, "Maildir: Symlink destination doesn't exist: %s", path);

2 1

[Dovecot] Panic: Leaked t_pop() call
by Len7hir 14 Oct '10

14 Oct '10

I have version 2.0.0 and upgraded to 2.0.2 and after - this is happend: Raw backtrace: /opt/dovecot2/lib/dovecot/libdovecot.so.0 [0xb7e3425e] -> /opt/dovecot2/lib/dovecot/libdovecot.so.0 [0xb7e342b5] -> /opt/dovecot2/lib/dovecot/libdovecot.so.0 [0xb7e338d6] -> /opt/dovecot2/lib/dovecot/libdovecot.so.0 [0xb7e31cb1] -> dovecot/pop3(client_handle_input+0x8e) [0x804be7e] -> /opt/dovecot2/lib/dovecot/libdovecot.so.0(io_loop_handler_run+0x120) [0xb7e40d30] -> /opt/dovecot2/lib/dovecot/libdovecot.so.0(io_loop_run+0x38) [0xb7e3f6b8] -> /opt/dovecot2/lib/dovecot/libdovecot.so.0(master_service_run+0x2a) [0xb7e2cf5a] -> dovecot/pop3(main+0x226) [0x804af66] -> /lib/tls/libc.so.6(__libc_start_main+0xc8) [0xb7cd0ea8] -> dovecot/pop3 [0x804ab51] Sep 10 13:11:32 pp6 dovecot: master: Error: service(pop3): child 14507 killed with signal 6 (core dumped) This is core dump: #0 0xb7d01947 in raise () from /lib/tls/libc.so.6 #1 0xb7d030c9 in abort () from /lib/tls/libc.so.6 #2 0xb7e5126d in default_fatal_finish (type=<value optimized out>, status=0) at failures.c:164 #3 0xb7e512b5 in i_internal_fatal_handler (type=LOG_TYPE_PANIC, status=0, fmt=0xb7e76391 "Leaked t_pop() call", args=0xbf82ac94 "\n") at failures.c:600 #4 0xb7e508d6 in i_panic (format=0xb7e76391 "Leaked t_pop() call") at failures.c:230 #5 0xb7e4ecb1 in t_pop_check (id=0xbf82acc8) at data-stack.c:267 #6 0x0804be7e in client_handle_input (client=0x8080f38) at pop3-client.c:621 #7 0xb7e5dd30 in io_loop_handler_run (ioloop=0x8058370) at ioloop-epoll.c:212 #8 0xb7e5c6b8 in io_loop_run (ioloop=0x8058370) at ioloop.c:350 #9 0xb7e49f5a in master_service_run (service=0x80582c0, callback=0x804b090 <client_connected>) at master-service.c:496 #10 0x0804af66 in main (argc=0, argv=0x0) at main.c:250 If You want core file I can send, but maybe this is unnecessary. -- Len7hir

2 2

[Dovecot] Dovecot 2.0 lock upgrade assertion failure
by Ryan Murray 14 Oct '10

14 Oct '10

Hi! I've now seen this assertion failure from lmtp (most frequent), pop3 (next frequent), and imap (rarely). It didn't start happening until the number of accounts on the server was increased into the 10k-25k range. It happens when index->file_lock is a read lock and mail_index_lock is called asking for a write lock. Dovecot 2.x dies at the assertion on line 62 of mail-index-lock.c If that assertion were removed, it would likely die at the assertion on line 80. Looking at the mail-index-lock.c from dovecot 1.2.15, it looks like the 1.2 series would enter the else case of the "kind of kludgy" block, and end up calling file_lock_try_update(), which seems like what needs to happen. Dovecot 2.x only does a file_lock_try_update() when unlocking, to demote a write lock to a read lock (according to grep). # 2.0.5 (6ea01abfaea9): /etc/dovecot/dovecot.conf # OS: Linux 2.6.35.6 x86_64 Debian 5.0.6 Oct 9 23:02:59 stor29 dovecot: lmtp(4793, user(a)example.com) Panic: file mail-index-lock.c: line 62 (mail_index_lock): assertion failed: (index->lock_type == F_UNLCK) Oct 9 23:02:59 stor29 dovecot: lmtp(4793, user(a)example.com) Error: Raw backtrace: /usr/lib/dovecot/libdovecot.so.0 [0x7f03e16ff842] -> /usr/lib/dovecot/libdovecot.so.0 [0x7f03e16ff8aa] -> /usr/lib/dovecot/libdovecot.so.0(i_error+0) [0x7f03e16ffc53] -> /usr/lib/dovecot/libdovecot-storage.so.0 [0x7f03e1bce244] -> /usr/lib/dovecot/libdovecot-storage.so.0(mail_index_try_lock_exclusive+0x20) [0x7f03e1bce2d0] -> /usr/lib/dovecot/libdovecot-storage.so.0(mail_index_write+0x31d) [0x7f03e1be287d] -> /usr/lib/dovecot/libdovecot-storage.so.0(mail_index_sync_commit+0x166) [0x7f03e1bda3d6] -> /usr/lib/dovecot/libdovecot-storage.so.0 [0x7f03e1ba1d16] -> /usr/lib/dovecot/libdovecot-storage.so.0(maildir_transaction_save_commit_pre+0x4d2) [0x7f03e1b9d0b2] -> /usr/lib/dovecot/libdovecot-storage.so.0 [0x7f03e1b98213] -> /usr/lib/dovecot/libdovecot-storage.so.0(mail_index_transaction_commit_full+0x97) [0x7f03e1bd2017] -> /usr/lib/dovecot/libdovecot-storage.so.0(index_transaction_commit+0x8b) [0x7f03e1b97e9b] -> /usr/lib/dovecot/modules/lib10_quota_plugin.so [0x7f03e0b44bd1] -> /usr/lib/dovecot/libdovecot-storage.so.0(mailbox_transaction_commit_get_changes+0x3d) [0x7f03e1b7722d] -> /usr/lib/dovecot/libdovecot-lda.so.0(mail_deliver_save+0x176) [0x7f03e1942e96] -> /usr/lib/dovecot/libdovecot-lda.so.0(mail_deliver+0xe3) [0x7f03e1943193] -> dovecot/lmtp [0x40569e] -> /usr/lib/dovecot/libdovecot.so.0(io_loop_handler_run+0xcb) [0x7f03e170a93b] -> /usr/lib/dovecot/libdovecot.so.0(io_loop_run+0x18) [0x7f03e1709a58] -> /usr/lib/dovecot/libdovecot.so.0(master_service_run+0x13) [0x7f03e16f8f93] -> dovecot/lmtp(main+0x159) [0x404419] -> /lib/libc.so.6(__libc_start_main+0xe6) [0x7f03e0f831a6] -> dovecot/lmtp [0x4041f9] Oct 9 23:02:59 stor29 dovecot: master: Error: service(lmtp): child 4793 killed with signal 6 (core not dumped) Here's a backtrace from a different lmtp process that I attached gdb to, since lmtp didn't want to dump core: #0 0x00007fe8054c7ed5 in raise () from /lib/libc.so.6 No symbol table info available. #1 0x00007fe8054c93f3 in abort () from /lib/libc.so.6 No symbol table info available. #2 0x00007fe805c30855 in default_fatal_finish (type=<value optimized out>, status=0) at failures.c:178 backtrace = 0x1a50bd0 "/usr/lib/dovecot/libdovecot.so.0 [0x7fe805c30842] -> /usr/lib/dovecot/libdovecot.so.0 [0x7fe805c308aa] -> /usr/lib/dovecot/libdovecot.so.0(i_error+0) [0x7fe805c30c53] -> /usr/lib/dovecot/libdovecot-st"... #3 0x00007fe805c308aa in i_internal_fatal_handler (type=LOG_TYPE_PANIC, status=0, fmt=<value optimized out>, args=<value optimized out>) at failures.c:607 No locals. #4 0x00007fe805c30c53 in i_panic (format=<value optimized out>) at failures.c:244 args = {{gp_offset = 40, fp_offset = 48, overflow_arg_area = 0x7fff71f8cc40, reg_save_area = 0x7fff71f8cb80}} #5 0x00007fe8060ff244 in mail_index_lock (index=0x1cf0f80, lock_type=1, timeout_secs=<value optimized out>, lock_id_r=0x7fff71f8cdac) at mail-index-lock.c:62 ret = <value optimized out> __FUNCTION__ = "mail_index_lock" #6 0x00007fe8060ff2d0 in mail_index_try_lock_exclusive (index=0x4c10, lock_id_r=<value optimized out>) at mail-index-lock.c:146 ret = <value optimized out> #7 0x00007fe80611387d in mail_index_write (index=0x1cf0f80, want_rotate=false) at mail-index-write.c:226 map = (struct mail_index_map *) 0x1d0baf0 st = {st_dev = 37632, st_ino = 12898927743, st_nlink = 1, st_mode = 33152, st_uid = 2500, st_gid = 2500, pad0 = 0, st_rdev = 0, st_size = 260200, st_blksize = 4096, st_blocks = 512, st_atim = { tv_sec = 1286434371, tv_nsec = 554727597}, st_mtim = {tv_sec = 1286611467, tv_nsec = 18456193}, st_ctim = {tv_sec = 1286611467, tv_nsec = 18456193}, __unused = {0, 0, 0}} lock_id = 0 ret = <value optimized out> __FUNCTION__ = "mail_index_write" #8 0x00007fe80610b3d6 in mail_index_sync_commit (_ctx=0x1cfd908) at mail-index-sync.c:837 ctx = (struct mail_index_sync_ctx *) 0x1cd4590 index = (struct mail_index *) 0x1cf0f80 next_uid = 0 want_rotate = 16 index_undeleted = false delete_index = false ret = 0 #9 0x00007fe8060d2d16 in maildir_sync_index_finish (ctx=0x1cfd8f0, success=<value optimized out>) at maildir-sync-index.c:332 mbox = (struct maildir_mailbox *) 0x1aa2af0 time_diff = <value optimized out> ret = 0 #10 0x00007fe8060ce0b2 in maildir_transaction_save_commit_pre (_ctx=0x1d47a40) at maildir-save.c:984 _t = (struct mailbox_transaction_context *) 0x1d0bd80 sync_flags = <value optimized out> ret = <value optimized out> __FUNCTION__ = "maildir_transaction_save_commit_pre" #11 0x00007fe8060c9213 in index_transaction_index_commit ( index_trans=0x1afbad0, result_r=0x7fff71f8d090) at index-transaction.c:27 it = (struct index_transaction_context *) 0x1d0bd80 ibox = (struct index_mailbox_context *) 0x1aa2eb8 ret = <value optimized out> __FUNCTION__ = "index_transaction_index_commit" #12 0x00007fe806103017 in mail_index_transaction_commit_full ( _t=0x7fff71f8d0b8, result_r=0x7fff71f8d090) at mail-index-transaction.c:234 t = (struct mail_index_transaction *) 0x1afbad0 index = (struct mail_index *) 0x1cf0f80 index_undeleted = false #13 0x00007fe8060c8e9b in index_transaction_commit (t=0x1d0bd80, changes_r=0x7fff71f8d160) at index-transaction.c:123 box = (struct mailbox *) 0x1aa2af0 itrans = (struct mail_index_transaction *) 0x0 result = {log_file_seq = 0, log_file_offset = 0, commit_size = 0, ignored_modseq_changes = 0} ret = <value optimized out> #14 0x00007fe805075bd1 in quota_mailbox_transaction_commit (ctx=0x1d0bd80, changes_r=0x7fff71f8d160) at quota-storage.c:94 qt = (struct quota_transaction_context *) 0x1cfd610 #15 0x00007fe8060a822d in mailbox_transaction_commit_get_changes ( _t=<value optimized out>, changes_r=0x7fff71f8d160) at mail-storage.c:1215 _data_stack_cur_id = 3 t = (struct mailbox_transaction_context *) 0x1d0bd80 ret = <value optimized out> #16 0x00007fe805e73e96 in mail_deliver_save (ctx=0x7fff71f8d250, mailbox=0x407ba1 "INBOX", flags=<value optimized out>, keywords=<value optimized out>, storage_r=0x7fff71f8d2c8) at mail-deliver.c:219 open_ctx = {user = 0x1ce6980, lda_mailbox_autocreate = false, lda_mailbox_autosubscribe = false} box = (struct mailbox *) 0x1aa2af0 trans_flags = <value optimized out> t = (struct mailbox_transaction_context *) 0x0 save_ctx = (struct mail_save_context *) 0x0 kw = (struct mail_keywords *) 0x0 error = MAIL_ERROR_NONE mailbox_name = 0x407ba1 "INBOX" errstr = <value optimized out> changes = {pool = 0x1cd3fb0, uid_validity = 1233133548, saved_uids = { arr = {buffer = 0x1cd3fd0, element_size = 8}, v = 0x1cd3fd0, v_modifiable = 0x1cd3fd0}, ignored_modseq_changes = 0} range = <value optimized out> ret = 0 __FUNCTION__ = "mail_deliver_save" #17 0x00007fe805e74193 in mail_deliver (ctx=0x7fff71f8d250, storage_r=0x7fff71f8d2c8) at mail-deliver.c:289 ret = -1 #18 0x000000000040569e in client_input_data_handle (client=0x1a87520) at commands.c:476 data = <value optimized out> size = 1662 ret = <value optimized out> #19 0x00007fe805c3b93b in io_loop_handler_run (ioloop=<value optimized out>) at ioloop-epoll.c:212 ctx = (struct ioloop_handler_context *) 0x1a5f480 event = (const struct epoll_event *) 0x1a5f4f0 list = (struct io_list *) 0x1a60170 io = (struct io_file *) 0x1b5aab0 tv = {tv_sec = 299, tv_usec = 998518} t_id = 2 msecs = <value optimized out> ret = 1 call = <value optimized out> #20 0x00007fe805c3aa58 in io_loop_run (ioloop=0x1a585b0) at ioloop.c:350 No locals. #21 0x00007fe805c29f93 in master_service_run (service=0x1a58480, callback=0x4c10) at master-service.c:496 22 0x0000000000404419 in main (argc=1, argv=0x1a58370) at main.c:120 set_roots = {0x6098a0, 0x408320, 0x0} service_flags = <value optimized out> storage_service_flags = 675 c = <value optimized out> And here's index and index->file_lock from mail_index_lock: (gdb) p *index $6 = {dir = 0x1b54380 "/w/c/3/d/808008/Maildir", prefix = 0x1d04430 "dovecot.index", cache = 0x1d0b8b0, log = 0x1c6afb0, open_count = 2, flags = MAIL_INDEX_OPEN_FLAG_CREATE, fsync_mode = FSYNC_MODE_OPTIMIZED, fsync_mask = 0, mode = 384, gid = 4294967295, gid_origin = 0x1b5e270 "/w/c/3/d/808008/Maildir", extension_pool = 0x1c32130, extensions = {arr = {buffer = 0x1c32150, element_size = 64}, v = 0x1c32150, v_modifiable = 0x1c32150}, sync_lost_handlers = {arr = {buffer = 0x1c06e60, element_size = 8}, v = 0x1c06e60, v_modifiable = 0x1c06e60}, filepath = 0x1bd71b0 "/w/c/3/d/808008/Maildir/dovecot.index", fd = 14, map = 0x1d0baf0, indexid = 1286433474, inconsistency_id = 0, last_read_log_file_seq = 3, last_read_log_file_head_offset = 32852, last_read_log_file_tail_offset = 32852, last_read_stat = {st_dev = 37632, st_ino = 12898927743, st_nlink = 1, st_mode = 33152, st_uid = 2500, st_gid = 2500, pad0 = 0, st_rdev = 0, st_size = 260200, st_blksize = 4096, st_blocks = 512, st_atim = {tv_sec = 1286434371, tv_nsec = 554727597}, st_mtim = {tv_sec = 1286611467, tv_nsec = 18456193}, st_ctim = { tv_sec = 1286611467, tv_nsec = 18456193}, __unused = {0, 0, 0}}, fsck_log_head_file_seq = 0, fsck_log_head_file_offset = 0, sync_commit_result = 0x0, lock_type = 0, shared_lock_count = 1, excl_lock_count = 0, lock_id_counter = 4, lock_method = FILE_LOCK_METHOD_FCNTL, max_lock_timeout_secs = 4294967295, file_lock = 0x1b5e290, dotlock = 0x0, keywords_pool = 0x1b5dfb0, keywords = { arr = {buffer = 0x1b5e1a0, element_size = 8}, v = 0x1b5e1a0, v_modifiable = 0x1b5e1a0}, keywords_hash = 0x1c6af60, keywords_ext_id = 0, modseq_ext_id = 1, module_contexts = {arr = {buffer = 0x1ac22b0, element_size = 8}, v = 0x1ac22b0, v_modifiable = 0x1ac22b0}, error = 0x0, nodiskspace = 0, index_lock_timeout = 0, index_delete_requested = 0, index_deleted = 0, log_sync_locked = 1, readonly = 0, mapping = 0, syncing = 1, need_recreate = 0, index_min_write = 0, modseqs_enabled = 0, initial_create = 0, initial_mapped = 1} (gdb) p *index->file_lock $7 = {fd = 14, path = 0x1d0bac0 "/w/c/3/d/808008/Maildir/dovecot.index", lock_type = 0, lock_method = FILE_LOCK_METHOD_FCNTL} I can easily reproduce this currently if more information is needed. -- Ryan Murray <rmurray(a)cyberhqz.com>

2 1

[Dovecot] lmtp weird error: Bad address
by Paweł Madej 14 Oct '10

14 Oct '10

>From time to time for one of email addresses i got such error. Have no idea why, as it is valid. Dovecot 2.0.2 Oct 6 17:37:52 postfix/smtpd: connect from unknown[212.xxx.101.5] Oct 6 17:37:52 postfix/smtpd: setting up TLS connection from unknown[212.xxx.101.5] Oct 6 17:37:53 postfix/smtpd: Anonymous TLS connection established from unknown[212.xxx.101.5]: TLSv1 with cipher DHE-RSA-AES256 -SHA (256/256 bits) Oct 6 17:37:53 sqlgrey: grey: from awl match: updating 212.xxx.101(212.xxx.101.5), from@example.com(from@example.com) Oct 6 17:37:59 postfix/policyd-weight: decided action=DUNNO using cached result; rate: -2.3; <client=212.xxx.101.5> <helo=mx1.example.com> <from=from(a)example.com> <to=to(a)example.com>; delay: 6s Oct 6 17:37:59 postfix/smtpd: 9CD23A9C6BD: client=unknown[212.xxx.101.5] Oct 6 17:37:59 postfix/cleanup: 9CD23A9C6BD: message-id=<4cac977f4c58d7.89836790(a)example.com> Oct 6 17:37:59 postfix/qmgr: 9CD23A9C6BD: from=<from(a)example.com>, size=1967, nrcpt=1 (queue active) Oct 6 15:37:59 postfix/smtpd: disconnect from unknown[212.xxx.101.5] Oct 6 17:38:00 postfix/smtpd: connect from localhost.localdomain[127.0.0.1] Oct 6 17:38:00 postfix/smtpd: 39179A9C886: client=localhost.localdomain[127.0.0.1] Oct 6 17:38:00 postfix/cleanup: 39179A9C886: message-id=<4cac977f4c58d7.89836790(a)example.com> Oct 6 17:38:00 postfix/qmgr: 39179A9C886: from=<from(a)example.com>, size=2335, nrcpt=1 (queue active) Oct 6 17:38:00 dovecot: lmtp(12184): Connect from local Oct 6 17:38:00 dovecot: lmtp(12184, to(a)example.com) Error: lstat((null)) failed: Bad address Oct 6 17:38:00 dovecot: lmtp(12184, to(a)example.com) Error: file_dotlock_create((null)) failed: Bad address Oct 6 17:38:00 dovecot: lmtp(12184, to(a)example.com) Error: open((null)) failed: Bad address Oct 6 17:38:00 postfix/smtpd: disconnect from localhost.localdomain[127.0.0.1] Oct 6 17:38:00 postfix/lmtp: 9CD23A9C6BD: to=<to(a)example.com>, relay=my.relay[/var/run/dspam/dspam.sock], delay=7.3, delays=6.8/0/0/0.53, dsn=2.6.0, status=sent (250 2.6.0 <to(a)example.com> Message accepted for delivery) Oct 6 17:38:00 postfix/qmgr: 9CD23A9C6BD: removed Message is delivered properly but i got such errors and have no idea why. I've searched google for this but noone have answer for my problem. Greets -- Paweł Madej

2 2

[Dovecot] pop3 TCP_CORK too late error
by Ryan Murray 14 Oct '10

14 Oct '10

I was straceing a pop3 process and noticed that the TCP_CORK option isn't set soon enough: epoll_wait(8, {{EPOLLOUT, {u32=37481984, u64=37481984}}}, 38, 207) = 1 write(41, "iTxPBrNlaNFao+yQzLhuO4/+tQ5cuiKSe"..., 224) = 224 epoll_ctl(8, EPOLL_CTL_MOD, 41, {EPOLLIN|EPOLLPRI|EPOLLERR|EPOLLHUP, {u32=37481984, u64=37481984}}) = 0 pread(19, "AFABQAlAC0AJ\nQAUALQAUAFABQAlAC0AF"..., 8192, 811008) = 8192 setsockopt(41, SOL_TCP, TCP_CORK, [1], 4) = 0 write(41, "\r\nKUWtGCjKO5N8UbW5uYLZbS0nmaNi4ZB"..., 4134) = 4134 write(41, "\r\npckt0KMGuho6r4H1ay0sXbx+YyuC0Sn"..., 4134) = 4134 pread(19, "kivLO4WgAoAKACgBKAFoAr3V0lpH5kuQg"..., 8192, 819200) = 8192 write(41, "\r\nJkm1ZFXSIr1Ig19KGYj7oHT61dWUG/d"..., 4134) = 4134 write(41, "\r\nSNUHRRipGU9bu2sdLubhPvxoSv1qoK7"..., 4134) = 4134 pread(19, "NcOu1l/u1rGGl2YVKnQb8M9X09dKg\n0v7"..., 8192, 827392) = 8192 write(41, "\r\nAAp/Uo/zfgP29S9rB/wnRTcXsvu8YEg"..., 4134) = 4134 write(41, "\r\nYHT5jx+tJ1Z9x8iF/wCEb0ny/LNmmM5"..., 4134) = 4134 pread(19, "4GhGM3jkA/3B09Kr66+wewj0BfA8f8d8/"..., 8192, 835584) = 8192 write(41, "\r\nxHf8JPpm/b54/I/4UfVKhX1h3tYT/hJ"..., 4134) = 3932 write(41, "tdGIPCOsquY5oRkcoSev1p/Xl2D6s0tGN"..., 202) = -1 EAGAIN (Resource temporarily unavailable) epoll_ctl(8, EPOLL_CTL_MOD, 41, {EPOLLIN|EPOLLPRI|EPOLLOUT|EPOLLERR| EPOLLHUP, {u32=37481984, u64=37481984}}) = 0 setsockopt(41, SOL_TCP, TCP_CORK, [0], 4) = 0 The TCP_CORK option should get set before the first call to write() there, rather than after the first pread(). -- Ryan Murray <rmurray(a)cyberhqz.com>

3 3

[Dovecot] managesieve fileinto folder with international characters
by Edward Carraro 14 Oct '10

14 Oct '10

I have a folder created in dovecot entered by the user as "ññoéé" On the file system it appears as "&APEA8Q-o&AOkA6Q-" (mUTF7) When creating a sieve rule, to file into the folder ññoéé, I am converting the name from UTF8 into UTF7, the rule becomes require ["fileinto"]; if header :contains ["From"] "user(a)domain.com" { fileinto "&APEA8Q-o&AOkA6Q-"; } however when executed, a sieve log is generated saying: failed to store into mailbox '&APEA8Q-o&AOkA6Q-' (&-APEA8Q-o&-AOkA6Q-): Mailbox doesn't exist: &-APEA8Q-o&-AOkA6Q-. If I directly modify the sieve file and place the actual utf8 version of the folder in it require ["fileinto"]; if header :contains ["From"] "user(a)domain.com" { fileinto "ññoéé"; } I get the following error: main_script: line 1: error: folder name specified for fileinto command is not utf-8: ññoéé.

4 5