#293: CalDAVRevertEntityQueueableOperation failure ----------------------------------+----------------------------------------- Reporter: cabanela@mnstate.edu | Owner: wsanchez@apple.com Type: Defect | Status: new Priority: 5: Not set | Milestone: Component: Calendar Server | Version: Severity: Serious | Resolution: Keywords: | ----------------------------------+----------------------------------------- Old description:
I am using the current (revision 2706) trunk of the Calendar Server.
Attempts to add a new item to one of my calendars results in:
"HTTP/1.1 500 Internal Server Error" to operation CalDAVRevertEntityQueueableOperation
No error message get placed in the error.log, however, the last few entries in the access.log are:
199.17.102.218 - JuanCabanela [16/Jul/2008:16:50:24 -0500] "PROPFIND /principals/users/JuanCabanela/ HTTP/1.1" 500 201 "-" "DAVKit/2.0 (10.5.4; wrbt) iCal 3.0.4" [19.3 ms] 199.17.102.218 - JuanCabanela [16/Jul/2008:16:50:24 -0500] "PROPFIND /principals/users/JuanCabanela/ HTTP/1.1" 207 1107 "-" "DAVKit/2.0 (10.5.4; wrbt) iCal 3.0.4" [14.5 ms] 199.17.102.218 - JuanCabanela [16/Jul/2008:16:50:24 -0500] "PROPFIND /principals/users/JuanCabanela/ HTTP/1.1" 207 294 "-" "DAVKit/2.0 (10.5.4; wrbt) iCal 3.0.4" [12.8 ms] 199.17.102.218 - - [16/Jul/2008:16:50:24 -0500] "PUT /calendars/__uids__/juan/54978F4D-C96D-4A1D-BE81-C37C78A06F9D/182C8FDC- CBF6-485D-AC56-3D0AAFD62CA6.ics HTTP/1.1" 500 201 "-" "DAVKit/2.0 (10.5.4; wrbt) iCal 3.0.4" [11.7 ms]
Since I ran 'run' interactively, the screen output is:
2008-07-16 16:50:24-0500 [-] [caldav-8009] [-] [twisted.web2.dav.method.propfind#error] Error reading property ('urn:ietf:params:xml:ns:caldav', 'calendar-home-set') for resource /principals/users/JuanCabanela/: 2008-07-16 16:50:24-0500 [-] [caldav-8009] [-] Exception rendering: 2008-07-16 16:50:24-0500 [-] [caldav-8009] [-] Unhandled Error 2008-07-16 16:50:24-0500 [-] [caldav-8009] Traceback (most recent call last): 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 239, in callback 2008-07-16 16:50:24-0500 [-] [caldav-8009] self._startRunCallbacks(result) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 304, in _startRunCallbacks 2008-07-16 16:50:24-0500 [-] [caldav-8009] self._runCallbacks() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 317, in _runCallbacks 2008-07-16 16:50:24-0500 [-] [caldav-8009] self.result = callback(self.result, *args, **kw) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 601, in gotResult 2008-07-16 16:50:24-0500 [-] [caldav-8009] _deferGenerator(g, deferred) 2008-07-16 16:50:24-0500 [-] [caldav-8009] --- <exception caught here> --- 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 576, in _deferGenerator 2008-07-16 16:50:24-0500 [-] [caldav-8009] result = g.next() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/web2/dav/method/propfind.py", line 164, in http_PROPFIND 2008-07-16 16:50:24-0500 [-] [caldav-8009] status = statusForFailure(f, "getting property: %s" % (property,)) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/web2/dav/http.py", line 319, in statusForFailure 2008-07-16 16:50:24-0500 [-] [caldav-8009] failure.raiseException() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/web2/dav/method/propfind.py", line 158, in http_PROPFIND 2008-07-16 16:50:24-0500 [-] [caldav-8009] resource_property = resource_property.getResult() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 555, in getResult 2008-07-16 16:50:24-0500 [-] [caldav-8009] self.result.raiseException() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/python/failure.py", line 303, in raiseException 2008-07-16 16:50:24-0500 [-] [caldav-8009] raise self.type, self.value, self.tb 2008-07-16 16:50:24-0500 [-] [caldav-8009] exceptions.AssertionError: 2008-07-16 16:50:24-0500 [-] [caldav-8009] 2008-07-16 16:50:24-0500 [-] [caldav-8009] [AMP,client] Exception rendering: 2008-07-16 16:50:24-0500 [-] [caldav-8009] [AMP,client] Unhandled Error 2008-07-16 16:50:24-0500 [-] [caldav-8009] Traceback (most recent call last): 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/web2/server.py", line 314, in _getChild 2008-07-16 16:50:24-0500 [-] [caldav-8009] result = res.locateChild(self, path) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/CalendarServer/twistedcaldav/directory/resource.py", line 62, in locateChild 2008-07-16 16:50:24-0500 [-] [caldav-8009] d.addCallback(lambda _: self.provisionChild(name)) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 191, in addCallback 2008-07-16 16:50:24-0500 [-] [caldav-8009] callbackKeywords=kw) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 182, in addCallbacks 2008-07-16 16:50:24-0500 [-] [caldav-8009] self._runCallbacks() 2008-07-16 16:50:24-0500 [-] [caldav-8009] --- <exception caught here> --- 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 317, in _runCallbacks 2008-07-16 16:50:24-0500 [-] [caldav-8009] self.result = callback(self.result, *args, **kw) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/CalendarServer/twistedcaldav/directory/resource.py", line 62, in <lambda> 2008-07-16 16:50:24-0500 [-] [caldav-8009] d.addCallback(lambda _: self.provisionChild(name)) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/CalendarServer/twistedcaldav/static.py", line 500, in provisionChild 2008-07-16 16:50:24-0500 [-] [caldav-8009] assert len(name) > 4 2008-07-16 16:50:24-0500 [-] [caldav-8009] exceptions.AssertionError: 2008-07-16 16:50:24-0500 [-] [caldav-8009]
Any ideas?
New description: I am using the current (revision 2706) trunk of the Calendar Server. Attempts to add a new item to one of my calendars results in: {{{ "HTTP/1.1 500 Internal Server Error" to operation CalDAVRevertEntityQueueableOperation }}} No error message get placed in the error.log, however, the last few entries in the access.log are: {{{ 199.17.102.218 - JuanCabanela [16/Jul/2008:16:50:24 -0500] "PROPFIND /principals/users/JuanCabanela/ HTTP/1.1" 500 201 "-" "DAVKit/2.0 (10.5.4; wrbt) iCal 3.0.4" [19.3 ms] 199.17.102.218 - JuanCabanela [16/Jul/2008:16:50:24 -0500] "PROPFIND /principals/users/JuanCabanela/ HTTP/1.1" 207 1107 "-" "DAVKit/2.0 (10.5.4; wrbt) iCal 3.0.4" [14.5 ms] 199.17.102.218 - JuanCabanela [16/Jul/2008:16:50:24 -0500] "PROPFIND /principals/users/JuanCabanela/ HTTP/1.1" 207 294 "-" "DAVKit/2.0 (10.5.4; wrbt) iCal 3.0.4" [12.8 ms] 199.17.102.218 - - [16/Jul/2008:16:50:24 -0500] "PUT /calendars/__uids__/juan/54978F4D-C96D-4A1D-BE81-C37C78A06F9D/182C8FDC- CBF6-485D-AC56-3D0AAFD62CA6.ics HTTP/1.1" 500 201 "-" "DAVKit/2.0 (10.5.4; wrbt) iCal 3.0.4" [11.7 ms] }}} Since I ran 'run' interactively, the screen output is: {{{ 2008-07-16 16:50:24-0500 [-] [caldav-8009] [-] [twisted.web2.dav.method.propfind#error] Error reading property ('urn:ietf:params:xml:ns:caldav', 'calendar-home-set') for resource /principals/users/JuanCabanela/: 2008-07-16 16:50:24-0500 [-] [caldav-8009] [-] Exception rendering: 2008-07-16 16:50:24-0500 [-] [caldav-8009] [-] Unhandled Error 2008-07-16 16:50:24-0500 [-] [caldav-8009] Traceback (most recent call last): 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 239, in callback 2008-07-16 16:50:24-0500 [-] [caldav-8009] self._startRunCallbacks(result) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 304, in _startRunCallbacks 2008-07-16 16:50:24-0500 [-] [caldav-8009] self._runCallbacks() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 317, in _runCallbacks 2008-07-16 16:50:24-0500 [-] [caldav-8009] self.result = callback(self.result, *args, **kw) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 601, in gotResult 2008-07-16 16:50:24-0500 [-] [caldav-8009] _deferGenerator(g, deferred) 2008-07-16 16:50:24-0500 [-] [caldav-8009] --- <exception caught here> --- 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 576, in _deferGenerator 2008-07-16 16:50:24-0500 [-] [caldav-8009] result = g.next() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/web2/dav/method/propfind.py", line 164, in http_PROPFIND 2008-07-16 16:50:24-0500 [-] [caldav-8009] status = statusForFailure(f, "getting property: %s" % (property,)) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/web2/dav/http.py", line 319, in statusForFailure 2008-07-16 16:50:24-0500 [-] [caldav-8009] failure.raiseException() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/web2/dav/method/propfind.py", line 158, in http_PROPFIND 2008-07-16 16:50:24-0500 [-] [caldav-8009] resource_property = resource_property.getResult() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 555, in getResult 2008-07-16 16:50:24-0500 [-] [caldav-8009] self.result.raiseException() 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/python/failure.py", line 303, in raiseException 2008-07-16 16:50:24-0500 [-] [caldav-8009] raise self.type, self.value, self.tb 2008-07-16 16:50:24-0500 [-] [caldav-8009] exceptions.AssertionError: 2008-07-16 16:50:24-0500 [-] [caldav-8009] 2008-07-16 16:50:24-0500 [-] [caldav-8009] [AMP,client] Exception rendering: 2008-07-16 16:50:24-0500 [-] [caldav-8009] [AMP,client] Unhandled Error 2008-07-16 16:50:24-0500 [-] [caldav-8009] Traceback (most recent call last): 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/web2/server.py", line 314, in _getChild 2008-07-16 16:50:24-0500 [-] [caldav-8009] result = res.locateChild(self, path) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/CalendarServer/twistedcaldav/directory/resource.py", line 62, in locateChild 2008-07-16 16:50:24-0500 [-] [caldav-8009] d.addCallback(lambda _: self.provisionChild(name)) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 191, in addCallback 2008-07-16 16:50:24-0500 [-] [caldav-8009] callbackKeywords=kw) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 182, in addCallbacks 2008-07-16 16:50:24-0500 [-] [caldav-8009] self._runCallbacks() 2008-07-16 16:50:24-0500 [-] [caldav-8009] --- <exception caught here> --- 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/Twisted/twisted/internet/defer.py", line 317, in _runCallbacks 2008-07-16 16:50:24-0500 [-] [caldav-8009] self.result = callback(self.result, *args, **kw) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/CalendarServer/twistedcaldav/directory/resource.py", line 62, in <lambda> 2008-07-16 16:50:24-0500 [-] [caldav-8009] d.addCallback(lambda _: self.provisionChild(name)) 2008-07-16 16:50:24-0500 [-] [caldav-8009] File "/usr/local/DarwinCalendarServer/CalendarServer/twistedcaldav/static.py", line 500, in provisionChild 2008-07-16 16:50:24-0500 [-] [caldav-8009] assert len(name) > 4 2008-07-16 16:50:24-0500 [-] [caldav-8009] exceptions.AssertionError: 2008-07-16 16:50:24-0500 [-] [caldav-8009] }}} Any ideas? -- Ticket URL: <https://trac.calendarserver.org/ticket/293#comment:1> CalendarServer </> HTTP/WebDAV/CalDAV Server