ptloader setup

Wed Jan 5 16:15:16 EST 2005

Igor Brezac 01/05/05 09:19pm
>
>On Wed, 5 Jan 2005, Mike O'Rourke wrote:
>
>> Igor Brezac 12/31/04 12:21am
>>
>>> On Thu, 30 Dec 2004, Mike O'Rourke wrote:
>>>
>> ...<snip>
>>>
>>> I would start with basics and get ptloader to work first.  Clear out the
>>> pt cache db and start from the begining.
>>>
>>> Can you email me queries from the ldap server log and ptdump output?
>>>
>>> I just tested a setup similar to your and things work for me.
>>>
>>> --
>>> Igor
>>
>> Hello Igor,
>>
>>
>> This is a login attempt from a SquirrelMail client. I first emptied the 
>> cache (is it normal that the cache has a "^Y^F" at the end of the 
>> username?) then tried the login.
>
>It should not show this, but this may be just syslog display issue.
>
>> imapd.log:
>>
>> Jan  5 03:24:36 server12 ptexpire[20488]: Expiring entries older than 10 seconds (currently 1104917076)
>> Jan  5 03:24:36 server12 ptexpire[20488]: $Id: ptexpire.c,v 1.18 2004/05/26 16:05:59 rjs3 Exp $
>> Jan  5 03:24:36 server12 ptexpire[20488]: deleteing entry for test3 at testdom.mydom.com^Y^F 
>> Jan  5 03:24:36 server12 ptexpire[20488]: mydelete: starting txn 2147483737
>> Jan  5 03:24:36 server12 ptexpire[20488]: mydelete: committing txn 2147483737
>> Jan  5 03:24:36 server12 ptexpire[20488]: finished
>> Jan  5 03:25:18 server12 master[20491]: about to exec /usr/cyrus/bin/imapd
>> Jan  5 03:25:18 server12 imap[20491]: executed
>> Jan  5 03:25:18 server12 imap[20491]: accepted connection
>> Jan  5 03:25:18 server12 imap[20491]: ptload(): pinging ptloader
>> Jan  5 03:25:18 server12 ptloader[6849]: accepted connection
>> Jan  5 03:25:18 server12 ptloader[6849]: mystore: starting txn 2147483739
>> Jan  5 03:25:18 server12 ptloader[6849]: mystore: committing txn 2147483739
>> Jan  5 03:25:18 server12 imap[20491]: badlogin: server11.mydom.com [192.168.7.11] plaintext test3 at testdom.mydom.com SASL(-13): user not 
>found: checkpass failed
>> Jan  5 03:26:21 server12 master[6846]: process 20491 exited, status 0
>>
>>
>> ptdump (after login attempt):
>>
>> user: test3 at testdom.mydom.com time: 1104917118 groups: 1
>>  secret
>>
>> transaction from slapd (removing the hex representations):
>>
>
>I just wanted to see if any other searches were performed.  You should 
>just use slapd -d 256 ...
>
>I think you have acls on this mailbox (or you have a shared mailbox with 
>acls) and you do not have an ldap entry for each of the identities listed 
>in those acls.
>
>-- 
>Igor

Actually, the mailbox you see here does not exist. I am also trying to use the autocreate patch (I did try without the auto* patches with no difference, so I switched back to the version I wanted to use.) Herewith an example of a mailbox that does exist (test1 at testdom.mydom.com) with only the mailbox owner having any rights:
    localhost> lam user/test1 at testdom.mydom.com
    test1 at testdom.mydom.com lrswipcda
and one mailbox that I want to autocreate (test3 at testdom.mydom.com). I issued a "ptexpire -E 10" before these tests.

imapd.log (blank line added between login attempts for clarity):

Jan  5 14:48:46 server12 master[21600]: about to exec /usr/cyrus/bin/imapd
Jan  5 14:48:46 server12 imap[21600]: executed
Jan  5 14:48:46 server12 imap[21600]: accepted connection
Jan  5 14:48:46 server12 imap[21600]: ptload(): pinging ptloader
Jan  5 14:48:46 server12 ptloader[6849]: accepted connection
Jan  5 14:48:46 server12 ptloader[6849]: mystore: starting txn 2147483754
Jan  5 14:48:46 server12 ptloader[6849]: mystore: committing txn 2147483754
Jan  5 14:48:46 server12 imap[21600]: badlogin: server11.mydom.com [192.168.7.11] plaintext test3 at testdom.mydom.com SASL(-13): user not found: checkpass failed
Jan  5 14:49:49 server12 master[6846]: process 21600 exited, status 0

Jan  5 14:50:04 server12 master[21601]: about to exec /usr/cyrus/bin/imapd
Jan  5 14:50:04 server12 imap[21601]: executed
Jan  5 14:50:04 server12 imap[21601]: accepted connection
Jan  5 14:50:04 server12 imap[21601]: ptload(): pinging ptloader
Jan  5 14:50:04 server12 ptloader[6849]: accepted connection
Jan  5 14:50:04 server12 ptloader[6849]: mystore: starting txn 2147483756
Jan  5 14:50:04 server12 ptloader[6849]: mystore: committing txn 2147483756
Jan  5 14:50:04 server12 imap[21601]: badlogin: server11.mydom.com [192.168.7.11] plaintext test1 at testdom.mydom.com SASL(-13): user not found: checkpass failed
Jan  5 14:51:08 server12 master[6846]: process 21601 exited, status 0

results of a "ptdump" after the two login attempts:

user: test1 at testdom.mydom.com time: 1104958204 groups: 1
  secret1
user: test3 at testdom.mydom.com time: 1104958126 groups: 1
  secret3

slapd.log (at -d 256; blank lines added after bind and between login attempts for clarity):

conn=0 fd=13 ACCEPT from IP=192.168.7.12:32913 (IP=0.0.0.0:636)
conn=0 op=0 BIND dn="cn=server11.mydom.com,ou=hosts,o=internet,dc=mydom.com" method=128
conn=0 op=0 BIND dn="cn=server11.mydom.com,ou=hosts,o=internet,dc=mydom.com" mech=SIMPLE ssf=0
conn=0 op=0 RESULT tag=97 err=0 text=

conn=0 op=1 SRCH base="ou=email,o=internet,dc=mydom.com" scope=2 deref=0 filter="(&(uid=test3 at testdom.mydom.com)(opDomMailUserDefHost=server11.mydom.com))"
conn=0 op=1 SEARCH RESULT tag=101 err=0 nentries=1 text=
conn=0 op=2 SRCH base="cn=test3,dc=testdom.mydom.com,ou=email,o=internet,dc=mydom.com" scope=0 deref=0 filter="(objectClass=*)"
conn=0 op=2 SEARCH RESULT tag=101 err=0 nentries=1 text=

conn=0 op=3 SRCH base="ou=email,o=internet,dc=mydom.com" scope=2 deref=0 filter="(&(uid=test1 at testdom.mydom.com)(opDomMailUserDefHost=server11.mydom.com))"
conn=0 op=3 SEARCH RESULT tag=101 err=0 nentries=1 text=
conn=0 op=4 SRCH base="cn=test1,dc=testdom.mydom.com,ou=email,o=internet,dc=mydom.com" scope=0 deref=0 filter="(objectClass=*)"
conn=0 op=4 SEARCH RESULT tag=101 err=0 nentries=1 text=

Thanks, Mike.

---
Cyrus Home Page: http://asg.web.cmu.edu/cyrus
Cyrus Wiki/FAQ: http://cyruswiki.andrew.cmu.edu
List Archives/Info: http://asg.web.cmu.edu/cyrus/mailing-list.html