cyrus-imapd 2.2.1 beta - auth problem

[Simon Matter]

>
>
> martynas at inet.lt wrote:
>
>> Hello,
>>
>> I try to setup cyrus imapd 2.2.1 beta + web-cyradm
>> (cyrus+postfix+mysql+pam_mysql+saslauthd). And I have such problem:
>> after setup, I try to login with cyrus user and get error:
>>
>> Authetntification is done through saslauthd -> pam -> pam_mysql -> mysql
>> I tried to debug, saslauthd returns "OK". But connecting to imap, I get
>> such
>> error:
>> [root at mail cyrus-imapd-2.2.1]# telnet localhost 143
>> Trying 127.0.0.1...
>> Connected to localhost.
>> Escape character is '^]'.
>> * OK mail.domain.com Cyrus IMAP4 v2.2.1-BETA-Invoca-RPM-2.2.1-1 server
>> ready
>>  login cyrus secret
>>  NO Login failed: can't request info until later in exchange
>>
>>
>> So, authentification doesn't work. Setup is correct for 2.1.x version,
>> because I changed to 2.1.14 and auhtentication works. After changing to
>> 2.2.1, I get this error. Something is changed in 2.2.1 version?
>>
>> So, could anybody help?
>
>
> This error is coming from SASL.  Could you please post the relevent
> contents of imapd.log and auth.log?

FYI, the beta rpm is built with '--with-syslogfacility=MAIL' so I expect
every message should go to /var/log/maillog. I don't see any errors there
and I ran saslauthd in debug mode an got an OK when trying to authenticate
using cyradm. What do I have to do to enable verbose logging?

Simon

/var/log/maillog:
Jul 24 17:46:22 black master[4054]: setrlimit: Unable to set file
descriptors limit to -1: Operation not permitted
Jul 24 17:46:22 black master[4054]: retrying with 1024 (current max)
Jul 24 17:46:22 black master[4054]: process started
Jul 24 17:46:22 black master[4055]: about to exec
/usr/lib/cyrus-imapd/ctl_cyrusdb
Jul 24 17:46:23 black ctl_cyrusdb[4055]: recovering cyrus databases
Jul 24 17:46:24 black ctl_cyrusdb[4055]: skiplist: recovered
/var/lib/imap/mailboxes.db (4 records, 800 bytes) in 1 second
Jul 24 17:46:24 black ctl_cyrusdb[4055]: done recovering cyrus databases
Jul 24 17:46:24 black master[4054]: ready for work
Jul 24 17:46:24 black master[4063]: about to exec
/usr/lib/cyrus-imapd/ctl_cyrusdb
Jul 24 17:46:24 black master[4064]: about to exec /usr/lib/cyrus-imapd/imapd
Jul 24 17:46:24 black imap[4064]: executed
Jul 24 17:46:24 black master[4065]: about to exec /usr/lib/cyrus-imapd/imapd
Jul 24 17:46:24 black imaps[4065]: executed
Jul 24 17:46:24 black master[4066]: about to exec /usr/lib/cyrus-imapd/pop3d
Jul 24 17:46:24 black ctl_cyrusdb[4063]: checkpointing cyrus databases
Jul 24 17:46:24 black ctl_cyrusdb[4063]: archiving log file:
/var/lib/imap/db/log.0000000001
Jul 24 17:46:24 black ctl_cyrusdb[4063]: archiving database file:
/var/lib/imap/mailboxes.db
Jul 24 17:46:24 black ctl_cyrusdb[4063]: archiving database file:
/var/lib/imap/annotations.db
Jul 24 17:46:24 black ctl_cyrusdb[4063]: archiving log file:
/var/lib/imap/db/log.0000000001
Jul 24 17:46:24 black pop3[4066]: executed
Jul 24 17:46:24 black master[4067]: about to exec /usr/lib/cyrus-imapd/pop3d
Jul 24 17:46:24 black master[4068]: about to exec /usr/lib/cyrus-imapd/lmtpd
Jul 24 17:46:24 black imap[4064]: skiplist: recovered
/var/lib/imap/annotations.db (0 records, 144 bytes) in 0 seconds
Jul 24 17:46:24 black ctl_cyrusdb[4063]: done checkpointing cyrus databases
Jul 24 17:46:24 black pop3s[4067]: executed
Jul 24 17:46:25 black lmtpunix[4068]: executed
Jul 24 17:46:25 black master[4054]: process 4063 exited, status 0
Jul 24 17:46:25 black master[4069]: about to exec /usr/lib/cyrus-imapd/imapd
Jul 24 17:46:25 black master[4070]: about to exec /usr/lib/cyrus-imapd/pop3d
Jul 24 17:46:25 black imap[4069]: executed
Jul 24 17:46:25 black pop3[4070]: executed
Jul 24 17:46:35 black imap[4064]: accepted connection
Jul 24 17:46:35 black master[4072]: about to exec /usr/lib/cyrus-imapd/imapd
Jul 24 17:46:35 black master[4073]: about to exec /usr/lib/cyrus-imapd/imapd
Jul 24 17:46:35 black imap[4073]: executed
Jul 24 17:46:35 black master[4074]: about to exec /usr/lib/cyrus-imapd/imapd
Jul 24 17:46:35 black imap[4074]: executed
Jul 24 17:46:35 black master[4075]: about to exec /usr/lib/cyrus-imapd/imapd
Jul 24 17:46:35 black master[4076]: about to exec /usr/lib/cyrus-imapd/pop3d
Jul 24 17:46:36 black imap[4072]: executed
Jul 24 17:46:36 black imap[4075]: executed
Jul 24 17:46:36 black pop3[4076]: executed

>
> --
> Kenneth Murchison     Oceana Matrix Ltd.
> Software Engineer     21 Princeton Place
> 716-662-8973 x26      Orchard Park, NY 14127
> --PGP Public Key--    http://www.oceana.com/~ken/ksm.pgp
>
>