for the ETAG Problem:
2012-07-10 08:36:07,221 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) ReportMethod: doMethod
2012-07-10 08:36:07,221 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] <?xml version="1.0"?>
<C:calendar-query xmlns:C="urn:ietf:params:xml:ns:caldav">
<D:prop xmlns:D="DAV:">
<D:getetag/>
<C:calendar-data/>
</D:prop>
<C:filter>
<C:comp-filter name="VCALENDAR">
<C:comp-filter name="VEVENT">
<C:prop-filter name="UID">
<C:text-match collation="i;ascii-casemap">20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede</C:text-match>
</C:prop-filter>
</C:comp-filter>
</C:comp-filter>
</C:filter>
</C:calendar-query>
2012-07-10 08:36:07,221 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) ReportMethod: depth=1
2012-07-10 08:36:07,221 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] prop: {DAV:}getetag
2012-07-10 08:36:07,221 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-10) <calendar-data content-type="text/calendar">
2012-07-10 08:36:07,221 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-10) </calendar-data>
2012-07-10 08:36:07,221 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] prop: {urn:ietf:params:xml:ns:caldav}calendar-data
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) REPORT: query
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) <filter>
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) <comp-filter name="VCALENDAR">
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) <comp-filter name="VEVENT">
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) <prop-filter name="UID">
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) <text-match collation=i;ascii-casemap negate-condition=no>
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) 20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) </text-match>
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) </prop-filter>
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) </comp-filter>
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) </comp-filter>
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) </filter>
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) setStatus(207)
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) getWriter called
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) resourceUri: /user/vbede/calendar/
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] About to get node for /user/vbede/calendar/
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] Normalized uri=/user/vbede/calendar
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] search for collection uri "/user/vbede/calendar"
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] create collection uri - cal="/user/vbede/calendar"
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) REPORT: preq not null
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) doNodeAndChildren: curDepth=0 maxDepth=1 uri=/user/vbede/calendar
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-10) getNodes: /user/vbede/calendar
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-10) getEvents for start=null end=null
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-10) select distinct ev from org.bedework.calfacade.BwEventObj ev where ev.tombstoned=false and (((ev.entityType=:fq__0) and (lower(ev.uid) like :fq__1) and (ev.colPath=:fq__2)))
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-10) Getting (0) Found 1 entries
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-10) select distinct ev from org.bedework.calfacade.BwEventAnnotation ev where ev.tombstoned=false and (ev.override = false)
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-10) Getting (1) Found 0 entries
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-10) select distinct ev from org.bedework.calfacade.BwEventObj ev, org.bedework.calfacade.BwRecurrenceInstance inst where (inst.master = ev) and (((ev.entityType=:fq__0) and (lower(ev.uid) like :fq__1) and (ev.colPath=:fq__2)))
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-10) Getting (4) Found 0 entries
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-10) select distinct ev from org.bedework.calfacade.BwEventAnnotation ev where ev.tombstoned=false and (ev.override = true)
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-10) Getting (2) Found 0 entries
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.filter.FilterHandler] (http-0.0.0.0-8080-10) Query returned 1
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] About to get node for /user/vbede/calendar/20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] Normalized uri=/user/vbede/calendar/20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [452] do CalendarData for /user/vbede/calendar/20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) End transaction for 2012-07-10 08:36:07.206
2012-07-10 08:36:07,252 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_IN
2012-07-10 08:36:07,252 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Close for 2012-07-10 08:36:07.206
2012-07-10 08:36:07,252 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event ENTITY_FETCHED
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) ------------------------ Dump of response -------------------
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) <?xml version="1.0" encoding="UTF-8" ?>
<DAV:multistatus xmlns:DAV="DAV:"
xmlns="urn:ietf:params:xml:ns:caldav"
xmlns:ical="
http://www.w3.org/2002/12/cal/ical#">
<DAV:response>
<DAV:href>/ucaldav/user/vbede/calendar/20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics</DAV:href>
<DAV:propstat>
<DAV:prop>
<DAV:getetag>"20120710T063606Z-0333"</DAV:getetag>
<calendar-data><![CDATA[BEGIN:VCALENDAR
PRODID://Bedework.org//BedeWork V3.8//EN
VERSION:2.0
BEGIN:VEVENT
CREATED:20120710T063606Z
DURATION:PT1H
DTSTAMP:20120710T063606Z
DTSTART:20120710T010000Z
LAST-MODIFIED:20120710T063606Z
SUMMARY:Ein neuer Termin
UID:20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede
END:VEVENT
END:VCALENDAR
]]></calendar-data>
</DAV:prop>
<DAV:status>HTTP/1.1 200 ok</DAV:status>
</DAV:propstat>
</DAV:response>
</DAV:multistatus>
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) ---------------------- End dump of response -----------------
2012-07-10 08:36:07,252 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_OUT
2012-07-10 08:36:07,252 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) contentLength=922
2012-07-10 08:36:07,252 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-10) SESSION-END:073B2F0E4A64A753AA6E365CEB56B381:?:0:452:132M:599M
2012-07-10 08:36:07,252 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-10) ========= Session destroyed(?): 0 active. vm(used, max)=(132M, 599M)
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) entry: PUT
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) Request headers
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) authorization = "Basic **********"
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) if-match = ""20120710T063606Z-0333""
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) user-agent = "Jakarta Commons-HttpClient/3.1"
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) host = "localhost:8080"
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) cookie = "$Version=0; JSESSIONID=073B2F0E4A64A753AA6E365CEB56B381; $Path=/ucaldav"
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) content-length = "354"
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) content-type = "text/calendar; charset=UTF-8"
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) Request parameters - global info and uris
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) getRemoteAddr = 127.0.0.1
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) getRequestURI = /ucaldav/user/vbede/calendar/20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) getRemoteUser = vbede
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) getRequestedSessionId = 073B2F0E4A64A753AA6E365CEB56B381
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) HttpUtils.getRequestURL(req) =
http://localhost:8080/ucaldav/user/vbede/calendar/20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) contextPath=/ucaldav
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) query=null
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) contentlen=354
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) request=org.apache.catalina.connector.RequestFacade@5c0c2339
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) parameters:
2012-07-10 08:36:07,284 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) Request parameters
2012-07-10 08:36:07,284 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-10) SESSION-START:C6AE78682F28DBF227166E1BAEB16B50:?:1:453:131M:599M
2012-07-10 08:36:07,284 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-10) ========= New session(?): 1 active, 453 total. vm(used, max)=(131M, 599M)
2012-07-10 08:36:07,284 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) New hibernate session for null
2012-07-10 08:36:07,284 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Open session for null
2012-07-10 08:36:07,284 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Begin transaction for null
2012-07-10 08:36:07,284 DEBUG [org.bedework.calsvc.CalSvc] (http-0.0.0.0-8080-10) Authenticated user vbede logged on
2012-07-10 08:36:07,284 DEBUG [org.bedework.calsvc.directory.UserGroupsLdapImpl] (http-0.0.0.0-8080-10) Logged into LDAP server, javax.naming.ldap.InitialLdapContext@74467cd8
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) End transaction for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Close for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_LOGIN
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) New hibernate session for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Open session for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Begin transaction for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) End transaction for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Close for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_SVCINIT
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) New hibernate session for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Open session for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Begin transaction for 2012-07-10 08:36:07.284
2012-07-10 08:36:07,299 DEBUG [edu.rpi.cct.webdav.servlet.common.PutMethod] (http-0.0.0.0-8080-10) PutMethod: doMethod
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [453] About to get node for /user/vbede/calendar/20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [453] Normalized uri=/user/vbede/calendar/20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [453] find event(s) - cal="/user/vbede/calendar" name="20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics"
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] BEGIN:VCALENDAR
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] PRODID://Bedework.org//BedeWork V3.8//EN
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] VERSION:2.0
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] BEGIN:VEVENT
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] DTSTART:20120710T010000Z
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] DURATION:PT1H
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] UID:20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] SUMMARY:I changed the summary!
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] ATTENDEE;PARTSTAT=ACCEPTED:mailto:
te...@test.de2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] DESCRIPTION:Termin geaendert
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] DTSTAMP:20120710T063607Z
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] END:VEVENT
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-10) [146] END:VCALENDAR
2012-07-10 08:36:07,299 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-10) TRANS-TO_EVENT: try to fetch event with guid=20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede
2012-07-10 08:36:07,299 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-10) TRANS-TO_EVENT: fetched event with guid
2012-07-10 08:36:07,299 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-10) No entry for index UNKNOWN_PROPERTY name null
2012-07-10 08:36:07,299 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-10) No entry for index BUSYTYPE name BUSYTYPE
2012-07-10 08:36:07,299 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-10) No entry for index COLLECTION name COLLECTION
2012-07-10 08:36:07,299 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-10) No entry for index LANG name LANGUAGE
2012-07-10 08:36:07,299 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-10) No entry for index XBEDEWORK_COST name X-BEDEWORK-COST
2012-07-10 08:36:07,299 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-10) No entry for index CALSCALE name CALSCALE
2012-07-10 08:36:07,299 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-10) No entry for index METHOD name METHOD
2012-07-10 08:36:07,299 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-10) No entry for index PRODID name PRODID
2012-07-10 08:36:07,299 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-10) No entry for index VERSION name VERSION
2012-07-10 08:36:07,299 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-10) ChangeTable{
SUMMARY: changed
DESCRIPTION: changed
DTSTAMP
UID
ATTENDEE: changed
DTSTART
DURATION}
2012-07-10 08:36:07,299 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-10) BwEvent{id=3783, owner=/principals/users/vbede, publick=false,
creator=/principals/users/vbede, access=null, collection=/user/vbede/calendar,
entityType=0, deleted=false,
dtstamp=20120710T063607Z,
dtstart=BwDateTime{DATETIME, dtval=20120710T010000Z, UTC},
dtend=BwDateTime{DATETIME, dtval=20120710T020000Z, UTC},
status=null,
lastmod=20120710T063606Z, created=20120710T063606Z, stag=null,
priority=null, classification=null,
uid=20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede,
name=20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics,
ctoken=20120710T063606Z-0333
, getRecurring=false,
organizer=null,
summary={BwString{id=-1, lang=null, value=I changed the summary!},
description={BwLongString{id=-1, lang=null, value=Termin geaendert},
attendee=BwAttendee{id=-1, cn=null, cuType=null, delegatedFrom=null, delegatedTo=null,
dir=null, language=null, member=null, rsvp=false,
role=null, partstat=ACCEPTED, sentBy=null, attendeeUri=mailto:
te...@test.de,
sequence=0, dtstamp=null,
scheduleAgent=0, scheduleStatus=null},
sequence=0, scheduleMethod=0,
originator=null, scheduleState=0}
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [453] putContent: intf has event with name 20120710T083606-77caf433-2c7d-4e68-9383-2d8077c52c31-vbede.ics and summary I changed the summary! new event = false
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) [453] putContent: etag mismatch if="20120710T063606Z-0333"prev="20120710T063606Z-0"
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Enter rollback
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) About to rollback
2012-07-10 08:36:07,299 ERROR [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-10) org.bedework.caldav.server.CaldavBWIntf@6376f152
edu.rpi.cct.webdav.servlet.shared.WebdavException
at org.bedework.caldav.server.CaldavBWIntf.putEvent(CaldavBWIntf.java:896)
at org.bedework.caldav.server.CaldavBWIntf.putContent(CaldavBWIntf.java:760)
at edu.rpi.cct.webdav.servlet.shared.WebdavNsIntf.putContent(WebdavNsIntf.java:680)
at edu.rpi.cct.webdav.servlet.common.PutMethod.doMethod(PutMethod.java:57)
at edu.rpi.cct.webdav.servlet.common.WebdavServlet.service(WebdavServlet.java:149)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:235)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:190)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:525)
at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:92)
at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.process(SecurityContextEstablishmentValve.java:126)
at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.invoke(SecurityContextEstablishmentValve.java:70)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
at org.jboss.web.tomcat.service.jca.CachedConnectionValve.invoke(CachedConnectionValve.java:158)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:567)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:330)
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:829)
at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:598)
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:447)
at java.lang.Thread.run(Thread.java:662)
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) Enter rollback
2012-07-10 08:36:07,299 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-10) setStatus(412) message=null
2012-07-10 08:36:07,299 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-10) End transaction for 2012-07-10 08:36:07.284
Where can i see the http.wire trace?
Thanks for your work and help!
Regards Hans
Am Montag, 9. Juli 2012 15:10:16 UTC+2 schrieb Hans Will:
i running my owen local bedework server and use caldav4j in eclipse, when i use the Examples in caldav4j i run in this error:
Creating Caldav Client..
Opening a collection..
root:/ucaldav/user/vbede/calendar/
create a dummy event..
modify the event..
Retrieve the event..
original BEGIN:VEVENT
CREATED:20120709T122331Z
DURATION:PT1H
DTSTAMP:20120709T122331Z
DTSTART:20120710T010000Z
LAST-MODIFIED:20120709T122331Z
SUMMARY:Ein neuer Termin
UID:20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
END:VEVENT
org.osaf.caldav4j.exceptions.CalDAV4JException: Problem executing put method
at org.osaf.caldav4j.CalDAVCalendarCollectionBase.put(CalDAVCalendarCollectionBase.java:214)
at org.osaf.caldav4j.CalDAVCalendarCollection.updateMasterEvent(CalDAVCalendarCollection.java:404)
at example.CalDavCollectionManager.editEvent(CalDavCollectionManager.java:245)
at example.CalDavCollectionManager.main(CalDavCollectionManager.java:400)
Caused by: org.osaf.caldav4j.exceptions.ResourceOutOfDateException: Etag was not matched: "20120709T122331Z-1067"
at org.osaf.caldav4j.CalDAVCalendarCollectionBase.put(CalDAVCalendarCollectionBase.java:209)
... 3 more
dump the event..
BEGIN:VCALENDAR
PRODID://Bedework.org//BedeWork V3.8//EN
VERSION:2.0
BEGIN:VEVENT
CREATED:20120709T122331Z
DURATION:PT1H
DTSTAMP:20120709T122331Z
DTSTART:20120710T010000Z
LAST-MODIFIED:20120709T122331Z
SUMMARY:Ein neuer Termin
UID:20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
END:VEVENT
END:VCALENDAR
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) entry: PUT
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request headers
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) authorization = "Basic **********"
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) if-none-match = "*"
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) user-agent = "Jakarta Commons-HttpClient/3.1"
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) host = "localhost:8080"
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-length = "257"
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-type = "text/calendar; charset=UTF-8"
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters - global info and uris
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteAddr = 127.0.0.1
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestURI = /ucaldav/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteUser = vbede
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestedSessionId = null
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) HttpUtils.getRequestURL(req) = http://localhost:8080/ucaldav/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contextPath=/ucaldav
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) query=null
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentlen=257
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) request=org.apache.catalina.connector.RequestFacade@4526d044
2012-07-09 14:23:31,894 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) parameters:
2012-07-09 14:23:31,895 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters
2012-07-09 14:23:31,895 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-8) SESSION-START:F4823B2A8A91B0845058EE1458405376:?:1:2366:251M:598M
2012-07-09 14:23:31,895 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-8) ========= New session(?): 1 active, 2366 total. vm(used, max)=(251M, 598M)
2012-07-09 14:23:31,895 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for null
2012-07-09 14:23:31,895 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for null
2012-07-09 14:23:31,895 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for null
2012-07-09 14:23:31,896 DEBUG [org.bedework.calsvc.CalSvc] (http-0.0.0.0-8080-8) Authenticated user vbede logged on
2012-07-09 14:23:31,897 DEBUG [org.bedework.calsvc.directory.UserGroupsLdapImpl] (http-0.0.0.0-8080-8) Logged into LDAP server, javax.naming.ldap.InitialLdapContext@4441f63f
2012-07-09 14:23:31,899 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,900 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,900 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,900 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,901 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,901 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_LOGIN
2012-07-09 14:23:31,904 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,905 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,905 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,905 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_SVCINIT
2012-07-09 14:23:31,905 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,905 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,906 DEBUG [edu.rpi.cct.webdav.servlet.common.PutMethod] (http-0.0.0.0-8080-8) PutMethod: doMethod
2012-07-09 14:23:31,906 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2366] About to get node for /user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:31,906 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2366] Normalized uri=/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:31,907 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2366] find event(s) - cal="/user/vbede/calendar" name="20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics"
2012-07-09 14:23:31,908 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] BEGIN:VCALENDAR
2012-07-09 14:23:31,908 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] PRODID:
2012-07-09 14:23:31,908 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] VERSION:2.0
2012-07-09 14:23:31,908 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] CALSCALE:GREGORIAN
2012-07-09 14:23:31,908 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] BEGIN:VEVENT
2012-07-09 14:23:31,908 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] DTSTAMP:20120709T122331Z
2012-07-09 14:23:31,909 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] DTSTART:20120710T010000Z
2012-07-09 14:23:31,909 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] DURATION:PT1H
2012-07-09 14:23:31,909 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] SUMMARY:Ein neuer Termin
2012-07-09 14:23:31,909 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] UID:20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
2012-07-09 14:23:31,909 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] END:VEVENT
2012-07-09 14:23:31,909 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [714] END:VCALENDAR
2012-07-09 14:23:31,909 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-8) TRANS-TO_EVENT: try to fetch event with guid=20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
2012-07-09 14:23:31,911 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-8) TRANS-TO_EVENT: did not find event with guid
2012-07-09 14:23:31,911 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index UNKNOWN_PROPERTY name null
2012-07-09 14:23:31,911 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index BUSYTYPE name BUSYTYPE
2012-07-09 14:23:31,911 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index COLLECTION name COLLECTION
2012-07-09 14:23:31,911 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index LANG name LANGUAGE
2012-07-09 14:23:31,911 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index XBEDEWORK_COST name X-BEDEWORK-COST
2012-07-09 14:23:31,911 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index CALSCALE name CALSCALE
2012-07-09 14:23:31,911 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index METHOD name METHOD
2012-07-09 14:23:31,911 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index PRODID name PRODID
2012-07-09 14:23:31,911 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index VERSION name VERSION
2012-07-09 14:23:31,911 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-8) ChangeTable{
SUMMARY: changed
DTSTAMP
UID: changed
DTSTART: changed
DURATION: changed}
2012-07-09 14:23:31,911 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-8) BwEvent{id=-1, owner=/principals/users/vbede, publick=null,
creator=/principals/users/vbede, access=null, collection=/user/vbede/calendar,
entityType=0, deleted=false,
dtstamp=20120709T122331Z,
dtstart=BwDateTime{DATETIME, dtval=20120710T010000Z, UTC},
dtend=BwDateTime{DATETIME, dtval=20120710T020000Z, UTC},
status=null,
lastmod=20120709T122331Z, created=20120709T122331Z, stag=null,
priority=null, classification=null,
uid=20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede,
name=null,
ctoken=20120709T122331Z-1066
, getRecurring=false,
organizer=null,
summary={BwString{id=-1, lang=null, value=Ein neuer Termin},
sequence=0, scheduleMethod=0,
originator=null, scheduleState=0}
2012-07-09 14:23:31,911 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2366] putContent: intf has event with name 20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics and summary Ein neuer Termin new event = true
2012-07-09 14:23:31,915 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) setStatus(201)
2012-07-09 14:23:31,915 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,916 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_IN
2012-07-09 14:23:31,919 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event ENTITY_FETCHED
2012-07-09 14:23:31,920 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event ENTITY_FETCHED
2012-07-09 14:23:31,921 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event STATS
2012-07-09 14:23:31,924 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event STATS
2012-07-09 14:23:31,924 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event STATS
2012-07-09 14:23:31,925 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event STATS
2012-07-09 14:23:31,926 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event ENTITY_ADDED
2012-07-09 14:23:31,926 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (org.bedework:service=Indexer) New hibernate session for 2012-07-09 12:14:01.756
2012-07-09 14:23:31,926 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (org.bedework:service=Indexer) Open session for 2012-07-09 12:14:01.756
2012-07-09 14:23:31,926 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (org.bedework:service=Indexer) Begin transaction for 2012-07-09 12:14:01.756
2012-07-09 14:23:31,928 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:31.898
2012-07-09 14:23:31,931 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ------------------------ Dump of response -------------------
2012-07-09 14:23:31,932 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8)
2012-07-09 14:23:31,932 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ---------------------- End dump of response -----------------
2012-07-09 14:23:31,932 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentLength=0
2012-07-09 14:23:31,932 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-8) SESSION-END:F4823B2A8A91B0845058EE1458405376:?:0:2366:246M:598M
2012-07-09 14:23:31,932 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-8) ========= Session destroyed(?): 0 active. vm(used, max)=(246M, 598M)
2012-07-09 14:23:31,933 DEBUG [org.bedework.calsvc.indexing.BwIndexLuceneImpl] (org.bedework:service=Indexer) removed 0 entries for event:020 /user/vbede/calendar058 20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbedeN
2012-07-09 14:23:31,984 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (org.bedework:service=Indexer) End transaction for 2012-07-09 12:14:01.756
2012-07-09 14:23:31,988 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (org.bedework:service=Indexer) Close for 2012-07-09 12:14:01.756
2012-07-09 14:23:31,989 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event STATS
2012-07-09 14:23:31,989 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_OUT
2012-07-09 14:23:31,989 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event ENTITY_FETCHED
2012-07-09 14:23:32,105 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) entry: REPORT
2012-07-09 14:23:32,105 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request headers
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) authorization = "Basic **********"
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) user-agent = "Jakarta Commons-HttpClient/3.1"
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) host = "localhost:8080"
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) cookie = "$Version=0; JSESSIONID=F4823B2A8A91B0845058EE1458405376; $Path=/ucaldav"
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-length = "571"
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) depth = "1"
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-type = "text/xml"
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters - global info and uris
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteAddr = 127.0.0.1
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestURI = /ucaldav/user/vbede/calendar/
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteUser = vbede
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestedSessionId = F4823B2A8A91B0845058EE1458405376
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) HttpUtils.getRequestURL(req) = http://localhost:8080/ucaldav/user/vbede/calendar/
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contextPath=/ucaldav
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) query=null
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentlen=571
2012-07-09 14:23:32,106 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) request=org.apache.catalina.connector.RequestFacade@4526d044
2012-07-09 14:23:32,107 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) parameters:
2012-07-09 14:23:32,107 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters
2012-07-09 14:23:32,107 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-8) SESSION-START:3753CE921FA34612419841C754C9D785:?:1:2367:244M:598M
2012-07-09 14:23:32,107 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-8) ========= New session(?): 1 active, 2367 total. vm(used, max)=(244M, 598M)
2012-07-09 14:23:32,107 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for null
2012-07-09 14:23:32,107 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for null
2012-07-09 14:23:32,107 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for null
2012-07-09 14:23:32,108 DEBUG [org.bedework.calsvc.CalSvc] (http-0.0.0.0-8080-8) Authenticated user vbede logged on
2012-07-09 14:23:32,109 DEBUG [org.bedework.calsvc.directory.UserGroupsLdapImpl] (http-0.0.0.0-8080-8) Logged into LDAP server, javax.naming.ldap.InitialLdapContext@486bae92
2012-07-09 14:23:32,110 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,112 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,112 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,112 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,112 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,112 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_LOGIN
2012-07-09 14:23:32,115 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,116 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,116 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,117 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,117 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,116 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_SVCINIT
2012-07-09 14:23:32,117 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) No charset specified in request; forced to UTF-8
2012-07-09 14:23:32,117 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) ReportMethod: doMethod
2012-07-09 14:23:32,118 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] <?xml version="1.0"?>
<C:calendar-query xmlns:C="urn:ietf:params:xml:ns:caldav">
<D:prop xmlns:D="DAV:">
<D:getetag/>
<C:calendar-data/>
</D:prop>
<C:filter>
<C:comp-filter name="VCALENDAR">
<C:comp-filter name="VEVENT">
<C:prop-filter name="UID">
<C:text-match collation="i;ascii-casemap">20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede</C:text-match>
</C:prop-filter>
</C:comp-filter>
</C:comp-filter>
</C:filter>
</C:calendar-query>
2012-07-09 14:23:32,118 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) ReportMethod: depth=1
2012-07-09 14:23:32,119 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] prop: {DAV:}getetag
2012-07-09 14:23:32,119 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) <calendar-data content-type="text/calendar">
2012-07-09 14:23:32,119 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) </calendar-data>
2012-07-09 14:23:32,119 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] prop: {urn:ietf:params:xml:ns:caldav}calendar-data
2012-07-09 14:23:32,151 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) REPORT: query
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <filter>
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <comp-filter name="VCALENDAR">
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <comp-filter name="VEVENT">
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <prop-filter name="UID">
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <text-match collation=i;ascii-casemap negate-condition=no>
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) 20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </text-match>
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </prop-filter>
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </comp-filter>
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </comp-filter>
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </filter>
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) setStatus(207)
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getWriter called
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) resourceUri: /user/vbede/calendar/
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] About to get node for /user/vbede/calendar/
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] Normalized uri=/user/vbede/calendar
2012-07-09 14:23:32,152 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] search for collection uri "/user/vbede/calendar"
2012-07-09 14:23:32,154 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] create collection uri - cal="/user/vbede/calendar"
2012-07-09 14:23:32,154 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) REPORT: preq not null
2012-07-09 14:23:32,154 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) doNodeAndChildren: curDepth=0 maxDepth=1 uri=/user/vbede/calendar
2012-07-09 14:23:32,154 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) getNodes: /user/vbede/calendar
2012-07-09 14:23:32,154 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) getEvents for start=null end=null
2012-07-09 14:23:32,154 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev from org.bedework.calfacade.BwEventObj ev where ev.tombstoned=false and (((ev.entityType=:fq__0) and (lower(ev.uid) like :fq__1) and (ev.colPath=:fq__2)))
2012-07-09 14:23:32,155 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (0) Found 1 entries
2012-07-09 14:23:32,155 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev from org.bedework.calfacade.BwEventAnnotation ev where ev.tombstoned=false and (ev.override = false)
2012-07-09 14:23:32,156 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (1) Found 0 entries
2012-07-09 14:23:32,156 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev from org.bedework.calfacade.BwEventObj ev, org.bedework.calfacade.BwRecurrenceInstance inst where (inst.master = ev) and (((ev.entityType=:fq__0) and (lower(ev.uid) like :fq__1) and (ev.colPath=:fq__2)))
2012-07-09 14:23:32,157 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (4) Found 0 entries
2012-07-09 14:23:32,157 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev from org.bedework.calfacade.BwEventAnnotation ev where ev.tombstoned=false and (ev.override = true)
2012-07-09 14:23:32,158 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (2) Found 0 entries
2012-07-09 14:23:32,158 DEBUG [org.bedework.caldav.server.filter.FilterHandler] (http-0.0.0.0-8080-8) Query returned 1
2012-07-09 14:23:32,158 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] About to get node for /user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,158 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] Normalized uri=/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,159 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2367] do CalendarData for /user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,161 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,162 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.11
2012-07-09 14:23:32,163 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_IN
2012-07-09 14:23:32,163 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event ENTITY_FETCHED
2012-07-09 14:23:32,164 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ------------------------ Dump of response -------------------
2012-07-09 14:23:32,164 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) <?xml version="1.0" encoding="UTF-8" ?>
<DAV:multistatus xmlns:DAV="DAV:"
xmlns="urn:ietf:params:xml:ns:caldav"
xmlns:ical="http://www.w3.org/2002/12/cal/ical#">
<DAV:response>
<DAV:href>/ucaldav/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics</DAV:href>
<DAV:propstat>
<DAV:prop>
<DAV:getetag>"20120709T122331Z-1067"</DAV:getetag>
<calendar-data><![CDATA[BEGIN:VCALENDAR
PRODID://Bedework.org//BedeWork V3.8//EN
VERSION:2.0
BEGIN:VEVENT
CREATED:20120709T122331Z
DURATION:PT1H
DTSTAMP:20120709T122331Z
DTSTART:20120710T010000Z
LAST-MODIFIED:20120709T122331Z
SUMMARY:Ein neuer Termin
UID:20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
END:VEVENT
END:VCALENDAR
]]></calendar-data>
</DAV:prop>
<DAV:status>HTTP/1.1 200 ok</DAV:status>
</DAV:propstat>
</DAV:response>
</DAV:multistatus>
2012-07-09 14:23:32,164 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ---------------------- End dump of response -----------------
2012-07-09 14:23:32,164 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentLength=922
2012-07-09 14:23:32,164 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-8) SESSION-END:3753CE921FA34612419841C754C9D785:?:0:2367:237M:598M
2012-07-09 14:23:32,164 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-8) ========= Session destroyed(?): 0 active. vm(used, max)=(237M, 598M)
2012-07-09 14:23:32,164 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_OUT
2012-07-09 14:23:32,212 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) entry: REPORT
2012-07-09 14:23:32,212 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request headers
2012-07-09 14:23:32,212 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) authorization = "Basic **********"
2012-07-09 14:23:32,212 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) user-agent = "Jakarta Commons-HttpClient/3.1"
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) host = "localhost:8080"
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) cookie = "$Version=0; JSESSIONID=3753CE921FA34612419841C754C9D785; $Path=/ucaldav"
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-length = "571"
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) depth = "1"
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-type = "text/xml"
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters - global info and uris
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteAddr = 127.0.0.1
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestURI = /ucaldav/user/vbede/calendar/
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteUser = vbede
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestedSessionId = 3753CE921FA34612419841C754C9D785
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) HttpUtils.getRequestURL(req) = http://localhost:8080/ucaldav/user/vbede/calendar/
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contextPath=/ucaldav
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) query=null
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentlen=571
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) request=org.apache.catalina.connector.RequestFacade@4526d044
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) parameters:
2012-07-09 14:23:32,213 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters
2012-07-09 14:23:32,213 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-8) SESSION-START:2ED3AB22CC319E19D1CDF6B7293A524F:?:1:2368:237M:598M
2012-07-09 14:23:32,213 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-8) ========= New session(?): 1 active, 2368 total. vm(used, max)=(237M, 598M)
2012-07-09 14:23:32,214 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for null
2012-07-09 14:23:32,214 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for null
2012-07-09 14:23:32,214 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for null
2012-07-09 14:23:32,214 DEBUG [org.bedework.calsvc.CalSvc] (http-0.0.0.0-8080-8) Authenticated user vbede logged on
2012-07-09 14:23:32,215 DEBUG [org.bedework.calsvc.directory.UserGroupsLdapImpl] (http-0.0.0.0-8080-8) Logged into LDAP server, javax.naming.ldap.InitialLdapContext@54ad4aa
2012-07-09 14:23:32,217 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,218 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,218 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,218 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,218 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,218 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_LOGIN
2012-07-09 14:23:32,221 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,222 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,222 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_SVCINIT
2012-07-09 14:23:32,222 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,222 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,222 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,222 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) No charset specified in request; forced to UTF-8
2012-07-09 14:23:32,223 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) ReportMethod: doMethod
2012-07-09 14:23:32,224 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] <?xml version="1.0"?>
<C:calendar-query xmlns:C="urn:ietf:params:xml:ns:caldav">
<D:prop xmlns:D="DAV:">
<D:getetag/>
<C:calendar-data/>
</D:prop>
<C:filter>
<C:comp-filter name="VCALENDAR">
<C:comp-filter name="VEVENT">
<C:prop-filter name="UID">
<C:text-match collation="i;ascii-casemap">20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede</C:text-match>
</C:prop-filter>
</C:comp-filter>
</C:comp-filter>
</C:filter>
</C:calendar-query>
2012-07-09 14:23:32,224 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) ReportMethod: depth=1
2012-07-09 14:23:32,224 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] prop: {DAV:}getetag
2012-07-09 14:23:32,224 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) <calendar-data content-type="text/calendar">
2012-07-09 14:23:32,224 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) </calendar-data>
2012-07-09 14:23:32,224 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] prop: {urn:ietf:params:xml:ns:caldav}calendar-data
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) REPORT: query
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <filter>
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <comp-filter name="VCALENDAR">
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <comp-filter name="VEVENT">
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <prop-filter name="UID">
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <text-match collation=i;ascii-casemap negate-condition=no>
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) 20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </text-match>
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </prop-filter>
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </comp-filter>
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </comp-filter>
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </filter>
2012-07-09 14:23:32,252 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) setStatus(207)
2012-07-09 14:23:32,253 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getWriter called
2012-07-09 14:23:32,253 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) resourceUri: /user/vbede/calendar/
2012-07-09 14:23:32,253 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] About to get node for /user/vbede/calendar/
2012-07-09 14:23:32,253 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] Normalized uri=/user/vbede/calendar
2012-07-09 14:23:32,253 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] search for collection uri "/user/vbede/calendar"
2012-07-09 14:23:32,254 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] create collection uri - cal="/user/vbede/calendar"
2012-07-09 14:23:32,254 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) REPORT: preq not null
2012-07-09 14:23:32,254 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) doNodeAndChildren: curDepth=0 maxDepth=1 uri=/user/vbede/calendar
2012-07-09 14:23:32,254 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) getNodes: /user/vbede/calendar
2012-07-09 14:23:32,254 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) getEvents for start=null end=null
2012-07-09 14:23:32,254 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev from org.bedework.calfacade.BwEventObj ev where ev.tombstoned=false and (((ev.entityType=:fq__0) and (lower(ev.uid) like :fq__1) and (ev.colPath=:fq__2)))
2012-07-09 14:23:32,255 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (0) Found 1 entries
2012-07-09 14:23:32,255 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev from org.bedework.calfacade.BwEventAnnotation ev where ev.tombstoned=false and (ev.override = false)
2012-07-09 14:23:32,255 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (1) Found 0 entries
2012-07-09 14:23:32,255 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev from org.bedework.calfacade.BwEventObj ev, org.bedework.calfacade.BwRecurrenceInstance inst where (inst.master = ev) and (((ev.entityType=:fq__0) and (lower(ev.uid) like :fq__1) and (ev.colPath=:fq__2)))
2012-07-09 14:23:32,256 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (4) Found 0 entries
2012-07-09 14:23:32,256 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev from org.bedework.calfacade.BwEventAnnotation ev where ev.tombstoned=false and (ev.override = true)
2012-07-09 14:23:32,256 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (2) Found 0 entries
2012-07-09 14:23:32,256 DEBUG [org.bedework.caldav.server.filter.FilterHandler] (http-0.0.0.0-8080-8) Query returned 1
2012-07-09 14:23:32,256 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] About to get node for /user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,256 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] Normalized uri=/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,257 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2368] do CalendarData for /user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,258 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,259 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_IN
2012-07-09 14:23:32,260 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.216
2012-07-09 14:23:32,260 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event ENTITY_FETCHED
2012-07-09 14:23:32,261 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ------------------------ Dump of response -------------------
2012-07-09 14:23:32,261 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) <?xml version="1.0" encoding="UTF-8" ?>
<DAV:multistatus xmlns:DAV="DAV:"
xmlns="urn:ietf:params:xml:ns:caldav"
xmlns:ical="http://www.w3.org/2002/12/cal/ical#">
<DAV:response>
<DAV:href>/ucaldav/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics</DAV:href>
<DAV:propstat>
<DAV:prop>
<DAV:getetag>"20120709T122331Z-1067"</DAV:getetag>
<calendar-data><![CDATA[BEGIN:VCALENDAR
PRODID://Bedework.org//BedeWork V3.8//EN
VERSION:2.0
BEGIN:VEVENT
CREATED:20120709T122331Z
DURATION:PT1H
DTSTAMP:20120709T122331Z
DTSTART:20120710T010000Z
LAST-MODIFIED:20120709T122331Z
SUMMARY:Ein neuer Termin
UID:20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
END:VEVENT
END:VCALENDAR
]]></calendar-data>
</DAV:prop>
<DAV:status>HTTP/1.1 200 ok</DAV:status>
</DAV:propstat>
</DAV:response>
</DAV:multistatus>
2012-07-09 14:23:32,261 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ---------------------- End dump of response -----------------
2012-07-09 14:23:32,261 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_OUT
2012-07-09 14:23:32,261 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentLength=922
2012-07-09 14:23:32,261 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-8) SESSION-END:2ED3AB22CC319E19D1CDF6B7293A524F:?:0:2368:231M:598M
2012-07-09 14:23:32,261 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-8) ========= Session destroyed(?): 0 active. vm(used, max)=(231M, 598M)
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) entry: PUT
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request headers
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) authorization = "Basic **********"
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) if-match = ""20120709T122331Z-1067""
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) user-agent = "Jakarta Commons-HttpClient/3.1"
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) host = "localhost:8080"
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) cookie = "$Version=0; JSESSIONID=2ED3AB22CC319E19D1CDF6B7293A524F; $Path=/ucaldav"
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-length = "354"
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-type = "text/calendar; charset=UTF-8"
2012-07-09 14:23:32,280 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters - global info and uris
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteAddr = 127.0.0.1
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestURI = /ucaldav/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteUser = vbede
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestedSessionId = 2ED3AB22CC319E19D1CDF6B7293A524F
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) HttpUtils.getRequestURL(req) = http://localhost:8080/ucaldav/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contextPath=/ucaldav
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) query=null
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentlen=354
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) request=org.apache.catalina.connector.RequestFacade@4526d044
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) parameters:
2012-07-09 14:23:32,281 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters
2012-07-09 14:23:32,281 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-8) SESSION-START:F1886758A33063ABD26A913FAA116CCF:?:1:2369:230M:598M
2012-07-09 14:23:32,281 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-8) ========= New session(?): 1 active, 2369 total. vm(used, max)=(230M, 598M)
2012-07-09 14:23:32,282 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for null
2012-07-09 14:23:32,282 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for null
2012-07-09 14:23:32,282 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for null
2012-07-09 14:23:32,282 DEBUG [org.bedework.calsvc.CalSvc] (http-0.0.0.0-8080-8) Authenticated user vbede logged on
2012-07-09 14:23:32,283 DEBUG [org.bedework.calsvc.directory.UserGroupsLdapImpl] (http-0.0.0.0-8080-8) Logged into LDAP server, javax.naming.ldap.InitialLdapContext@27ba0fde
2012-07-09 14:23:32,285 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,286 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,286 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,286 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_LOGIN
2012-07-09 14:23:32,286 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,286 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,289 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,290 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,290 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,290 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_SVCINIT
2012-07-09 14:23:32,290 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,291 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,291 DEBUG [edu.rpi.cct.webdav.servlet.common.PutMethod] (http-0.0.0.0-8080-8) PutMethod: doMethod
2012-07-09 14:23:32,291 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2369] About to get node for /user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,291 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2369] Normalized uri=/user/vbede/calendar/20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics
2012-07-09 14:23:32,292 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2369] find event(s) - cal="/user/vbede/calendar" name="20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics"
2012-07-09 14:23:32,293 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] BEGIN:VCALENDAR
2012-07-09 14:23:32,293 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] PRODID://Bedework.org//BedeWork V3.8//EN
2012-07-09 14:23:32,293 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] VERSION:2.0
2012-07-09 14:23:32,293 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] BEGIN:VEVENT
2012-07-09 14:23:32,293 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] DTSTART:20120710T010000Z
2012-07-09 14:23:32,293 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] DURATION:PT1H
2012-07-09 14:23:32,293 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] UID:20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
2012-07-09 14:23:32,293 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] SUMMARY:I changed the summary!
2012-07-09 14:23:32,293 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] ATTENDEE;PARTSTAT=ACCEPTED:mailto:te...@test.de
2012-07-09 14:23:32,294 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] DESCRIPTION:Termin geaendert
2012-07-09 14:23:32,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] DTSTAMP:20120709T122332Z
2012-07-09 14:23:32,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] END:VEVENT
2012-07-09 14:23:32,299 DEBUG [org.bedework.caldav.server.SysIntfReader] (http-0.0.0.0-8080-8) [715] END:VCALENDAR
2012-07-09 14:23:32,299 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-8) TRANS-TO_EVENT: try to fetch event with guid=20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede
2012-07-09 14:23:32,300 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-8) TRANS-TO_EVENT: fetched event with guid
2012-07-09 14:23:32,301 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index UNKNOWN_PROPERTY name null
2012-07-09 14:23:32,301 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index BUSYTYPE name BUSYTYPE
2012-07-09 14:23:32,301 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index COLLECTION name COLLECTION
2012-07-09 14:23:32,301 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index LANG name LANGUAGE
2012-07-09 14:23:32,301 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index XBEDEWORK_COST name X-BEDEWORK-COST
2012-07-09 14:23:32,301 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index CALSCALE name CALSCALE
2012-07-09 14:23:32,301 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index METHOD name METHOD
2012-07-09 14:23:32,301 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index PRODID name PRODID
2012-07-09 14:23:32,301 WARN [org.bedework.calfacade.util.ChangeTable] (http-0.0.0.0-8080-8) No entry for index VERSION name VERSION
2012-07-09 14:23:32,302 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-8) ChangeTable{
SUMMARY: changed
DESCRIPTION: changed
DTSTAMP
UID
ATTENDEE: changed
DTSTART
DURATION}
2012-07-09 14:23:32,303 DEBUG [org.bedework.icalendar.IcalUtil] (http-0.0.0.0-8080-8) BwEvent{id=3505, owner=/principals/users/vbede, publick=false,
creator=/principals/users/vbede, access=null, collection=/user/vbede/calendar,
entityType=0, deleted=false,
dtstamp=20120709T122332Z,
dtstart=BwDateTime{DATETIME, dtval=20120710T010000Z, UTC},
dtend=BwDateTime{DATETIME, dtval=20120710T020000Z, UTC},
status=null,
lastmod=20120709T122331Z, created=20120709T122331Z, stag=null,
priority=null, classification=null,
uid=20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede,
name=20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics,
ctoken=20120709T122331Z-1067
, getRecurring=false,
organizer=null,
summary={BwString{id=-1, lang=null, value=I changed the summary!},
description={BwLongString{id=-1, lang=null, value=Termin geaendert},
attendee=BwAttendee{id=-1, cn=null, cuType=null, delegatedFrom=null, delegatedTo=null,
dir=null, language=null, member=null, rsvp=false,
role=null, partstat=ACCEPTED, sentBy=null, attendeeUri=mailto:test@test.de,
sequence=0, dtstamp=null,
scheduleAgent=0, scheduleStatus=null},
sequence=0, scheduleMethod=0,
originator=null, scheduleState=0}
2012-07-09 14:23:32,303 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2369] putContent: intf has event with name 20120709T142331-4ebff3ea-b5c6-4479-9a7c-0a7a270f6052-vbede.ics and summary I changed the summary! new event = false
2012-07-09 14:23:32,303 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2369] putContent: etag mismatch if="20120709T122331Z-1067"prev="20120709T122331Z-0"
2012-07-09 14:23:32,303 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Enter rollback
2012-07-09 14:23:32,303 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) About to rollback
2012-07-09 14:23:32,303 ERROR [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) org.bedework.caldav.server.CaldavBWIntf@9ada14
edu.rpi.cct.webdav.servlet.shared.WebdavException
at org.bedework.caldav.server.CaldavBWIntf.putEvent(CaldavBWIntf.java:896)
at org.bedework.caldav.server.CaldavBWIntf.putContent(CaldavBWIntf.java:760)
at edu.rpi.cct.webdav.servlet.shared.WebdavNsIntf.putContent(WebdavNsIntf.java:680)
at edu.rpi.cct.webdav.servlet.common.PutMethod.doMethod(PutMethod.java:57)
at edu.rpi.cct.webdav.servlet.common.WebdavServlet.service(WebdavServlet.java:149)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at org.jboss.web.tomcat.filters.ReplyHeaderFilter.doFilter(ReplyHeaderFilter.java:96)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:235)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:235)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
at org.jboss.web.tomcat.security.SecurityAssociationValve.invoke(SecurityAssociationValve.java:190)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:525)
at org.jboss.web.tomcat.security.JaccContextValve.invoke(JaccContextValve.java:92)
at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.process(SecurityContextEstablishmentValve.java:126)
at org.jboss.web.tomcat.security.SecurityContextEstablishmentValve.invoke(SecurityContextEstablishmentValve.java:70)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
at org.jboss.web.tomcat.service.jca.CachedConnectionValve.invoke(CachedConnectionValve.java:158)
at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:567)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:330)
at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:829)
at org.apache.coyote.http11.Http11Protocol$Http11ConnectionHandler.process(Http11Protocol.java:598)
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:447)
at java.lang.Thread.run(Thread.java:662)
2012-07-09 14:23:32,304 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Enter rollback
2012-07-09 14:23:32,304 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) setStatus(412) message=null
2012-07-09 14:23:32,304 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,304 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.284
2012-07-09 14:23:32,304 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ------------------------ Dump of response -------------------
2012-07-09 14:23:32,304 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8)
2012-07-09 14:23:32,304 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ---------------------- End dump of response -----------------
2012-07-09 14:23:32,304 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentLength=0
2012-07-09 14:23:32,304 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-8) SESSION-END:F1886758A33063ABD26A913FAA116CCF:?:0:2369:229M:598M
2012-07-09 14:23:32,304 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-8) ========= Session destroyed(?): 0 active. vm(used, max)=(229M, 598M)
2012-07-09 14:23:32,327 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) entry: REPORT
2012-07-09 14:23:32,327 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request headers
2012-07-09 14:23:32,327 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) authorization = "Basic **********"
2012-07-09 14:23:32,327 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) user-agent = "Jakarta Commons-HttpClient/3.1"
2012-07-09 14:23:32,327 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) host = "localhost:8080"
2012-07-09 14:23:32,327 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) cookie = "$Version=0; JSESSIONID=F1886758A33063ABD26A913FAA116CCF; $Path=/ucaldav"
2012-07-09 14:23:32,327 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-length = "715"
2012-07-09 14:23:32,327 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) depth = "1"
2012-07-09 14:23:32,327 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) content-type = "text/xml"
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters - global info and uris
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteAddr = 127.0.0.1
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestURI = /ucaldav/user/vbede/calendar/
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRemoteUser = vbede
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getRequestedSessionId = F1886758A33063ABD26A913FAA116CCF
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) HttpUtils.getRequestURL(req) = http://localhost:8080/ucaldav/user/vbede/calendar/
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contextPath=/ucaldav
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) query=null
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentlen=715
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) request=org.apache.catalina.connector.RequestFacade@4526d044
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) parameters:
2012-07-09 14:23:32,328 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) Request parameters
2012-07-09 14:23:32,328 INFO [edu.rpi.sss.util.jsp.SessionListener] (http-0.0.0.0-8080-8) SESSION-START:A206117587CCC8AB66326AC439B7A194:?:1:2370:229M:598M
2012-07-09 14:23:32,328 INFO [org.apache.catalina.core.ContainerBase.[jboss.web].[localhost].[/ucaldav]] (http-0.0.0.0-8080-8) ========= New session(?): 1 active, 2370 total. vm(used, max)=(229M, 598M)
2012-07-09 14:23:32,328 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for null
2012-07-09 14:23:32,328 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for null
2012-07-09 14:23:32,329 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for null
2012-07-09 14:23:32,329 DEBUG [org.bedework.calsvc.CalSvc] (http-0.0.0.0-8080-8) Authenticated user vbede logged on
2012-07-09 14:23:32,332 DEBUG [org.bedework.calsvc.directory.UserGroupsLdapImpl] (http-0.0.0.0-8080-8) Logged into LDAP server, javax.naming.ldap.InitialLdapContext@1b5ca52f
2012-07-09 14:23:32,334 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,335 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,335 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,335 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,335 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,335 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_LOGIN
2012-07-09 14:23:32,338 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,339 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,339 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) New hibernate session for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,339 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event USER_SVCINIT
2012-07-09 14:23:32,339 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Open session for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,339 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Begin transaction for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,339 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) No charset specified in request; forced to UTF-8
2012-07-09 14:23:32,339 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) ReportMethod: doMethod
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2370] <?xml version="1.0"?>
<C:calendar-query xmlns:C="urn:ietf:params:xml:ns:caldav">
<D:prop xmlns:D="DAV:">
<D:getetag/>
<C:calendar-data>
<C:comp name="VCALENDAR">
<C:comp name="VEVENT">
<C:prop name="UID"/>
</C:comp>
</C:comp>
</C:calendar-data>
</D:prop>
<C:filter>
<C:comp-filter name="VCALENDAR">
<C:comp-filter name="VEVENT">
<C:prop-filter name="DTSTAMP">
<C:time-range end="20120701T000000Z" start="20120710T010000Z"/>
</C:prop-filter>
</C:comp-filter>
</C:comp-filter>
</C:filter>
</C:calendar-query>
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) ReportMethod: depth=1
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2370] prop: {DAV:}getetag
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) calendar-data node type: 1 name:C:comp
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) comp node type: 1 name:C:comp
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) comp node type: 1 name:C:prop
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) <calendar-data content-type="text/calendar">
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) <comp name=VCALENDAR>
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) <comp name=VEVENT>
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) <calddav:prop name=UID novalue=no/>
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) </comp>
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) </comp>
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.calquery.CalData] (http-0.0.0.0-8080-8) </calendar-data>
2012-07-09 14:23:32,341 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2370] prop: {urn:ietf:params:xml:ns:caldav}calendar-data
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) REPORT: query
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <filter>
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <comp-filter name="VCALENDAR">
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <comp-filter name="VEVENT">
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <prop-filter name="DTSTAMP">
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) <time-range start=20120710T010000Z end=20120701T000000Z/>
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </prop-filter>
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </comp-filter>
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </comp-filter>
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) </filter>
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) setStatus(207)
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) getWriter called
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) resourceUri: /user/vbede/calendar/
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2370] About to get node for /user/vbede/calendar/
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2370] Normalized uri=/user/vbede/calendar
2012-07-09 14:23:32,370 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2370] search for collection uri "/user/vbede/calendar"
2012-07-09 14:23:32,372 DEBUG [org.bedework.caldav.server.CaldavBWIntf] (http-0.0.0.0-8080-8) [2370] create collection uri - cal="/user/vbede/calendar"
2012-07-09 14:23:32,373 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) REPORT: preq not null
2012-07-09 14:23:32,373 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) doNodeAndChildren: curDepth=0 maxDepth=1 uri=/user/vbede/calendar
2012-07-09 14:23:32,373 DEBUG [org.bedework.caldav.server.CaldavReportMethod] (http-0.0.0.0-8080-8) getNodes: /user/vbede/calendar
2012-07-09 14:23:32,373 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) getEvents for start=null end=null
2012-07-09 14:23:32,373 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev.lastmod, ev.uid, ev.access, ev.colPath, ev.created, ev.creatorHref, ev.dtend, ev.dtstamp, ev.dtstart, ev.duration, ev.endType, ev.entityType, ev.id, ev.name, ev.noStart, ev.ownerHref from org.bedework.calfacade.BwEventObj ev where ev.tombstoned=false and (((ev.entityType=:fq__0) and ((ev.dtstamp>=:fq__1) and (ev.dtstamp<:fq__2)) and (ev.colPath=:fq__3)))
2012-07-09 14:23:32,386 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (0) Found 0 entries
2012-07-09 14:23:32,386 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev.lastmod, ev.uid, ev.access, ev.colPath, ev.created, ev.creatorHref, ev.dtend, ev.dtstamp, ev.dtstart, ev.duration, ev.endType, ev.entityType, ev.id, ev.name, ev.noStart, ev.ownerHref, ev.override, ev.target, ev.master from org.bedework.calfacade.BwEventAnnotation ev where ev.tombstoned=false and (ev.override = false)
2012-07-09 14:23:32,398 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (1) Found 0 entries
2012-07-09 14:23:32,398 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev.lastmod, ev.uid, ev.access, ev.colPath, ev.created, ev.creatorHref, ev.dtend, ev.dtstamp, ev.dtstart, ev.duration, ev.endType, ev.entityType, ev.id, ev.name, ev.noStart, ev.ownerHref from org.bedework.calfacade.BwEventObj ev, org.bedework.calfacade.BwRecurrenceInstance inst where (inst.master = ev) and (((ev.entityType=:fq__0) and ((ev.dtstamp>=:fq__1) and (ev.dtstamp<:fq__2)) and (ev.colPath=:fq__3)))
2012-07-09 14:23:32,410 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (4) Found 0 entries
2012-07-09 14:23:32,411 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) select distinct ev from org.bedework.calfacade.BwEventAnnotation ev where ev.tombstoned=false and (ev.override = true)
2012-07-09 14:23:32,411 DEBUG [org.bedework.calcore.hibernate.CoreEvents] (http-0.0.0.0-8080-8) Getting (2) Found 0 entries
2012-07-09 14:23:32,411 DEBUG [org.bedework.caldav.server.filter.FilterHandler] (http-0.0.0.0-8080-8) Query returned 0
2012-07-09 14:23:32,411 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) End transaction for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,413 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_IN
2012-07-09 14:23:32,413 DEBUG [org.bedework.calcore.hibernate.CalintfImpl] (http-0.0.0.0-8080-8) Close for 2012-07-09 14:23:32.333
2012-07-09 14:23:32,413 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event ENTITY_FETCHED
2012-07-09 14:23:32,414 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ------------------------ Dump of response -------------------
2012-07-09 14:23:32,414 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) <?xml version="1.0" encoding="UTF-8" ?>
<DAV:multistatus xmlns:DAV="DAV:"
xmlns="urn:ietf:params:xml:ns:caldav"
xmlns:ical="http://www.w3.org/2002/12/cal/ical#">
</DAV:multistatus>
2012-07-09 14:23:32,414 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) ---------------------- End dump of response -----------------
2012-07-09 14:23:32,414 DEBUG [org.bedework.caldav.server.CaldavBWServlet] (http-0.0.0.0-8080-8) contentLength=210
2012-07-09 14:23:32,414 DEBUG [org.bedework.indexer.MessageProcessor] (org.bedework:service=Indexer) Event CALDAV_OUT
When i run the Unit tests i became this errors:
Results :
Failed tests:
testGetCalendarByPath(org.osaf.caldav4j.CalDAVCalendarCollectionWithCacheTest)
testGetEventResources(org.osaf.caldav4j.CalDAVCalendarCollectionWithCacheTest): expected:<0> but was:<1>
testGetEventResources(org.osaf.caldav4j.CalDAVCollectionTest): expected:<3> but was:<0>
testGetEventResourcesFloatingIssues(org.osaf.caldav4j.CalDAVCollectionTest)
queryPartialCalendar(org.osaf.caldav4j.CalDAVCollectionTest): bad number of responses: expected:<3> but was:<1>
testAddRemoveCalendarResource(org.osaf.caldav4j.google.methods.GooglePutGetTest): Response status expected:<201> but was:<405>
Tests in error:
testUpdateEvent(org.osaf.caldav4j.CalDAVCalendarCollectionTest): Problem executing put method
testUpdateEvent(org.osaf.caldav4j.CalDAVCalendarCollectionWithCacheTest): Problem executing put method
testGetOptions(org.osaf.caldav4j.CalDAVCollectionAceTest)
testUpdateEvent(org.osaf.caldav4j.CalDAVCollectionTest): Problem executing put method
can anyone help me what is wrong?
Thanks Regards