[Dovecot] Issue Authenticating to a new dovecot-postfix installation

[Anthony Nedland]

Timo Sirainen wrote:
> On Wed, 2009-12-30 at 15:09 -0600, Anthony Nedland wrote:
>   
>> When I telnet into 110 I can enter a username with user [username] then 
>> when I do pass [password] I get -ERR Authentication failed.
>> I know the user info is correct.
>>     
>
> Setting auth_debug_passwords=yes and looking at the logs would tell
> exactly why it's failing. http://wiki.dovecot.org/Logging
>
>   
>> root at mail:/etc/dovecot# dovecot -n
>> # 1.1.11: /etc/dovecot/dovecot.conf
>> Error: Error in configuration file /etc/dovecot/dovecot.conf line 1076: 
>> Unknown section type (section changed in /etc/dovecot/dovecot.conf at 
>> line 1038)
>>     
>
> In Ubuntu Dovecot is started with -c /etc/dovecot/dovecot-postfix.conf,
> so the dovecot.conf isn't used at all. In your dovecot -n output you'd
> need to give the same -c parameter. Why they decided to do it like this,
> I've no idea.
>
> Anyway.. What this means is that:
>
>   
>> Starting line 1076--->
>>   master {
>>     
>
> Apparently master {} isn't inside socket listen {} block, as it should
> be.
>   
I get no error when I run dovecot -n -c 
/etc/dovecot/dovecot-postfix.conf, just an extremely large output.
Here is the latest portion of my log attempting to log in with a user 
that I created in postfixadmin. The telnet session opened fine and it 
gave +OK for the user. Then I got -ERR Authentication failed for the 
password.
This is the log of it...

Dec 30 15:22:21 mail dovecot: dovecot v1.1.11 starting up (core dumps 
disabled)
Dec 30 15:22:22 mail dovecot: auth-worker(default): mysql: Connected to 
localhost (postfix)
Dec 30 15:22:23 mail dovecot: auth(default): new auth connection: pid=4333
Dec 30 15:22:23 mail dovecot: auth(default): new auth connection: pid=4334
Dec 30 15:22:23 mail dovecot: auth(default): new auth connection: pid=4335
Dec 30 15:22:23 mail dovecot: auth(default): new auth connection: pid=4336
Dec 30 15:22:23 mail dovecot: auth(default): new auth connection: pid=4337
Dec 30 15:22:23 mail dovecot: auth(default): new auth connection: pid=4339
Dec 30 15:22:23 mail dovecot: auth(default): new auth connection: pid=4338
Dec 30 15:22:23 mail dovecot: auth(default): new auth connection: pid=4340
Dec 30 15:22:23 mail dovecot: auth(default): new auth connection: pid=4341
Dec 31 11:06:23 mail postfix/smtpd[4935]: connect from 
hoot.bldwn-tel.com[64.33.164.10]
Dec 31 11:06:25 mail postfix/smtpd[4935]: disconnect from 
hoot.bldwn-tel.com[64.33.164.10]
Dec 31 11:06:27 mail dovecot: auth(default): new auth connection: pid=4939
Dec 31 11:06:34 mail dovecot: auth(default): client in: 
AUTH#0111#011PLAIN#011service=pop3#011lip=192.168.1.9#011rip=64.33.164.10#011lport=110#011rport=48288#011resp=AHJha2thAHJha2th
Dec 31 11:06:34 mail dovecot: auth-worker(default): mysql: Connected to 
localhost (postfix)
Dec 31 11:06:34 mail dovecot: auth-worker(default): 
sql(rakka,64.33.164.10): query: SELECT username as user, password, 
'/var/vmail//rakka' as userdb_home,'maildir:/var/vmail//rakka' as 
userdb_mail, 150 as userdb_uid, 8 as userdb_gid FROM mailbox WHERE 
username = 'rakka' AND active = 1
Dec 31 11:06:34 mail dovecot: auth-worker(default): 
sql(rakka,64.33.164.10): unknown user
Dec 31 11:06:36 mail dovecot: auth(default): client out: 
FAIL#0111#011user=rakka
Dec 31 11:06:37 mail dovecot: pop3-login: Aborted login (auth failed, 1 
attempts): user=<rakka>, method=PLAIN, rip=64.33.164.10, lip=192.168.1.9


--