Dear list, please find below some more details about this error. The exact error message the user is receiving is:
The server responded: "403" to operation CalDAVWriteEntityQueueableOperation. Log entries: access.log: ----------------- xxx.xxx.xxx.xxx - USERNAME [16/Sep/2013:21:25:16 +0200] "PROPFIND /principals/__uids__/XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX/ HTTP/1.1" 207 1377 "-" "Mac OS X/10.8.4 (12E55) CalendarAgent/57" i=3 t=16.3 or=1 xxx.xxx.xxx.xxx - USERNAME [16/Sep/2013:21:25:16 +0200] "PROPFIND /calendars/__uids__/XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX/XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX/ HTTP/1.1" 207 389 "-" "Mac OS X/10.8.4 (12E55) CalendarAgent/57" i=3 t=25.7 or=1 responses=1 xxx.xxx.xxx.xxx - USERNAME [16/Sep/2013:21:25:16 +0200] "PUT /calendars/__uids__/XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX/XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX/XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX.ics HTTP/1.1" 403 256 "-" "Mac OS X/10.8.4 (12E55) CalendarAgent/57" i=3 t=48.8 or=1 cl=1363 error.log: ----------------- 2013-09-16 21:25:16+0200 [-] [caldav-3] [HTTPChannel,17729,xxx.xxx.xxx.xxx] [twext.web2.server#info] PUT /calendars/__uids__/XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX/XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX/XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX.ics HTTP/1.1 2013-09-16 21:25:16+0200 [-] [caldav-3] [HTTPChannel,17729,xxx.xxx.xxx.xxx] [twistedcaldav.directory.digest.DigestCredentialsMemcache#debug] Getting Cache Token for '667401876552876251529133599083248041295625182628380460952' 2013-09-16 21:25:16+0200 [-] [caldav-3] [HTTPChannel,17729,xxx.xxx.xxx.xxx] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e861908> 2013-09-16 21:25:16+0200 [-] [caldav-3] [HTTPChannel,17729,xxx.xxx.xxx.xxx] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e861908> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [calendarserver.platform.darwin.od.opendirectory#debug] Checking digest auth for user 'USERNAME' (tries remaining: 3) 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [calendarserver.platform.darwin.od.opendirectory#debug] Digest auth for user 'USERNAME' result: True 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcacher.Memcacher#debug] Getting Cache Token for 'XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX' 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e85b998> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e85b998> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcacher.Memcacher#debug] Getting Cache Token for '179544' 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e0bfc20> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e0bfc20> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcacher.Memcacher#debug] Getting Cache Token for 'XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX' 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e69f680> 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e69f680> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcacher.Memcacher#debug] Getting Cache Token for '66274' 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e842ef0> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e842ef0> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcacher.Memcacher#debug] Getting Cache Token for '66276' 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e861908> 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e861908> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Memcache: checking dir|xxx.xxx.xxx.xxx|guid|xxx.xxx.xxx.xxx|users|groups 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Memcache: miss dir|xxx.xxx.xxx.xxx|guid|xxx.xxx.xxx.xxx|users|groups 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Faulting record for attribute 'guid' with value 'xxx.xxx.xxx.xxx' 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] opendirectory.queryRecordsWithAttribute_list(<calendarserver.platform.darwin.od.opendirectory.Directory object at 0x10e3335d0>,'dsAttrTypeStandard:GeneratedUID','xxx.xxx.xxx.xxx',8193,False,['dsRecTypeStandard:Users'],['dsAttrTypeStandard:GeneratedUID', 'dsAttrTypeStandard:RecordName', 'dsAttrTypeStandard:AltSecurityIdentities', 'dsAttrTypeStandard:RecordType', 'dsAttrTypeStandard:RealName', 'dsAttrTypeStandard:FirstName', 'dsAttrTypeStandard:LastName', 'dsAttrTypeStandard:EMailAddress', 'dsAttrTypeStandard:AppleMetaNodeLocation']) 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] opendirectory.queryRecordsWithAttribute_list(<calendarserver.platform.darwin.od.opendirectory.Directory object at 0x10e3335d0>,'dsAttrTypeStandard:GeneratedUID','xxx.xxx.xxx.xxx',8193,False,['dsRecTypeStandard:Groups'],['dsAttrTypeStandard:GeneratedUID', 'dsAttrTypeStandard:RecordName', 'dsAttrTypeStandard:AltSecurityIdentities', 'dsAttrTypeStandard:RecordType', 'dsAttrTypeStandard:RealName', 'dsAttrTypeStandard:FirstName', 'dsAttrTypeStandard:LastName', 'dsAttrTypeStandard:EMailAddress', 'dsAttrTypeStandard:AppleMetaNodeLocation', 'dsAttrTypeStandard:GroupMembers', 'dsAttrTypeStandard:NestedGroups']) 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] opendirectory.queryRecordsWithAttribute_list matched records: 1 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Storing (guid xxx.xxx.xxx.xxx) <OpenDirectoryRecord[users@xxxxxxxxxxxxxxxxxxxxxxxxxxx(server.domain.com->['/LDAPv3/127.0.0.1'])] xxx.xxx.xxx.xxx(otherusername) 'OTHER USER'> in internal cache 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.cachingdirectory.DictRecordTypeCache#debug] Memcache: storing dir|xxx.xxx.xxx.xxx|guid|xxx.xxx.xxx.xxx|users|groups 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Found record for attribute 'guid' with value 'xxx.xxx.xxx.xxx' 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Memcache: checking dir|xxx.xxx.xxx.xxx|cua|mailto:someu...@otherdomain.com|users|groups 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Memcache: miss dir|xxx.xxx.xxx.xxx|cua|mailto:someu...@otherdomain.com|users|groups 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Faulting record for attribute 'cua' with value 'mailto:someu...@otherdomain.com' 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] opendirectory.queryRecordsWithAttribute_list(<calendarserver.platform.darwin.od.opendirectory.Directory object at 0x10e3335d0>,'dsAttrTypeStandard:EMailAddress','someu...@otherdomain.com',8193,True,['dsRecTypeStandard:Users'],['dsAttrTypeStandard:GeneratedUID', 'dsAttrTypeStandard:RecordName', 'dsAttrTypeStandard:AltSecurityIdentities', 'dsAttrTypeStandard:RecordType', 'dsAttrTypeStandard:RealName', 'dsAttrTypeStandard:FirstName', 'dsAttrTypeStandard:LastName', 'dsAttrTypeStandard:EMailAddress', 'dsAttrTypeStandard:AppleMetaNodeLocation']) 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] opendirectory.queryRecordsWithAttribute_list matched records: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Memcache: checking dir|xxx.xxx.xxx.xxx|cua|mailto:someu...@otherdomain.com|users|groups 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Memcache: miss dir|xxx.xxx.xxx.xxx|cua|mailto:someu...@otherdomain.com|users|groups 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] Faulting record for attribute 'cua' with value 'mailto:someu...@otherdomain.com' 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] opendirectory.queryRecordsWithAttribute_list(<calendarserver.platform.darwin.od.opendirectory.Directory object at 0x10e3335d0>,'dsAttrTypeStandard:EMailAddress','someu...@otherdomain.com',8193,True,['dsRecTypeStandard:Users'],['dsAttrTypeStandard:GeneratedUID', 'dsAttrTypeStandard:RecordName', 'dsAttrTypeStandard:AltSecurityIdentities', 'dsAttrTypeStandard:RecordType', 'dsAttrTypeStandard:RealName', 'dsAttrTypeStandard:FirstName', 'dsAttrTypeStandard:LastName', 'dsAttrTypeStandard:EMailAddress', 'dsAttrTypeStandard:AppleMetaNodeLocation']) 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.appleopendirectory.OpenDirectoryService#debug] opendirectory.queryRecordsWithAttribute_list matched records: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.directory.principal#debug] No principal for calendar user address: 'mailto:someu...@otherdomain.com' 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachelock.MemcacheLock#debug] Adding Cache Token for 'XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX' 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e85b998> 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e85b998> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [txdav.common.datastore.sql_legacy.MemcachedUIDReserver#debug] Reserving UID 'XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX' @ <Calendar: 66276> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e0bfc20> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e0bfc20> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [txdav.common.datastore.sql_legacy.MemcachedUIDReserver#debug] Unreserving UID 'XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX' @ <Calendar: 66276> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e69f680> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e69f680> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachelock.MemcacheLock#debug] Deleting Cache Token for 'XXXXXXXX-XXXX-XXXX-XXXX-XXXXXXXXXXXX' 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachepool.MemCachePool#debug] Busied client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e842ef0> 2013-09-16 21:25:16+0200 [-] [caldav-3] [-] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 4, #busy: 1, #pending: 0, #queued: 0 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Freed client: <twistedcaldav.memcachepool.PooledMemCacheProtocol instance at 0x10e842ef0> 2013-09-16 21:25:16+0200 [-] [caldav-3] [PooledMemCacheProtocol,client] [twistedcaldav.memcachepool.MemCachePool#debug] Clients #free: 5, #busy: 0, #pending: 0, #queued: 0 Thanks in advance Frank On Sep 18, 2013, at 2:35 PM, Frank Keller wrote: > Dear list, > > we are running an OSX lion server and using caldav on it. > > Server: > System Version: 10.7.4 (Build 11E53) > Kernel: Darwin 11.4.0 > Services: Mail, Open Directory, iCal > > Clients are running OSX 10.7.x and 10.8.x > > We had problems in the past with errors when refreshing calendars. It > happened often that an error message 500 was shown when refreshing, > especially if the user had more calendar delegations > configured. After a long journey with the the apple support a workaround was > mentioned to change the port from 'auto' to '8443' in the server settings for > iCal on the client machines. We also changed the > refresh rate for calendars from push to a fixed value. It seems that these > changes solved the problems with the 500 error. > > Now we are facing a new error when receiving calendar invites as a attached > ics file, mainly from outside our organization. When opening the attached ics > file, an error 403 is shown and it is not possible to > accept the invite. Contacting Apple support again was not successful because > they are saying it is a different error and we need to purchase a new support > case to get help from them. > > So the question is, can anybody give us a hint on how to solve these issue? > Maybe someone already has a fix or a workaround for this error? > If you need any further information, please let me know. > > Any help would be appreciated. > > Best Regards > Frank
signature.asc
Description: Message signed with OpenPGP using GPGMail
_______________________________________________ calendarserver-users mailing list calendarserver-users@lists.macosforge.org https://lists.macosforge.org/mailman/listinfo/calendarserver-users
