- dovecot - dovecot.org

[Dovecot] Disconnected: BUG internal error
by Ainsley Pereira 15 May '08

15 May '08

Hello, I'm seeing some messages from dovecot in my logs such as: May 8 11:43:41 snowdrift dovecot: IMAP(username): Disconnected: BUG: Unknown internal error I did some searching, and discovered a similar report last month, to which there was a request for more information that didn't seem to get followed up, so I have collected this information too. Dovecot version: 1.0.10 (from Ubuntu hardy package, which includes some patches; details of the patches can be found here: http://svn.debian.org/wsvn/collab-maint/deb-maint/dovecot/trunk/debian/patc… ) OS: Ubuntu 8.04 (Hardy) CPU: x86 Filesystem: ext3 IMAP client: Thunderbird. What was happening with it is not too clear, unfortunately it only seems to occur for one user, and that's not me. Reproducability: Seems to occur fairly frequently, but unable to provide steps. dovecot -n output: # 1.0.10: /etc/dovecot/dovecot.conf log_timestamp: %Y-%m-%d %H:%M:%S protocols: imaps pop3s ssl_cert_file: /etc/ssl/certs/snowdrift-cert.pem ssl_key_file: /etc/ssl/private/snowdrift-key.pem ssl_cipher_list: ALL:!LOW:!SSLv2 login_dir: /var/run/dovecot/login login_executable(default): /usr/lib/dovecot/imap-login login_executable(imap): /usr/lib/dovecot/imap-login login_executable(pop3): /usr/lib/dovecot/pop3-login mail_location: mbox:~/mail:INBOX=/var/mail/%u mail_debug: yes mail_executable(default): /usr/lib/dovecot/rawlog /usr/lib/dovecot/imap mail_executable(imap): /usr/lib/dovecot/rawlog /usr/lib/dovecot/imap mail_executable(pop3): /usr/lib/dovecot/pop3 mail_plugin_dir(default): /usr/lib/dovecot/modules/imap mail_plugin_dir(imap): /usr/lib/dovecot/modules/imap mail_plugin_dir(pop3): /usr/lib/dovecot/modules/pop3 pop3_uidl_format(default): pop3_uidl_format(imap): pop3_uidl_format(pop3): %08Xu%08Xv auth default: passdb: driver: pam userdb: driver: passwd Raw log output: 29 OK Fetch completed. * 632 FETCH (UID 14265 RFC822.SIZE 4373) * BYE BUG: Unknown internal error Immediately before that was a set of headers from an email, so I guess that's what the "29" line's talking about, and it's just the last two that are relevant. Please let me know if there's anything further I can provide to help track this down. Thanks, Ainsley

2 1

[Dovecot] unix style mbox and vmain maildir on the same server
by Glen Lee Edwards 15 May '08

15 May '08

Hi, I'm new to dovecott. Using version 1.0.rc15. I have a mail server that has both the old style unix mbox in /var/mail/%u, and virtual mail maildir in /var/vmail/%d/%n. Debian Linux Etch stable. I'm trying to get dovecot to deliver to /var/mail/%u using mbox format, and to deliver to /var/vmail/%d/%n using maildir format. I can't get it do work. I can get it to access both directories, but not use the two formats. This is what I tried last: namespace private { separator = / inbox = yes hidden = yes prefix = location = mbox:~/mail:INBOX=/var/mail/%u } namespace private { separator = / inbox = no hidden = yes prefix = mail/ location = maildir:/var/vmail/%d/%n } I have since commented out the above two namespaces and set mail_location to mail_location = maildir:/var/vmail/%d/%n. $ dovecot -n # /etc/dovecot/dovecot.conf log_timestamp: %Y-%m-%d %H:%M:%S protocols: imap imaps pop3 pop3s disable_plaintext_auth: no login_dir: /var/run/dovecot/login login_executable(default): /usr/lib/dovecot/imap-login login_executable(imap): /usr/lib/dovecot/imap-login login_executable(pop3): /usr/lib/dovecot/pop3-login mail_privileged_group: mail mail_location: maildir:/var/vmail/%d/%n mail_executable(default): /usr/lib/dovecot/imap mail_executable(imap): /usr/lib/dovecot/imap mail_executable(pop3): /usr/lib/dovecot/pop3 mail_plugin_dir(default): /usr/lib/dovecot/modules/imap mail_plugin_dir(imap): /usr/lib/dovecot/modules/imap mail_plugin_dir(pop3): /usr/lib/dovecot/modules/pop3 pop3_uidl_format(default): pop3_uidl_format(imap): pop3_uidl_format(pop3): %08Xu%08Xv auth default: mechanisms: plain login passdb: driver: pam args: dovecot passdb: driver: passwd args: blocking=yes passdb: driver: sql args: /etc/dovecot/dovecot-sql.conf userdb: driver: passwd userdb: driver: static args: uid=2000 gid=2000 home=/var/vmail/%d/%n allow_all_users=yes socket: type: listen client: path: /var/spool/postfix/private/auth mode: 432 user: postfix group: postfix master: path: /var/run/dovecot/auth-master mode: 384 user: vmail Glen

3 5

[Dovecot] Dovecot immediate logout (imap4)
by Дмитрий Бригадиров 15 May '08

15 May '08

I've experienced with automatic client logout (probably after IDLE command sent by a client). I simply run any imap4 client and get this in mail.log: May 14 18:26:37 athlon dovecot: imap-login: Login: user=<neptunix(a)tehexergo.ru>, method=PLAIN, rip=192.168.0.3, lip=192.168.0.3, secured May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Loading modules from directory: /usr/lib/dovecot/modules/imap May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Module loaded: /usr/lib/dovecot/modules/imap/lib10_quota_plugin.so May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Module loaded: /usr/lib/dovecot/modules/imap/lib11_imap_quota_plugin.so May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Effective uid=112, gid=118, home=/var/spool/mail/tehexergo.ru/neptunix May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): maildir: data=/var/spool/mail/tehexergo.ru/neptunix/Maildir:INDEX=/var/spool/mail/tehexergo.ru/neptunix May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): maildir: root=/var/spool/mail/tehexergo.ru/neptunix/Maildir, index=/var/spool/mail/tehexergo.ru/neptunix, control=, inbox= May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Disconnected: Logged out May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Loading modules from directory: /usr/lib/dovecot/modules/imap May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Module loaded: /usr/lib/dovecot/modules/imap/lib10_quota_plugin.so May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Module loaded: /usr/lib/dovecot/modules/imap/lib11_imap_quota_plugin.so May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Effective uid=112, gid=118, home=/var/spool/mail/tehexergo.ru/neptunix May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): maildir: data=/var/spool/mail/tehexergo.ru/neptunix/Maildir:INDEX=/var/spool/mail/tehexergo.ru/neptunix May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): maildir: root=/var/spool/mail/tehexergo.ru/neptunix/Maildir, index=/var/spool/mail/tehexergo.ru/neptunix, control=, inbox= May 14 18:26:37 athlon dovecot: imap-login: Login: user=<neptunix(a)tehexergo.ru>, method=PLAIN, rip=192.168.0.3, lip=192.168.0.3, secured May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Disconnected: Logged out May 14 18:26:37 athlon dovecot: imap-login: Login: user=<neptunix(a)tehexergo.ru>, method=PLAIN, rip=192.168.0.3, lip=192.168.0.3, secured May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Loading modules from directory: /usr/lib/dovecot/modules/imap May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Module loaded: /usr/lib/dovecot/modules/imap/lib10_quota_plugin.so May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Module loaded: /usr/lib/dovecot/modules/imap/lib11_imap_quota_plugin.so May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Effective uid=112, gid=118, home=/var/spool/mail/tehexergo.ru/neptunix May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): maildir: data=/var/spool/mail/tehexergo.ru/neptunix/Maildir:INDEX=/var/spool/mail/tehexergo.ru/neptunix May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): maildir: root=/var/spool/mail/tehexergo.ru/neptunix/Maildir, index=/var/spool/mail/tehexergo.ru/neptunix, control=, inbox= May 14 18:26:37 athlon dovecot: IMAP(neptunix(a)tehexergo.ru): Disconnected: Logged out 3 login attempts each after another. Any way client shows me the inbox and I can manage mail just fine. However it disconnects every time instead of using idle command (this I my guess). Don't know the reason for such a strange situation. Thanks for any help in advance. By the way I can't get rawlog to work. It doesn't write any logs to home directory. dovecot 10.0.10 (from ubuntu hardy repository) dovecot -n # 1.0.10: /etc/dovecot/dovecot.conf log_timestamp: %Y-%m-%d %H:%M:%S ssl_cert_file: /etc/ssl/private/exim.pem ssl_key_file: /etc/ssl/private/exim.pem verbose_ssl: yes login_dir: /var/run/dovecot/login login_executable: /usr/lib/dovecot/imap-login login_greeting: Dovecot MUA ready. login_max_processes_count: 32 login_max_connections: 64 max_mail_processes: 256 verbose_proctitle: yes first_valid_uid: 100 mail_privileged_group: mail mail_location: maildir:/var/spool/mail/%d/%n/Maildir:INDEX=/var/spool/mail/%d/%n mail_debug: yes mail_executable: /usr/lib/dovecot/rawlog /usr/lib/dovecot/imap mail_plugins: quota imap_quota auth default: passdb: driver: ldap args: /etc/dovecot/dovecot-ldap.conf userdb: driver: ldap args: /etc/dovecot/dovecot-ldap.conf socket: type: listen master: path: /var/run/dovecot/auth-master mode: 384 user: mail plugin: quota: maildir -- Dmitry Brigadirov

3 4

[Dovecot] missing slash when concatenating strings from userdb static?
by Elod 15 May '08

15 May '08

Dovecot version: 1.0.13 Linux: Debian Testing (kernel 2.6.22) Fs: local # 1.0.13: /etc/dovecot/dovecot.conf log_timestamp: %Y-%m-%d %H:%M:%S protocols: imap pop3 disable_plaintext_auth: no login_dir: /var/run/dovecot/login login_executable(default): /usr/lib/dovecot/imap-login login_executable(imap): /usr/lib/dovecot/imap-login login_executable(pop3): /usr/lib/dovecot/pop3-login valid_chroot_dirs: /home/email mail_chroot: /home/email first_valid_uid: 109 last_valid_uid: 109 first_valid_gid: 65534 last_valid_gid: 65534 mail_access_groups: nogroup mail_privileged_group: mail mail_location: maildir:~/Maildir maildir_copy_with_hardlinks: yes mail_executable(default): /usr/lib/dovecot/imap mail_executable(imap): /usr/lib/dovecot/imap mail_executable(pop3): /usr/lib/dovecot/pop3 mail_plugin_dir(default): /usr/lib/dovecot/modules/imap mail_plugin_dir(imap): /usr/lib/dovecot/modules/imap mail_plugin_dir(pop3): /usr/lib/dovecot/modules/pop3 pop3_uidl_format(default): pop3_uidl_format(imap): pop3_uidl_format(pop3): %08Xu%08Xv auth default: passdb: driver: passwd-file args: /home/email/%d/passwd userdb: driver: static args: uid=email gid=nogroup home=/%d/%n It finds mails with "/%d/%n" but not with "%d/%n". At another site I have the same version, but with an SQL backend. That one works beautifully with relative (to chroot dir) paths. -- Valkai Elõd

2 1

[Dovecot] need help
by Gabriele Fergola 14 May '08

14 May '08

I tried to migrate from a server courier to dovecot with imapsync but i get this errore: Couldn't append msg #15 (Subject:[Registrazione]) to folder INBOX: Error sending command '16 APPEND INBOX (\Answered \Seen) "" {3478} ': 16 BAD Invalid internal date. thk you in advance Workino

2 2

[Dovecot] Problem with virtual mail user login users uid not permitted
by Neil Muller 14 May '08

14 May '08

Hello, I am trying to run exim 4.68 and dovecot 1.0.13 on Solaris 10 x86 5/08 using dovecot lda and sieve with virtual users and domains, tls and ssl. At the moment certificates are from my internal CA Exim and Dovecot, dovecot lda and dovecot sieve were downloaded and installed from Blastwave. Mail delivery (ie from Exim to dovecot via dovecot lda) is working correctly but when I try to access mail using imap from a client (eg. Thunderbird) the login fails. My mail user for accessing virtual user mail is vmail (uid=954, gid=954). I have attached the messages from dovecot.log and the output of dovecot -n below as well as contents from the passdb file. Can anyone point me to where I've gone wrong, I've had this working fine on Linux but Solaris just doesn't seem to want to play :-) Thanks, Neil -- E neil(a)neologix.net My passdb file contents: lothar# cat /opt/csw/etc/vmail/comms.neologix/passwd neil:{MD5-CRYPT}$1$Lik.5MFj$PJKYoXEfADgTiK1PI6aa01:954:954::/export/ home/vmail/comms.neologix/users/ neil::userdb_quota=maildir:storage=10240 mail_plugins=cmusieve,quota,imap_quota sieve=.dovecot.sieve Contents of dovecot.log: dovecot: May 12 15:13:45 Info: auth(default): passwd-file /opt/csw/etc/ vmail/comms.neologix/passwd: Read 2 users dovecot: May 12 15:13:45 Info: auth(default): passwd-file(neil(a)comms.neologix ,192.168.1.100): lookup: user=neil file=/opt/csw/etc/vmail/ comms.neologix/passwd dovecot: May 12 15:13:45 Info: auth(default): client out: OK 1 user=neil(a)comms.neologix mail_plugins=cmusieve,quota,imap_quota sieve=.dovecot.sieve dovecot: May 12 15:13:45 Error: user neil(a)comms.neologix: Logins with login_user's UID 954 not permitted (see http://wiki.dovecot.org/ UserIds). dovecot: May 12 15:13:45 Info: auth(default): master in: REQUEST 1 16850 1 dovecot: May 12 15:13:45 Info: auth(default): passwd(neil(a)comms.neologix,192.168.1.100): lookup dovecot: May 12 15:13:45 Info: auth(default): passwd(neil(a)comms.neologix,192.168.1.100): unknown user dovecot: May 12 15:13:45 Info: auth(default): passwd-file(neil(a)comms.neologix ,192.168.1.100): lookup: user=neil file=/opt/csw/etc/vmail/ comms.neologix/passwd dovecot: May 12 15:13:45 Info: auth(default): master out: USER 1 neil(a)comms.neologix uid=954 gid=954 home=/export/home/ vmail/comms.neologix/users/neil quota=maildir:storage=10240 dovecot: May 12 15:13:45 Info: imap-login: Internal login failure: user=<neil(a)comms.neologix>, method=PLAIN, rip=192.168.1.100, lip=192.168.1.229, TLS The output from dovecot -n is: lothar# dovecot -n # 1.0.13: /opt/csw/etc/dovecot.conf base_dir: /opt/csw/var/run/dovecot/ log_path: /opt/csw/var/log/dovecot.log ssl_cert_file: /opt/csw/ssl/certs/dovecot-cert.pem ssl_key_file: /opt/csw/ssl/private/dovecot-key-np.pem verbose_ssl: yes login_dir: /opt/csw/var/run/dovecot//login login_executable: /opt/csw/libexec/dovecot/imap-login login_user: vmail first_valid_uid: 900 last_valid_uid: 1900 first_valid_gid: 900 last_valid_gid: 1900 mail_location: maildir:%h/Maildir mail_debug: yes auth default: username_format: %Lu verbose: yes debug: yes debug_passwords: yes passdb: driver: passwd-file args: /opt/csw/etc/vmail/%d/passwd userdb: driver: passwd userdb: driver: passwd-file args: /opt/csw/etc/vmail/%d/passwd socket: type: listen client: path: /opt/csw/var/run/dovecot/auth-client mode: 432 master: path: /opt/csw/var/run/dovecot/auth-master mode: 384 user: vmail group: vmail plugin: sieve: %h/.dovecot.sieve quota: maildir

2 2

[Dovecot] Time moved backwards
by Eugene 13 May '08

13 May '08

Hello, I would like to suggest a change in handling of 'Time moved backwards' problem. Right now dovecot just dies. So, the scenario: 1) Colocation server is shut down for some reason. The internal time drifts. 2) Server is started again. 3) Dovecot starts successfully. 4) In about a minute, NTP daemon feels confident about adjusting the system time. 5) Dovecot sees the changed time and dies. 6) Admin has to notice that, login and restart Dovecot manually. I suggest that Dovecot simply terminate the current connections (causing the client to reconnect) or -- if the time change is really that much of a problem -- to restart itself automatically. Maybe a config option could be introduced. Best wishes Eugene

10 20

[Dovecot] Unknown internal error
by Martin Preen 13 May '08

13 May '08

Hello, I just found this message in our dovecot logfiles: "Disconnected: BUG: Unknown internal error" Should I worry about this ? There are no complaints yet (although it is not limited to one user). It seems to occur with different clients (Apple/MacOS mail, Windows/Thunderbird, Pine). We're running dovecot 1.0.10 on Solaris 10 with mboxes (NFS) and local index storage. There are no such messages before the upgrade (from version 1.0.5). Regards. Martin --------------------------------------------------------------- Martin Preen, Universität Freiburg, Institut für Informatik Georges-Koehler-Allee 52, Raum 00-006, 79110 Freiburg, Germany phone: ++49 761 203-8250 preen(a)informatik.uni-freiburg.de fax: ++49 761 203-8242 www.informatik.uni-freiburg.de

2 3

[Dovecot] Mailbox problem
by Sadiq Walji 13 May '08

13 May '08

Greetings, I am using dovecot as our POP3 and IMAP server and Squirrelmail for the Webmail. Some of our users get the error message below when trying to access the mailbox using Webmail: "ERROR: Could not complete request. Query: SELECT "INBOX" Reason Given: Internal error occurred. Error report written to server log. [2008-05-12 09:08:39] To resolve this issue, I need to open the /var/spool/mail/<username> (mailbox of the user) and delete an empty line that is inserted at the top of the mailbox file. I am running dovecot-0.99.11-8.EL4 on CentOS release 4.6 (Final). Kindly provide suggestions on how to resolve this issue. Thank you, Sadiq

2 2

[Dovecot] how add size (, S=size) and virtual size (, W=vsize) fields to a maildir filename ?
by Marco Giunta 13 May '08

13 May '08

Hi to all, I'm a sys admin in a college, and we're using Dovecot as IMAP/POP3 server and delivery; we're also patch dovecot to add managesieve capability. I've a question: I've read on dovecot's wiki, that is possible improve the performance on maildir files by adding ,S=<size>,W=<vsize> fields on filename. How is possible to do that ? I've search on all the wiki and on the mailing list, but I didn't find nothing about modify the maildir file name. Someone can help me ? Best regards, Marco

2 2