Hello,

> was not replying to the list intentional or may I copy the list again?
No that was not intentional. Sorry about that.


> I tried getting a trace using 1.3.99.4 however the thread did not
> crash when having a Timetout of one minute set.
I guess this is off the table for now as I also tried commenting out
the RetryDuration - still no crash with the newest version. Maybe it
was a bug in 1.3.99.3 that was already fixed?


> > [DEBUG] syncevo-http: processing incoming message of type
> > application/vnd.syncml+wbxml and length 411, binary data
> > [ERROR] sync: /org/syncevolution/Session/5101776841374092036: error code
> > from SyncEvolution data merged (remote, status 207): updateAllSubItems
> > REPORT 'multiget new/updated items': Neon error code 1: Could not parse
> > response: XML parse error at line 52675: PCDATA invalid Char value 1

> > In the log I can see:
> > [2013-07-17 22:43:23.951] stderr: XML: Parsing 8000 bytes.

> What is before that? There should be some output from Neon starting with
> a REPORT as HTTP operation and a request body like this:
>         "<?xml version=\"1.0\" encoding=\"utf-8\" ?>\n"
>         "<C:calendar-query xmlns:D=\"DAV:\"\n"
>         "xmlns:C=\"urn:ietf:params:xml:ns:caldav\">\n"
>         "<D:prop>\n"
>         "<D:getetag/>\n"
>         "</D:prop>\n"
>         // filter expected by Yahoo! Calendar
>         "<C:filter>\n"
>         "<C:comp-filter name=\"VCALENDAR\">\n"
>         "<C:comp-filter name=\"VEVENT\">\n"
>         "</C:comp-filter>\n"
>         "</C:comp-filter>\n"
>         "</C:filter>\n"
>         "</C:calendar-query>\n";

> The response to that should also be logged. It is then getting
> parsed as XML, which fails.
I did try this in the log directory:
for i in *.xml
do
  xmllint $i >/dev/null
  echo $?
done

That reported success for every xml file that is in the directory.
Now I looked into the logfile again and I also found these:
[2013-07-17 22:41:45.372] Warning: More than 3 consecutive Alert 222 - looks 
like endless loop, check if we need to work around client implementation 
issues
[2013-07-17 22:41:45.372] Alert: command finished execution -> deleting
actually I feel this log is rather interesting. If you like, I can place
it online.

I looked a little further into the logfile and found this:

[2013-07-17 22:43:23.905] stderr: Header Name: [transfer-encoding], Value: 
[chunked]
[2013-07-17 22:43:23.905] stderr: [hdr] Content-Type: application/xml; 
charset=utf-8
[2013-07-17 22:43:23.905] stderr: Header Name: [content-type], Value: 
[application/xml; charset=utf-8]
[2013-07-17 22:43:23.906] stderr: [hdr]
[2013-07-17 22:43:23.906] stderr: End of headers.
[2013-07-17 22:43:23.906] stderr: Running post_headers hooks
[2013-07-17 22:43:23.906] stderr: [chunk] < 2a7581
[2013-07-17 22:43:23.906] stderr: Got chunk size: 2782593
[2013-07-17 22:43:23.906] stderr: Reading 8000 bytes of response body.
[2013-07-17 22:43:23.912] stderr: Got 8000 bytes.
[2013-07-17 22:43:23.914] stderr: Read block (8000 bytes):
[<?xml version="1.0" encoding="utf-8"?>
<d:multistatus xmlns:d="DAV:" xmlns:s="http://sabredav.org/ns"; 
xmlns:cal="urn:ietf:params:xml:ns:caldav" 
xmlns:cs="http://calendarserver.org/ns/";><d:response><d:href>/owncloud/apps/calendar/caldav.php/calendars/christof/defaultcalendar/01102012130248332750-0.ics</d:href><d:propstat><d:prop><cal:calendar-data>BEGIN:VCALENDAR
VERSION:2.0
PRODID:-//Synthesis AG//NONSGML SyncML Engine V3.4.0.45//EN
BEGIN:VEVENT
STATUS:CONFIRMED
LAST-MODIFIED:20121001T130248Z
DTSTAMP:20121001T130248Z
UID:01102012130248332750-0
SEQUENCE:0
CLASS:PUBLIC
PRIORITY:0
SUMMARY:DR\\, AAA AAAAA
DTSTART:20121001T120000Z
DTEND:20121001T170000Z
BEGIN:VALARM
TRIGGER;VALUE=DURATION:-PT10M
ACTION:DISPLAY
DESCRIPTION:z:systemSystemSoundsalarm.wav
END:VALARM
END:VEVENT
END:VCALENDAR

SNIP
I did cut out quite a bit until the end of this chunk.


</cal:calendar-
data><d:getetag>"64585e1c80459c9ccc4163a5190b2f16"</d:getetag></d:prop><d:status>HTTP/1.1
 
200 
OK</d:status></d:propstat></d:response><d:response><d:href>/owncloud/apps/calendar/caldav.php/calendars/christof/defaultcalendar/01112012134617286750-0.ics</d:href><d:propstat><d:prop><cal:calendar-
data>BEGIN:VCALENDAR
VER]
[2013-07-17 22:43:23.920] stderr: XML: Parsing 8000 bytes.
[2013-07-17 22:43:23.920] stderr: XML: start-element (0, {DAV:, multistatus}) 
=> 1
[2013-07-17 22:43:23.921] stderr: XML: start-element (1, {DAV:, response}) => 
1
[2013-07-17 22:43:23.921] stderr: XML: start-element (1, {DAV:, href}) => 1
[2013-07-17 22:43:23.921] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.921] stderr: XML: end-element (1, {DAV:, href})
[2013-07-17 22:43:23.921] stderr: XML: start-element (1, {DAV:, propstat}) => 
1
[2013-07-17 22:43:23.921] stderr: XML: start-element (1, {DAV:, prop}) => 1
[2013-07-17 22:43:23.922] stderr: XML: start-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data}) => 1
[2013-07-17 22:43:23.922] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.922] stderr: XML: end-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data})
[2013-07-17 22:43:23.922] stderr: XML: start-element (1, {DAV:, getetag}) => 1
[2013-07-17 22:43:23.923] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.923] stderr: XML: end-element (1, {DAV:, getetag})
[2013-07-17 22:43:23.923] stderr: XML: end-element (1, {DAV:, prop})
[2013-07-17 22:43:23.923] stderr: XML: start-element (1, {DAV:, status}) => 1
[2013-07-17 22:43:23.923] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.923] stderr: XML: end-element (1, {DAV:, status})
[2013-07-17 22:43:23.924] stderr: XML: end-element (1, {DAV:, propstat})
[2013-07-17 22:43:23.924] stderr: XML: end-element (1, {DAV:, response})
[2013-07-17 22:43:23.924] stderr: XML: start-element (1, {DAV:, response}) => 
1
[2013-07-17 22:43:23.924] stderr: XML: start-element (1, {DAV:, href}) => 1
[2013-07-17 22:43:23.924] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.924] stderr: XML: end-element (1, {DAV:, href})
[2013-07-17 22:43:23.925] stderr: XML: start-element (1, {DAV:, propstat}) => 
1
[2013-07-17 22:43:23.925] stderr: XML: start-element (1, {DAV:, prop}) => 1
[2013-07-17 22:43:23.925] stderr: XML: start-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data}) => 1
[2013-07-17 22:43:23.925] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.925] stderr: XML: end-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data})
[2013-07-17 22:43:23.926] stderr: XML: start-element (1, {DAV:, getetag}) => 1
[2013-07-17 22:43:23.926] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.926] stderr: XML: end-element (1, {DAV:, getetag})
[2013-07-17 22:43:23.926] stderr: XML: end-element (1, {DAV:, prop})
[2013-07-17 22:43:23.926] stderr: XML: start-element (1, {DAV:, status}) => 1
[2013-07-17 22:43:23.926] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.927] stderr: XML: end-element (1, {DAV:, status})
[2013-07-17 22:43:23.927] stderr: XML: end-element (1, {DAV:, propstat})
[2013-07-17 22:43:23.927] stderr: XML: end-element (1, {DAV:, response})
[2013-07-17 22:43:23.927] stderr: XML: start-element (1, {DAV:, response}) => 
1
[2013-07-17 22:43:23.927] stderr: XML: start-element (1, {DAV:, href}) => 1
[2013-07-17 22:43:23.927] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.928] stderr: XML: end-element (1, {DAV:, href})
[2013-07-17 22:43:23.928] stderr: XML: start-element (1, {DAV:, propstat}) => 
1
[2013-07-17 22:43:23.928] stderr: XML: start-element (1, {DAV:, prop}) => 1
[2013-07-17 22:43:23.928] stderr: XML: start-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data}) => 1
[2013-07-17 22:43:23.929] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.929] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.929] stderr: XML: end-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data})
[2013-07-17 22:43:23.929] stderr: XML: start-element (1, {DAV:, getetag}) => 1
[2013-07-17 22:43:23.929] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.930] stderr: XML: end-element (1, {DAV:, getetag})
[2013-07-17 22:43:23.930] stderr: XML: end-element (1, {DAV:, prop})
[2013-07-17 22:43:23.930] stderr: XML: start-element (1, {DAV:, status}) => 1
[2013-07-17 22:43:23.930] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.931] stderr: XML: end-element (1, {DAV:, status})
[2013-07-17 22:43:23.931] stderr: XML: end-element (1, {DAV:, propstat})
[2013-07-17 22:43:23.931] stderr: XML: end-element (1, {DAV:, response})
[2013-07-17 22:43:23.931] stderr: XML: start-element (1, {DAV:, response}) => 
1
[2013-07-17 22:43:23.931] stderr: XML: start-element (1, {DAV:, href}) => 1
[2013-07-17 22:43:23.931] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.932] stderr: XML: end-element (1, {DAV:, href})
[2013-07-17 22:43:23.932] stderr: XML: start-element (1, {DAV:, propstat}) => 
1
[2013-07-17 22:43:23.932] stderr: XML: start-element (1, {DAV:, prop}) => 1
[2013-07-17 22:43:23.932] stderr: XML: start-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data}) => 1
[2013-07-17 22:43:23.932] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.932] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.932] stderr: XML: end-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data})
[2013-07-17 22:43:23.933] stderr: XML: start-element (1, {DAV:, getetag}) => 1
[2013-07-17 22:43:23.933] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.933] stderr: XML: end-element (1, {DAV:, getetag})
[2013-07-17 22:43:23.933] stderr: XML: end-element (1, {DAV:, prop})
[2013-07-17 22:43:23.933] stderr: XML: start-element (1, {DAV:, status}) => 1
[2013-07-17 22:43:23.933] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.934] stderr: XML: end-element (1, {DAV:, status})
[2013-07-17 22:43:23.934] stderr: XML: end-element (1, {DAV:, propstat})
[2013-07-17 22:43:23.934] stderr: XML: end-element (1, {DAV:, response})
[2013-07-17 22:43:23.934] stderr: XML: start-element (1, {DAV:, response}) => 
1
[2013-07-17 22:43:23.934] stderr: XML: start-element (1, {DAV:, href}) => 1
[2013-07-17 22:43:23.934] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.935] stderr: XML: end-element (1, {DAV:, href})
[2013-07-17 22:43:23.935] stderr: XML: start-element (1, {DAV:, propstat}) => 
1
[2013-07-17 22:43:23.935] stderr: XML: start-element (1, {DAV:, prop}) => 1
[2013-07-17 22:43:23.935] stderr: XML: start-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data}) => 1
[2013-07-17 22:43:23.935] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.935] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.936] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.936] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.936] stderr: XML: end-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data})
[2013-07-17 22:43:23.936] stderr: XML: start-element (1, {DAV:, getetag}) => 1
[2013-07-17 22:43:23.936] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.936] stderr: XML: end-element (1, {DAV:, getetag})
[2013-07-17 22:43:23.937] stderr: XML: end-element (1, {DAV:, prop})
[2013-07-17 22:43:23.937] stderr: XML: start-element (1, {DAV:, status}) => 1
[2013-07-17 22:43:23.937] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.937] stderr: XML: end-element (1, {DAV:, status})
[2013-07-17 22:43:23.937] stderr: XML: end-element (1, {DAV:, propstat})
[2013-07-17 22:43:23.937] stderr: XML: end-element (1, {DAV:, response})
[2013-07-17 22:43:23.938] stderr: XML: start-element (1, {DAV:, response}) => 
1
[2013-07-17 22:43:23.938] stderr: XML: start-element (1, {DAV:, href}) => 1
[2013-07-17 22:43:23.938] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.938] stderr: XML: end-element (1, {DAV:, href})
[2013-07-17 22:43:23.938] stderr: XML: start-element (1, {DAV:, propstat}) => 
1
[2013-07-17 22:43:23.938] stderr: XML: start-element (1, {DAV:, prop}) => 1
[2013-07-17 22:43:23.939] stderr: XML: start-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data}) => 1
[2013-07-17 22:43:23.939] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.939] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.939] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.939] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.939] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.940] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.940] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.940] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.940] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.940] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.940] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.940] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.941] stderr: XML: end-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data})
[2013-07-17 22:43:23.941] stderr: XML: start-element (1, {DAV:, getetag}) => 1
[2013-07-17 22:43:23.941] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.941] stderr: XML: end-element (1, {DAV:, getetag})
[2013-07-17 22:43:23.941] stderr: XML: end-element (1, {DAV:, prop})
[2013-07-17 22:43:23.941] stderr: XML: start-element (1, {DAV:, status}) => 1
[2013-07-17 22:43:23.942] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.942] stderr: XML: end-element (1, {DAV:, status})
[2013-07-17 22:43:23.942] stderr: XML: end-element (1, {DAV:, propstat})
[2013-07-17 22:43:23.942] stderr: XML: end-element (1, {DAV:, response})
[2013-07-17 22:43:23.942] stderr: XML: start-element (1, {DAV:, response}) => 
1
[2013-07-17 22:43:23.942] stderr: XML: start-element (1, {DAV:, href}) => 1
[2013-07-17 22:43:23.943] stderr: XML: char-data (1) returns 0
[2013-07-17 22:43:23.943] stderr: XML: end-element (1, {DAV:, href})
[2013-07-17 22:43:23.943] stderr: XML: start-element (1, {DAV:, propstat}) => 
1
[2013-07-17 22:43:23.943] stderr: XML: start-element (1, {DAV:, prop}) => 1
[2013-07-17 22:43:23.943] stderr: XML: start-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data}) => 1
[2013-07-17 22:43:23.943] stderr: XML: xmlParseChunk returned 0
[2013-07-17 22:43:23.944] stderr: Reading 8000 bytes of response body.
[2013-07-17 22:43:23.944] stderr: Got 8000 bytes.
[2013-07-17 22:43:23.945] stderr: Read block (8000 bytes): 
......
t-element (1, {DAV:, propstat}) => 1
[2013-07-17 22:43:23.943] stderr: XML: start-element (1, {DAV:, prop}) => 1
[2013-07-17 22:43:23.943] stderr: XML: start-element (1, 
{urn:ietf:params:xml:ns:caldav, calendar-data}) => 1
[2013-07-17 22:43:23.943] stderr: XML: xmlParseChunk returned 0
[2013-07-17 22:43:23.944] stderr: Reading 8000 bytes of response body.
[2013-07-17 22:43:23.944] stderr: Got 8000 bytes.
[2013-07-17 22:43:23.945] stderr: Read block (8000 bytes):
[SION:2.0
PRODID:-//Synthesis AG//NONSGML SyncML Engine V3.4.0.45//EN
BEGIN:VEVENT
LAST-MODIFIED:20121105T110647Z
DTSTAMP:20121105T110647Z
UID:01112012134617286750-0
SEQUENCE:0
CLASS:PUBLIC
PRIORITY:0
SUMMARY:Abschiedsfeier 

apparently the chunking cuts off events at fixed byte offsets - in this
case between VER an SION so I would doubt that each chunkg is ever a
valid xml on large syncs where multiple chunks are needed.

Christof

-- 
()  ascii ribbon campaign - against html e-mail
/\  www.asciiribbon.org   - against proprietary attachments

Attachment: signature.asc
Description: This is a digitally signed message part.

_______________________________________________
SyncEvolution mailing list
[email protected]
https://lists.syncevolution.org/mailman/listinfo/syncevolution

Reply via email to