[Dovecot] Dovecot - not pulling pop3s email from virtual mbox

Sat Jan 18 15:13:38 EET 2014

*Please ignore the previous logs, The latest logs is like this*

Jan 18 18:24:20 ns dovecot: pop3(info at ghhdomain.com): Disconnected: Logged
out top=0/0, retr=0/0, del=0/0, size=0
Jan 18 18:24:21 ns dovecot: auth: Debug: auth client connected
(pid=6565)uth: Debug: Module loaded:
/usr/lib/dovecot/auth/libdriver_sqlite.so
Jan 18 18:24:20 ns dovecot: auth: Debug: Module loaded:
/usr/lib/dovecot/auth/libmech_gssapi.so
Jan 18 18:24:20 ns dovecot: auth: Debug: passwd-file /etc/dovecot/users:
Read 1 users
Jan 18 18:24:20 ns dovecot: auth: Debug: auth client connected (pid=6557)
Jan 18 18:24:20 ns dovecot: auth: Debug: client in:
AUTH#0111#011CRAM-MD5#011service=pop3#011secured#011lip=10.0.0.12#011rip=10.0.0.12#011lport=995#011rport=60220
Jan 18 18:24:20 ns dovecot: auth: Debug: client out:
CONT#0111#011PDkyMTUxNjk0NjcyMTczNTguMTM5MDA0OTY2MEBucy5tYXN0ZXItc2VydmVyPg==
Jan 18 18:24:20 ns dovecot: auth: Debug: client in:
CONT#0111#011aW5mb0BnaGhkb21haW4uY29tIGQxYWQ3YjFjZGJhNzgzYThlZTE0YjFmYTQzZWRhNWYy
Jan 18 18:24:20 ns dovecot: auth: Debug:
passwd-file(info at ghhdomain.com,10.0.0.12):
lookup: user=info at ghhdomain.com file=/etc/dovecot/users
Jan 18 18:24:20 ns dovecot: auth: Debug:
password(info at ghhdomain.com,10.0.0.12):
Credentials:
8314fef5923bb513c7e8be9e663501bbc56ce1012aae68e4c68852be5ab8da76
Jan 18 18:24:20 ns dovecot: auth
Jan 18 18:24:21 ns dovecot: auth: Debug: client in:
AUTH#0111#011CRAM-MD5#011service=pop3#011secured#011lip=10.0.0.12#011rip=10.0.0.12#011lport=995#011rport=60221
Jan 18 18:24:21 ns dovecot: auth: Debug: client out:
CONT#0111#011PDgzODc1MDY2NDY4MTI4NDIuMTM5MDA0OTY2MUBucy5tYXN0ZXItc2VydmVyPg==
Jan 18 18:24:21 ns dovecot: auth: Debug: client in:
CONT#0111#011aW5mb0BnaGhkb21haW4uY29tIDQxZGNhMjZhNWFiNDE4Nzc3OWMyNjA4YWZjZTZlM2U3
Jan 18 18:24:21 ns dovecot: auth: Debug:
passwd-file(info at ghhdomain.com,10.0.0.12):
lookup: user=info at ghhdomain.com file=/etc/dovecot/users
Jan 18 18:24:21 ns dovecot: auth: Debug:
password(info at ghhdomain.com,10.0.0.12):
Credentials:
8314fef5923bb513c7e8be9e663501bbc56ce1012aae68e4c68852be5ab8da76
Jan 18 18:24:21 ns dovecot: auth: Debug: client out: OK#0111#011user=
info at ghhdomain.com
Jan 18 18:24:21 ns dovecot: auth: Debug: master in:
REQUEST#0113064463361#0116565#0111#0113f28733155b91b94914b425475b79851
Jan 18 18:24:21 ns dovecot: auth: Debug:
passwd-file(info at ghhdomain.com,10.0.0.12):
lookup: user=info at ghhdomain.com file=/etc/dovecot/users
Jan 18 18:24:21 ns dovecot: auth: Debug: master out: USER#0113064463361#
011info at ghhdomain.com#011uid=503#011gid=503
Jan 18 18:24:21 ns dovecot: pop3-login: Login: user=<info at ghhdomain.com>,
method=CRAM-MD5, rip=10.0.0.12, lip=10.0.0.12, mpid=6566, TLS
Jan 18 18:24:21 ns dovecot: pop3(info at ghhdomain.com): Debug: Effective
uid=503, gid=503, home=
Jan 18 18:24:21 ns dovecot: pop3(info at ghhdomain.com): Debug: mbox: INBOX
defaulted to /var/spool/mail/ghhdomain.com/info/inbox
Jan 18 18:24:21 ns dovecot: pop3(info at ghhdomain.com): Debug: fs:
root=/var/spool/mail/ghhdomain.com/info, index=, control=,
inbox=/var/spool/mail/ghhdomain.com/info/inbox

On Sat, Jan 18, 2014 at 6:34 PM, Ganesh Hariharan <ghariharan at gmail.com>wrote:

> Hi,
>
> Client is able to authenticate to the dovecot server using cram-md5
> password, and I can see the file being created by dovecot server under
> /var/spool/mail/ghhdomain.com/info/Inbox, having said it is 0 byte file
> and no mails are found
>
>
> any help is appreciated..
>
>
> logs as below
> Jan 18 17:22:53 ns dovecot: auth: Debug: auth client connected (pid=5162)
> Jan 18 17:22:53 ns dovecot: auth: Debug: client in:
> AUTH#0111#011CRAM-MD5#011service=pop3#011secured#011lip=10.0.0.12#011rip=10.0.0.12#011lport=995#011rport=60156
> Jan 18 17:22:53 ns dovecot: auth: Debug: client out:
> CONT#0111#011PDA0NDM3NzgzNDMyODE4MzMuMTM5MDA0NTk3M0Bucy5tYXN0ZXItc2VydmVyPg==
> Jan 18 17:22:53 ns dovecot: auth: Debug: client in:
> CONT#0111#011aW5mb0BnaGhkb21haW4uY29tIGJhMGYwMGEzZmZkMjU5YWJjZDA4ZTI5ZmIwZDY4Y2Mw
> Jan 18 17:22:53 ns dovecot: auth: Debug: passwd-file(info at ghhdomain.com,10.0.0.12):
> lookup: user=info at ghhdomain.com file=/etc/dovecot/users
> Jan 18 17:22:53 ns dovecot: auth: Debug: password(info at ghhdomain.com,10.0.0.12):
> Credentials:
> 8314fef5923bb513c7e8be9e663501bbc56ce1012aae68e4c68852be5ab8da76
> Jan 18 17:22:53 ns dovecot: auth: Debug: client out: OK#0111#011user=
> info at ghhdomain.com
> Jan 18 17:22:53 ns dovecot: auth: Debug: master in:
> REQUEST#011931659777#0115162#0111#011ec6a642974dcbb984952b19eb208d849
> Jan 18 17:22:53 ns dovecot: auth: Debug: passwd-file(info at ghhdomain.com,10.0.0.12):
> lookup: user=info at ghhdomain.com file=/etc/dovecot/users
> Jan 18 17:22:53 ns dovecot: auth: Debug: master out: USER#011931659777#
> 011info at ghhdomain.com#011uid=503#011gid=503#011home=/bin/false<http://011info@ghhdomain.com#011uid=503%23011gid=503%23011home=/bin/false>
> Jan 18 17:22:53 ns dovecot: pop3-login: Login: user=<info at ghhdomain.com>,
> method=CRAM-MD5, rip=10.0.0.12, lip=10.0.0.12, mpid=5163, TLS
> Jan 18 17:22:53 ns dovecot: pop3(info at ghhdomain.com): Debug: Effective
> uid=503, gid=503, home=/bin/false
> Jan 18 17:22:53 ns dovecot: pop3(info at ghhdomain.com): Error:
> chdir(/bin/false) failed: Not a directory
> Jan 18 17:22:53 ns dovecot: pop3(info at ghhdomain.com): Debug: mbox: INBOX
> defaulted to /var/spool/mail/info at ghhdomain.com/inbox
>
>
> the current config as below
> # 2.0.9: /etc/dovecot/dovecot.conf
> # OS: Linux 2.6.32-431.el6.i686 i686 CentOS release 6.5 (Final) ext4
> auth_debug = yes
> auth_debug_passwords = yes
> auth_mechanisms = cram-md5
> mail_debug = yes
> mail_full_filesystem_access = yes
> mail_gid = 503
> mail_location = mbox:/var/spool/mail/ghhdomain.com/%n
> mail_uid = 503
> mbox_write_locks = fcntl
> passdb {
>   args = scheme=cram-md5 username_format=%u /etc/dovecot/users
>   driver = passwd-file
> }
> service pop3-login {
>   inet_listener pop3 {
>     port = 110
>   }
>   inet_listener pop3s {
>     port = 995
>     ssl = yes
>   }
> }
> ssl_cert = </etc/postfix/newcert.pem
> ssl_key = </etc/postfix/newkey.pem
> userdb {
>   args = /etc/dovecot/users
>   driver = passwd-file
> }
> userdb {
>   args = username_format=%u /etc/dovecot/users
>   driver = passwd-file
> }
>
>
>
> Thanks!
>
>
> On Thu, Jan 16, 2014 at 6:14 PM, Steffen Kaiser <
> skdovecot at smail.inf.fh-brs.de> wrote:
>
>> -----BEGIN PGP SIGNED MESSAGE-----
>> Hash: SHA1
>>
>> On Thu, 16 Jan 2014, Ganesh Hariharan wrote:
>>
>>  I have two files , users and passwd
>>>
>>> cat /etc/dovecot/users
>>> info at ghhdomain.com:501:501:/var/spool/mail/ghhdomain/info/:/bin/false:
>>>
>>> [sysopminds at ns ~]$ cat /etc/dovecot/passwd
>>> info at ghhdomain.com:
>>> {CRAM-MD5}e02d374fde0dc75a17a557039a3a5338c7743304777dccd376f332bee68d
>>> 2cf6:503:503
>>>
>>
>> See: http://wiki2.dovecot.org/AuthDatabase/PasswdFile
>> the syntax is: user:password:uid:gid:(gecos):home:(shell):extra_fields
>> so your user file is wrong. But this error would come later.
>>
>> The config shows that you have not configured no passdb. Re-check that
>> you've included the appropriate auth*ext files, e.g. the
>> auth-passwdfile.conf.ext.
>>
>>
>>  On Thu, Jan 16, 2014 at 3:44 PM, Steffen Kaiser <
>>> skdovecot at smail.inf.fh-brs.de> wrote:
>>>
>>>  -----BEGIN PGP SIGNED MESSAGE-----
>>>> Hash: SHA1
>>>>
>>>>
>>>> On Thu, 16 Jan 2014, Ganesh Hariharan wrote:
>>>>
>>>>  Jan 16 09:27:04 ns dovecot: auth: Error: passwd-file
>>>> /etc/dovecot/users:
>>>>
>>>>> User info at ghhdomain.com has invalid GID '/var/spool/mail/ghhdomain/
>>>>> info/'
>>>>> Jan 16 09:27:04 ns dovecot: auth: Debug: passwd-file
>>>>> /etc/dovecot/users:
>>>>> Read 0 users
>>>>>
>>>>>
>>>>  Please see my configs
>>>>
>>>>>
>>>>>  don't grab selected output from the conf files, use doveconf -n
>>>>
>>>>
>>>>  users file look like this
>>>>> info at ghhdomain.com:
>>>>> {CRAM-MD5}e02d374fde0dc75a17a557039a3a5338c7743304777dccd376f332bee68d
>>>>> 2cf6:503:503
>>>>>
>>>>>
>>>>>  Do you have a line with "/var/spool/mail/ghhdomain/info/" in
>>>> /etc/dovecot/users ? Post that line and, say, three lines before and
>>>> three
>>>> after it.
>>>>
>>>> - -- Steffen Kaiser
>>>> -----BEGIN PGP SIGNATURE-----
>>>> Version: GnuPG v1.4.11 (GNU/Linux)
>>>>
>>>> iQEVAwUBUtew/HD1/YhP6VMHAQLtbwgAjj11c42Ou+tQ5pBglOIIIfU+VrKjq2Av
>>>> 0Ii2FMcjT/KMH7yHya/Dj6KGUMv1miZGj3FSpGaihcYIilxkjUXKr01noSmEb4Pj
>>>> BkSHkqciJrzVZulzDtOiWXEl3jsT3VpQcqMKbfMOrAshG9nxz0cTCw6AtIEllJC8
>>>> StytjqaaYDBaW5zmRWY7kSjKiLHr8Y3nLQfFLPjrRw1KL1lKTTNm8o2mpA1Yah+3
>>>> cBZ1zFBswxbVmORhcug+sJB+vWauiZ9cX5DGgjLjflHFiaL9CXnGnjntdki2ZFjg
>>>> VAShxwU/RSnTQBrdYvWSvAtD+bXP+3eySuitaHqyGcogHVZFb1bPQQ==
>>>> =w/kl
>>>> -----END PGP SIGNATURE-----
>>>>
>>>>
>>>
>> - -- Steffen Kaiser
>> -----BEGIN PGP SIGNATURE-----
>> Version: GnuPG v1.4.11 (GNU/Linux)
>>
>> iQEVAwUBUtfUOXD1/YhP6VMHAQIYYgf9EZJL9VQCUa2Qqf+OoJk+Wo+sizCV/95n
>> q+oaGW3OrgN/kIVLMc6qiVJQThQ6KZUadtIQKY4t987nhqByEnH6ZslNakQKRFz9
>> 2tHMww7TDE/6snQeGw/D83+hnhsu7GapLTuLSE8mjOkGpj3XUQrdsthEXE3rW4Mn
>> ZGjubq3WVmAPxTz041sX7BsTtTqVOZCIT/lMeSUV8YkPEclC8gKzuIE2RKX9z5Ms
>> 3Sj8iskxYhtr9i04D/JZmlMlPrFqcxaveZWoxDwF33YJ09QkhkvKP0+/JpYP4OS9
>> pxw5D7sjd4V6sYNb1jVt74WAuxRI2ZxKwOm9MZozJEiM99t9Snv56g==
>> =YjUp
>> -----END PGP SIGNATURE-----
>>
>
>