Scenario: Sogo/Mysql+Postfix+Dovecot(only IMAP)+LDAP (Active Directory)
1) LOGIN TO WEBGUI = 11 sec
(time, from submitting account, to viewing webmail, with INBOX filled with all
mails)
Mar 08 23:06:21 auth: Debug: Loading modules from directory:
/usr/lib64/dovecot/auth
Mar 08 23:06:21 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libauthdb_ldap.so
Mar 08 23:06:21 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libdriver_sqlite.so
Mar 08 23:06:21 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libmech_gssapi.so
Mar 08 23:06:21 auth: Debug: auth client connected (pid=7447)
Mar 08 23:06:21 auth: Debug: client in: AUTH 1 PLAIN service=imap
secured lip=127.0.0.1 rip=127.0.0.1 lport=143 rport=37483
resp=<hidden>
Mar 08 23:06:21 auth: Debug: Loading modules from directory:
/usr/lib64/dovecot/auth
Mar 08 23:06:21 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libauthdb_ldap.so
Mar 08 23:06:21 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libdriver_sqlite.so
Mar 08 23:06:21 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libmech_gssapi.so
Mar 08 23:06:21 auth: Debug: pam(utente1,127.0.0.1): lookup service=dovecot
Mar 08 23:06:21 auth: Debug: pam(utente1,127.0.0.1): #1/1 style=1 msg=Password:
Mar 08 23:06:24 auth: Debug: client out: OK 1 user=utente1
Mar 08 23:06:24 auth: Debug: master in: REQUEST 1055260673 7447 1
2d1cceba170f9b2d57dbd27a9107d30a
Mar 08 23:06:24 auth: Debug: master out: USER 1055260673 utente1 uid=500
gid=500 home=/var/vmail/utente1
Mar 08 23:06:24 imap-login: Info: Login: user=<utente1>, method=PLAIN,
rip=127.0.0.1, lip=127.0.0.1, mpid=7451, secured
Mar 08 23:06:24 imap(utente1): Debug: Effective uid=500, gid=500,
home=/var/vmail/utente1
Mar 08 23:06:24 imap(utente1): Debug: maildir++:
root=/var/vmail/utente1/maildir, index=, control=,
inbox=/var/vmail/utente1/maildir
Mar 08 23:06:24 imap(utente1): Info: Disconnected: Logged out bytes=212/1582
Mar 08 23:06:27 auth: Debug: auth client connected (pid=7453)
Mar 08 23:06:27 auth: Debug: client in: AUTH 1 PLAIN service=imap
secured lip=127.0.0.1 rip=127.0.0.1 lport=143 rport=37492
resp=<hidden>
Mar 08 23:06:27 auth: Debug: pam(utente1,127.0.0.1): lookup service=dovecot
Mar 08 23:06:27 auth: Debug: pam(utente1,127.0.0.1): #1/1 style=1 msg=Password:
Mar 08 23:06:30 auth: Debug: client out: OK 1 user=utente1
Mar 08 23:06:30 auth: Debug: master in: REQUEST 4084072449 7453 1
7ae1f281f1cb91b62fbceab75ca18f00
Mar 08 23:06:30 auth: Debug: master out: USER 4084072449 utente1 uid=500
gid=500 home=/var/vmail/utente1
Mar 08 23:06:30 imap-login: Info: Login: user=<utente1>, method=PLAIN,
rip=127.0.0.1, lip=127.0.0.1, mpid=7454, secured
Mar 08 23:06:30 imap(utente1): Debug: Effective uid=500, gid=500,
home=/var/vmail/utente1
Mar 08 23:06:30 imap(utente1): Debug: maildir++:
root=/var/vmail/utente1/maildir, index=, control=,
inbox=/var/vmail/utente1/maildir
Mar 08 23:06:31 imap(utente1): Info: Disconnected: Logged out bytes=64/829
Mar 08 23:06:31 auth: Debug: auth client connected (pid=7455)
Mar 08 23:06:31 auth: Debug: client in: AUTH 1 PLAIN service=imap
secured lip=127.0.0.1 rip=127.0.0.1 lport=143 rport=37497
resp=<hidden>
Mar 08 23:06:31 auth: Debug: pam(utente1,127.0.0.1): lookup service=dovecot
Mar 08 23:06:31 auth: Debug: pam(utente1,127.0.0.1): #1/1 style=1 msg=Password:
Mar 08 23:06:33 auth: Debug: client out: OK 1 user=utente1
Mar 08 23:06:33 auth: Debug: master in: REQUEST 914620417 7455 1
7e051c44092b4e4139563a975df2b14b
Mar 08 23:06:33 auth: Debug: master out: USER 914620417 utente1 uid=500
gid=500 home=/var/vmail/utente1
Mar 08 23:06:33 imap-login: Info: Login: user=<utente1>, method=PLAIN,
rip=127.0.0.1, lip=127.0.0.1, mpid=7456, secured
Mar 08 23:06:33 imap(utente1): Debug: Effective uid=500, gid=500,
home=/var/vmail/utente1
Mar 08 23:06:33 imap(utente1): Debug: maildir++:
root=/var/vmail/utente1/maildir, index=, control=,
inbox=/var/vmail/utente1/maildir
Mar 08 23:06:33 imap(utente1): Info: Disconnected: Logged out bytes=104/1091
note three imap-login
2) OPEN WRITE-EMAIL POPUP = 7 sec
Mar 08 23:12:46 auth: Debug: Loading modules from directory:
/usr/lib64/dovecot/auth
Mar 08 23:12:46 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libauthdb_ldap.so
Mar 08 23:12:46 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libdriver_sqlite.so
Mar 08 23:12:46 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libmech_gssapi.so
Mar 08 23:12:46 auth: Debug: auth client connected (pid=7471)
Mar 08 23:12:46 auth: Debug: client in: AUTH 1 PLAIN service=imap
secured lip=127.0.0.1 rip=127.0.0.1 lport=143 rport=37504
resp=<hidden>
Mar 08 23:12:46 auth: Debug: Loading modules from directory:
/usr/lib64/dovecot/auth
Mar 08 23:12:46 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libauthdb_ldap.so
Mar 08 23:12:46 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libdriver_sqlite.so
Mar 08 23:12:46 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libmech_gssapi.so
Mar 08 23:12:46 auth: Debug: pam(utente1,127.0.0.1): lookup service=dovecot
Mar 08 23:12:46 auth: Debug: pam(utente1,127.0.0.1): #1/1 style=1 msg=Password:
Mar 08 23:12:49 auth: Debug: client out: OK 1 user=utente1
Mar 08 23:12:49 auth: Debug: master in: REQUEST 1795162113 7471 1
1f4d8e4390669d3bfe27296ef03f663e
Mar 08 23:12:49 auth: Debug: master out: USER 1795162113 utente1 uid=500
gid=500 home=/var/vmail/utente1
Mar 08 23:12:49 imap-login: Info: Login: user=<utente1>, method=PLAIN,
rip=127.0.0.1, lip=127.0.0.1, mpid=7475, secured
Mar 08 23:12:49 imap(utente1): Debug: Effective uid=500, gid=500,
home=/var/vmail/utente1
Mar 08 23:12:49 imap(utente1): Debug: maildir++:
root=/var/vmail/utente1/maildir, index=, control=,
inbox=/var/vmail/utente1/maildir
Mar 08 23:12:49 imap(utente1): Info: Disconnected: Logged out bytes=49/734
Mar 08 23:12:49 auth: Debug: auth client connected (pid=7476)
Mar 08 23:12:49 auth: Debug: client in: AUTH 1 PLAIN service=imap
secured lip=127.0.0.1 rip=127.0.0.1 lport=143 rport=37509
resp=<hidden>
Mar 08 23:12:49 auth: Debug: pam(utente1,127.0.0.1): lookup service=dovecot
Mar 08 23:12:49 auth: Debug: pam(utente1,127.0.0.1): #1/1 style=1 msg=Password:
Mar 08 23:12:52 auth: Debug: client out: OK 1 user=utente1
Mar 08 23:12:52 auth: Debug: master in: REQUEST 1808531457 7476 1
cefcdd9fa37b49d400786e5f5a80e4c9
Mar 08 23:12:52 auth: Debug: master out: USER 1808531457 utente1 uid=500
gid=500 home=/var/vmail/utente1
Mar 08 23:12:52 imap-login: Info: Login: user=<utente1>, method=PLAIN,
rip=127.0.0.1, lip=127.0.0.1, mpid=7477, secured
Mar 08 23:12:52 imap(utente1): Debug: Effective uid=500, gid=500,
home=/var/vmail/utente1
Mar 08 23:12:52 imap(utente1): Debug: maildir++:
root=/var/vmail/utente1/maildir, index=, control=,
inbox=/var/vmail/utente1/maildir
Mar 08 23:12:53 imap(utente1): Info: Disconnected: Logged out bytes=49/734
note here two imap-login
3) CLOSE WRITE-EMAIL POPUP = 7 sec
Mar 08 23:14:10 auth: Debug: Loading modules from directory:
/usr/lib64/dovecot/auth
Mar 08 23:14:10 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libauthdb_ldap.so
Mar 08 23:14:10 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libdriver_sqlite.so
Mar 08 23:14:10 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libmech_gssapi.so
Mar 08 23:14:10 auth: Debug: auth client connected (pid=7480)
Mar 08 23:14:10 auth: Debug: client in: AUTH 1 PLAIN service=imap
secured lip=127.0.0.1 rip=127.0.0.1 lport=143 rport=37513
resp=<hidden>
Mar 08 23:14:10 auth: Debug: Loading modules from directory:
/usr/lib64/dovecot/auth
Mar 08 23:14:10 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libauthdb_ldap.so
Mar 08 23:14:10 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libdriver_sqlite.so
Mar 08 23:14:10 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libmech_gssapi.so
Mar 08 23:14:10 auth: Debug: pam(utente1,127.0.0.1): lookup service=dovecot
Mar 08 23:14:10 auth: Debug: pam(utente1,127.0.0.1): #1/1 style=1 msg=Password:
Mar 08 23:14:17 auth: Debug: client out: OK 1 user=utente1
Mar 08 23:14:17 auth: Debug: master in: REQUEST 1298399233 7480 1
edb8838e85110b528ab3da9cd647c52f
Mar 08 23:14:17 auth: Debug: master out: USER 1298399233 utente1 uid=500
gid=500 home=/var/vmail/utente1
Mar 08 23:14:17 imap-login: Info: Login: user=<utente1>, method=PLAIN,
rip=127.0.0.1, lip=127.0.0.1, mpid=7484, secured
Mar 08 23:14:17 imap(utente1): Debug: Effective uid=500, gid=500,
home=/var/vmail/utente1
Mar 08 23:14:17 imap(utente1): Debug: maildir++:
root=/var/vmail/utente1/maildir, index=, control=,
inbox=/var/vmail/utente1/maildir
Mar 08 23:14:17 imap(utente1): Info: Disconnected: Logged out bytes=49/734
4) RE-OPEN WRITE-EMAIL POPUP = 9 sec
Mar 08 23:15:38 auth: Debug: Loading modules from directory:
/usr/lib64/dovecot/auth
Mar 08 23:15:38 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libauthdb_ldap.so
Mar 08 23:15:38 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libdriver_sqlite.so
Mar 08 23:15:38 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libmech_gssapi.so
Mar 08 23:15:38 auth: Debug: auth client connected (pid=7487)
Mar 08 23:15:38 auth: Debug: client in: AUTH 1 PLAIN service=imap
secured lip=127.0.0.1 rip=127.0.0.1 lport=143 rport=37517
resp=<hidden>
Mar 08 23:15:38 auth: Debug: Loading modules from directory:
/usr/lib64/dovecot/auth
Mar 08 23:15:38 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libauthdb_ldap.so
Mar 08 23:15:38 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libdriver_sqlite.so
Mar 08 23:15:38 auth: Debug: Module loaded:
/usr/lib64/dovecot/auth/libmech_gssapi.so
Mar 08 23:15:38 auth: Debug: pam(utente1,127.0.0.1): lookup service=dovecot
Mar 08 23:15:38 auth: Debug: pam(utente1,127.0.0.1): #1/1 style=1 msg=Password:
Mar 08 23:15:46 auth: Debug: client out: OK 1 user=utente1
Mar 08 23:15:46 auth: Debug: master in: REQUEST 483786753 7487 1
056713ad7466f8aee167545b318b05e3
Mar 08 23:15:46 auth: Debug: master out: USER 483786753 utente1 uid=500
gid=500 home=/var/vmail/utente1
Mar 08 23:15:46 imap-login: Info: Login: user=<utente1>, method=PLAIN,
rip=127.0.0.1, lip=127.0.0.1, mpid=7491, secured
Mar 08 23:15:46 imap(utente1): Debug: Effective uid=500, gid=500,
home=/var/vmail/utente1
Mar 08 23:15:46 imap(utente1): Debug: maildir++:
root=/var/vmail/utente1/maildir, index=, control=,
inbox=/var/vmail/utente1/maildir
Mar 08 23:15:46 imap(utente1): Info: Disconnected: Logged out bytes=49/734
Mar 08 23:15:46 auth: Debug: auth client connected (pid=7492)
Mar 08 23:15:46 auth: Debug: client in: AUTH 1 PLAIN service=imap
secured lip=127.0.0.1 rip=127.0.0.1 lport=143 rport=37521
resp=<hidden>
Mar 08 23:15:46 auth: Debug: pam(utente1,127.0.0.1): lookup service=dovecot
Mar 08 23:15:46 auth: Debug: pam(utente1,127.0.0.1): #1/1 style=1 msg=Password:
Mar 08 23:15:47 auth: Debug: client out: OK 1 user=utente1
Mar 08 23:15:47 auth: Debug: master in: REQUEST 3944218625 7492 1
802ea9bff74c7dcf641076fb85ab1659
Mar 08 23:15:47 auth: Debug: master out: USER 3944218625 utente1 uid=500
gid=500 home=/var/vmail/utente1
Mar 08 23:15:47 imap-login: Info: Login: user=<utente1>, method=PLAIN,
rip=127.0.0.1, lip=127.0.0.1, mpid=7493, secured
Mar 08 23:15:47 imap(utente1): Debug: Effective uid=500, gid=500,
home=/var/vmail/utente1
Mar 08 23:15:47 imap(utente1): Debug: maildir++:
root=/var/vmail/utente1/maildir, index=, control=,
inbox=/var/vmail/utente1/maildir
Mar 08 23:15:47 imap(utente1): Info: Disconnected: Logged out bytes=49/734
so all operation take seconds and the usability is painfull
dovecot -n
# 2.0.9: /etc/dovecot/dovecot.conf
# OS: Linux 2.6.32-279.el6.x86_64 x86_64 CentOS release 6.3 (Final) ext4
auth_debug = yes
auth_username_chars =
abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ01234567890.-_@/
auth_username_format = %Lu
first_valid_gid = 500
last_valid_gid = 500
last_valid_uid = 500
log_path = /var/log/dovecot
mail_debug = yes
mail_location = maildir:/var/vmail/%n/maildir
mbox_write_locks = fcntl
passdb {
driver = pam
}
postmaster_address = administrator@domain.local
protocols = imap
service auth {
unix_listener /var/spool/postfix/private/auth {
group = postfix
mode = 0660
user = postfix
}
unix_listener auth-userdb {
group = vmail
mode = 0600
user = vmail
}
}
ssl = no
ssl_cert = </etc/pki/dovecot/certs/dovecot.pem
ssl_key = </etc/pki/dovecot/private/dovecot.pem
userdb {
args = uid=500 gid=500 home=/var/vmail/%Lu allow_all_users=yes
driver = static
}
valid_chroot_dirs = /var/vmail
/etc/postfix/master.cf (relevant)
# Dovecot LDA
dovecot unix - n n - - pipe flags=DRhu user=vmail:vmail
argv=/usr/libexec/dovecot/deliver -f ${sender} -d ${recipient}
/etc/postfix/ldap-groups.cf
server_host = domain.local
search_base = CN=users,DC=domain,DC=local
bind = yes
bind_dn = query@domain.local
bind_pw = **********
query_filter = (&(objectclass=group) (mail=%s))
leaf_result_attribute = mail
special_result_attribute = member
version = 3
--
users@sogo.nu
https://inverse.ca/sogo/lists
