[CalendarServer-users] OpenLDAP Login does not work

12 Jun 2014

      Hello

Can Someone Help Me with my OpenLDAP and calendarserver Setup?

OpenLDAP is working fine with other services.
Calendarserver is new setup, completely empty. But i Am unable to Authenticate against OpenLDAP and can't figure out why.

Here is a lot of output I can supply:

OpenLDAP Server: 172.16.20.1
Calendarserver (with PostgresDB): 172.16.20.2

-------------------------------------------------------------------
OpenLDAP Log
Jun 12 08:02:16 intranet slapd[37255]: conn=1204 op=6 SRCH base="ou=users,dc=mycompany,dc=at" scope=2 deref=0 filter="(&(&(!(objectClass=organizationalUnit))(objectClass=person))(uid=michael))"
Jun 12 08:02:16 intranet slapd[37255]: conn=1204 op=6 SRCH attr=uid entryUUID member sn mail givenName cn
Jun 12 08:02:16 intranet slapd[37255]: conn=1204 op=6 SEARCH RESULT tag=101 err=0 nentries=1 text=

-------------------------------------------------------------------
Caldavd.log (debug)
2014-06-12 08:02:00+0200 [-] [caldav-0]  [HTTPChannel,18,172.16.20.135] [twext.web2.server#info] PROPFIND /.well-known/caldav HTTP/1.1
2014-06-12 08:02:00+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] hashing key for get: ('PROPFIND', '{DAV:}unauthenticated', '/.well-known/caldav', '0', -5831127382503763874) to 'cb21600fe1f04810171c8c277cf6f30a'
2014-06-12 08:02:00+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] Checking cache for: 'cb21600fe1f04810171c8c277cf6f30a'
2014-06-12 08:02:00+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:00+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:00+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:00+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:00+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.cache.MemcacheResponseCache#debug] Not in cache: 'cb21600fe1f04810171c8c277cf6f30a'
2014-06-12 08:02:00+0200 [Logging] [calendarserver.accesslog#info] Rotating log file to: /var/log/caldavd/access.log.2014_6_11
2014-06-12 08:02:00+0200 [-] [caldav-0]  [HTTPChannel,18,172.16.20.135] [twext.web2.server#info] PROPFIND / HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,18,172.16.20.135] [twext.web2.server#info] PROPFIND / HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,18,172.16.20.135] [twext.web2.server#info] PROPFIND /calendar/dav/michael/user/ HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] hashing key for get: ('PROPFIND', '{DAV:}unauthenticated', '/calendar/dav/michael/user/', '0', -5831127382503763874) to 'b4accc7ce5fdf237253ed408e0ba3de5'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] Checking cache for: 'b4accc7ce5fdf237253ed408e0ba3de5'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.cache.MemcacheResponseCache#debug] Not in cache: 'b4accc7ce5fdf237253ed408e0ba3de5'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,18,172.16.20.135] [twext.web2.server#info] PROPFIND /principals/users/michael/ HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] hashing key for get: ('PROPFIND', '{DAV:}unauthenticated', '/principals/users/michael/', '0', -5831127382503763874) to 'f3038de2b9043adee5c6fc610dbb1969'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] Checking cache for: 'f3038de2b9043adee5c6fc610dbb1969'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.cache.MemcacheResponseCache#debug] Not in cache: 'f3038de2b9043adee5c6fc610dbb1969'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.cachingdirectory.DictRecordTypeCache#debug] Removed record c0a848c6-745d-1033-8f65-7fab776ed3b7
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Memcache: checking dir|5A871574-0C86-44EE-B11B-B9440C3DC4DD|shortname|michael|users|groups
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Memcache: miss dir|5A871574-0C86-44EE-B11B-B9440C3DC4DD|shortname|michael|users|groups
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Faulting record for attribute 'shortname' with value 'michael'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] LDAP query for types ['users'], indexType shortname and indexKey michael
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Retrieving ldap record with base ou=users,dc=mycompany,dc=at and filter (&(&(!(objectClass=organizationalUnit))(objec
tClass=person))(uid=michael)).
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Got LDAP record <LdapDirectoryRecord[users@a660b981-f5ee-5e13-a226-1e0037a77042(ldap://ldap.intern.mycompany.at/)] c0
a848c6-745d-1033-8f65-7fab776ed3b7(michael) 'Michael Polanz' @ None/#>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.cachingdirectory.DictRecordTypeCache#debug] Memcache: storing dir|5A871574-0C86-44EE-B11B-B9440C3DC4DD|shortname|michael|users|groups
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.cachingdirectory.DictRecordTypeCache#debug] Memcache: storing dir|5A871574-0C86-44EE-B11B-B9440C3DC4DD|guid|c0a848c6-745d-1033-8f65-7fab776ed3b7|users|gro
ups
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.ldapdirectory.LdapDirectoryService#debug] Found record for attribute 'shortname' with value 'michael'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache Token for '334247766580093840921227804067894426191709273898389687340'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache Token for '334247766580093840921227804067894426191709273898389687340'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] Could not locate URI: URINotFoundException: Could not find URI '{DAV:}unauthenticated'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,19,172.16.20.135] [twext.web2.server#info] PROPFIND /principals/users/michael/ HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,19,172.16.20.135] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache Token for '334247766580093840921227804067894426191709273898389687340'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,19,172.16.20.135] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,19,172.16.20.135] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache Token for '263656109578519429260912374366681780235009889785072829817'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache Token for '263656109578519429260912374366681780235009889785072829817'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,20,172.16.20.135] [twext.web2.server#info] PROPFIND /principals/users/michael/ HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] hashing key for get: ('PROPFIND', '{DAV:}unauthenticated', '/principals/users/michael/', '0', -5831127382503763874) to 'f3038de2b9043adee5c6fc610dbb1969'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] Checking cache for: 'f3038de2b9043adee5c6fc610dbb1969'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.cache.MemcacheResponseCache#debug] Not in cache: 'f3038de2b9043adee5c6fc610dbb1969'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache Token for '108512302307150721247221014016571903416317306378413117435'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache Token for '108512302307150721247221014016571903416317306378413117435'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] Could not locate URI: URINotFoundException: Could not find URI '{DAV:}unauthenticated'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,20,172.16.20.135] [twext.web2.server#info] PROPFIND /principals/ HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] hashing key for get: ('PROPFIND', '{DAV:}unauthenticated', '/principals/', '0', -5831127382503763874) to '67a1b86e149e4f923cacada94760752b'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] Checking cache for: '67a1b86e149e4f923cacada94760752b'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.cache.MemcacheResponseCache#debug] Not in cache: '67a1b86e149e4f923cacada94760752b'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache Token for '574435993294825038237996323120762883923851736127472981076'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache Token for '574435993294825038237996323120762883923851736127472981076'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,21,172.16.20.135] [twext.web2.server#info] PROPFIND /principals/ HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,21,172.16.20.135] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache Token for '574435993294825038237996323120762883923851736127472981076'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,21,172.16.20.135] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,21,172.16.20.135] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache Token for '651605969348500415518033960959266286117169713778210774636'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache Token for '651605969348500415518033960959266286117169713778210774636'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,22,172.16.20.135] [twext.web2.server#info] PROPFIND /principals/ HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] hashing key for get: ('PROPFIND', '{DAV:}unauthenticated', '/principals/', '0', -5831127382503763874) to '67a1b86e149e4f923cacada94760752b'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] Checking cache for: '67a1b86e149e4f923cacada94760752b'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.cache.MemcacheResponseCache#debug] Not in cache: '67a1b86e149e4f923cacada94760752b'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache Token for '393887940127969569076817591927550490454145692277185341423'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Setting Cache Token for '393887940127969569076817591927550490454145692277185341423'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [HTTPChannel,22,172.16.20.135] [twext.web2.server#info] PROPFIND /dav/principals/ HTTP/1.1
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] hashing key for get: ('PROPFIND', '{DAV:}unauthenticated', '/dav/principals/', '0', -5831127382503763874) to '9a34baeab8b9bfea8b988cf3b52ad4bf'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.cache.MemcacheResponseCache#debug] Checking cache for: '9a34baeab8b9bfea8b988cf3b52ad4bf'
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 0, #busy: 1, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x4086ef0>
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 1, #busy: 0, #pending: 0, #queued: 0
2014-06-12 08:02:10+0200 [-] [caldav-0]  [PooledMemCacheProtocol,client] [twistedcaldav.cache.MemcacheResponseCache#debug] Not in cache: '9a34baeab8b9bfea8b988cf3b52ad4bf'

-------------------------------------------------------------------
/Applications/Calendar.app/Contents/MacOS/Calendar -LogHTTPActivity YES
2014-06-12 08:02:20.974 Calendar[40935:ed17] [com.apple.calendar.iaplugin.log.CalInternetAccountsPlugin] [Autodiscovery error: [Error Domain=CoreDAVHTTPStatusErrorDomain Code=401 "Der Vorgang konnte nicht abgeschlossen werden. (CoreDAVHTTPStatusErrorDomain-Fehler 401.)" UserInfo=0x7fea1d784ea0 {CoreDAVHTTPHeaders=<CFBasicHash 0x7fea1add80f0 [0x7fff7e10bf00]>{type = immutable dict, count = 7,
entries =>
	0 : Server = <CFString 0x7fea1f8b86d0 [0x7fff7e10bf00]>{contents = "CalendarServer/3.2(r) Twisted/12.0.0 TwistedWeb/9.0.0"}
	1 : Content-Type = <CFString 0x7fea1f801ea0 [0x7fff7e10bf00]>{contents = "text/html;charset=utf-8"}
	3 : Strict-Transport-Security = <CFString 0x7fea1fe1b760 [0x7fff7e10bf00]>{contents = "max-age=600"}
	4 : DAV = <CFString 0x7fea1fe6c740 [0x7fff7e10bf00]>{contents = "1, access-control, calendar-access, calendar-schedule, calendar-auto-schedule, calendar-availability, inbox-availability, calendar-proxy, calendarserver-private-events, calendarserver-private-comments, calendarserver-sharing, calendarserver-sharing-no-scheduling, calendar-query-extended, addressbook, extended-mkcol, calendarserver-principal-property-search"}
	6 : Date = <CFString 0x7fea1d739650 [0x7fff7e10bf00]>{contents = "Thu, 12 Jun 2014 06:02:10 GMT"}
	9 : Www-Authenticate = <CFString 0x7fea1f8583d0 [0x7fff7e10bf00]>{contents = "digest nonce="219623413418261832358442125127482014527428307489524228543", realm="ldap://ldap.intern.mycompany.at/", algorithm="md5""}
	10 : Content-Length = <CFString 0x7fea1f86a580 [0x7fff7e10bf00]>{contents = "141"}
}
}].]
2014-06-12 08:02:20.974 Calendar[40935:161f] [com.apple.calendarsetup.iaplugin.log.controller] [Account setup failed with error Accountname oder Kennwort konnten nicht überprüft werden.]

("Accountname oder Kennwort konnten nicht überprüft werden" means: Unable to check Username or Password)

-------------------------------------------------------------------
ldap part of caldavc.plist
<key>DirectoryService</key>
   <dict>
     <key>type</key>
     <string>twistedcaldav.directory.ldapdirectory.LdapDirectoryService</string>

     <key>params</key>
     <dict>
       <key>restrictEnabledRecords</key>
       <false/>
       <key>restrictToGroup</key>
       <string></string>
       <key>cacheTimeout</key>
       <integer>30</integer>
       <key>uri</key>
       <string>ldap://ldap.intern.mycompany.at/</string>
       <key>tls</key>
       <false/>
       <key>tlsCACertFile</key>
       <string></string>
       <key>tlsCACertDir</key>
       <string></string>
       <key>tlsRequireCert</key>
       <string>never</string>
       <key>credentials</key>
       <dict>
         <key>dn</key>
         <string>uid=calendar,ou=sysaccounts,dc=mycompany,dc=at</string>
         <key>password</key>
         <string>SUPERSECRETPASSWD</string>
       </dict>
       <key>authMethod</key>
       <string>LDAP</string>
       <key>rdnSchema</key>
       <dict>
         <key>base</key>
         <string>dc=mycompany,dc=at</string>
         <key>guidAttr</key>
         <string>entryUUID</string>
         <key>users</key>
         <dict>
           <key>rdn</key>
           <string>ou=users</string>
           <key>attr</key>
           <string>uid</string>
           <key>emailSuffix</key>
           <string>mycompany.at</string>
           <key>filter</key>
           <string>(objectClass=person)</string>
           <key>loginEnabledAttr</key>
           <string></string>
           <key>loginEnabledValue</key>
           <string>no</string>
           <key>mapping</key>
           <dict>
             <key>recordName</key>
             <string>uid</string>
             <key>fullName</key>
             <string>cn</string>
             <key>emailAddresses</key>
             <string>mail</string>
             <key>firstName</key>
             <string>givenName</string>
             <key>lastName</key>
             <string>sn</string>
           </dict>
         </dict>
         <key>groups</key>
         <dict>
           <key>rdn</key>
           <string>ou=groups</string>
           <key>attr</key>
           <string>cn</string>
           <key>emailSuffix</key>
           <string></string>
           <key>filter</key>
           <string></string>
           <key>mapping</key>
           <dict>
             <key>recordName</key>
             <string>cn</string>
             <key>fullName</key>
             <string>cn</string>
             <key>emailAddresses</key>
             <string>mail</string>
             <key>firstName</key>
             <string>givenName</string>
             <key>lastName</key>
             <string>sn</string>
           </dict>
         </dict>
       </dict>
       <key>groupSchema</key>
       <dict>
         <key>membersAttr</key>
         <string>member</string>
         <key>nestedGroupsAttr</key>
         <string></string>
         <key>memberIdAttr</key>
         <string></string>
       </dict>
       <key>resourceSchema</key>
       <dict>
         <key>resourceInfoAttr</key>
         <string></string>
         <key>autoScheduleAttr</key>
         <string></string>
         <key>autoScheduleEnabledValue</key>
         <string>yes</string>
         <key>proxyAttr</key>
         <string></string>
         <key>readOnlyProxyAttr</key>
         <string></string>
       </dict>
     </dict>
   </dict>

Thank you in advance

Michael Polanz

--
EDIS GmbH
Hauptplatz 3
8010 Graz
Austria
Umsatzsteuer-ID: ATU 64124511
Firmenbuch: FN 308697t

phone: +43 316 827 500 385
fax: +43 316 827 500 777
http://www.edis.at

This e-mail is confidential and may well also be legally privileged. If you have received it in error, you are on notice of its status. Please notify us immediately by reply e-mail and then delete this message from your system. Please do not copy it or use it for any purposes, or disclose its contents to any other person: to do so could be a breach of confidence. Thank you for your cooperation.