6.0.0-beta13
▾
Tasks
New Task
Search
Photos
Wiki
▾
Tickets
New Ticket
Search
dev.horde.org
Toggle Alerts Log
Help
4/11/26
H
istory
A
ttachments
C
omment
W
atch
Download
Comment on [#12595] AS: Message delete + add leads to broken XML stream
*
Your Email Address
*
Spam protection
Enter the letters below:
__ . .__ __ __. / `| | \/ `(__ \__.|___|__/\__..__)
Comment
> Hi, > > when I delete a message and add a new one at the same time > (needed to trigger a "ping" response on an IMAP server > without CONDSTORE / modseq), the ActiveSync XML stream is broken. > Here's the output enriched with some custom loggers: > > -------------------------------------------------------------- > 2013-08-21T16:16:44+02:00 INFO: [2977] Found 2 message changes in 4eaa9b8f. > 2013-08-21T16:16:44+02:00 INFO: [2977] No PIM changes present, > returning all messages. > 2013-08-21T16:16:44+02:00 INFO: Old SYNCKEY: > {52149b50-8680-4b35-a0db-0466ac100163}61, New SYNCKEY: > {52149b50-8680-4b35-a0db-0466ac100163}62 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <Folders> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <Folder> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <SyncKey> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O > {52149b50-8680-4b35-a0db-0466ac100163}62 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </SyncKey> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <FolderId> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 4eaa9b8f > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </FolderId> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <Status> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 1 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </Status> > 2013-08-21T16:16:44+02:00 INFO: [2977] > Horde_Core_ActiveSync_Driver::getMessage(INBOX, 186885) > 2013-08-21T16:16:44+02:00 INFO: Sending PLAINTEXT Message. > 2013-08-21T16:16:44+02:00 INFO: Validating UTF-8 data coming from iso-8859-1 > 2013-08-21T16:16:44+02:00 INFO: FETCHING VERB > 2013-08-21T16:16:44+02:00 INFO: RETURNING VERB > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <Commands> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <Add> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <ServerEntryId> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 186885 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </ServerEntryId> > 2013-08-21T16:16:44+02:00 ERR: TOMJ: wrote end tag for > messageChange() SERVERENTRYID > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <Data> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:To> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O xxxxxx > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:To> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:From> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O xxxxxxxxxxxxxxxxx > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:From> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:Subject> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O sync #11 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:Subject> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:ThreadTopic> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O sync #11 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:ThreadTopic> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:DateReceived> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 2013-08-21T14:16:29.000Z > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:DateReceived> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:DisplayTo> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O xxxxxx > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:DisplayTo> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:Importance> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 1 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:Importance> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:Read> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 0 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:Read> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:MessageClass> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O IPM.Note > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:MessageClass> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:Reply-To> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O xxxxxx > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:Reply-To> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:InternetCPID> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 65001 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:InternetCPID> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <AirSyncBase:NativeBodyType> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 1 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O > </AirSyncBase:NativeBodyType> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <AirSyncBase:Body> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <AirSyncBase:Type> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 1 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </AirSyncBase:Type> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O > <AirSyncBase:EstimatedDataSize> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 372 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O > </AirSyncBase:EstimatedDataSize> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <AirSyncBase:Data> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O > > xxxx > > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </AirSyncBase:Data> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </AirSyncBase:Body> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:Flag/> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:ContentClass> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O urn:content-classes:message > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </POOMMAIL:ContentClass> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <POOMMAIL:Categories/> > 2013-08-21T16:16:44+02:00 ERR: TOMJ: wrote end tag for > messageChange() SYNC_DATA > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </Data> > 2013-08-21T16:16:44+02:00 ERR: TOMJ: wrote end tag for messageChange() > 2013-08-21T16:16:44+02:00 INFO: [2977] Updating state during change > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <Remove> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O <ServerEntryId> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O 186884 > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </ServerEntryId> > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </Remove> > 2013-08-21T16:16:44+02:00 ERR: TOMJ: wrote end tag for messageDeletion() > 2013-08-21T16:16:44+02:00 INFO: [2977] Updating state during delete > 2013-08-21T16:16:44+02:00 DEBUG: [2977] O </Add> > 2013-08-21T16:16:44+02:00 ERR: TOMJ: wrote end tag for SYNC_COMMANDS > -------------------------------------------------------------- > > -> The "<Remove>" command is inside the "<Add>" tag. This is wrong. > The XML stream is missing an end tag somewhere. When I comment out this > line in Message/Base.php::encodeStream() > > $encoder->startTag($tag, null, true); > > the XML output is fine again. So it looks like the wbxml output > of empty tags is somehow not working correctly. > > Thomas >
Attachment
Watch this ticket
N
ew Ticket
M
y Tickets
S
earch
Q
uery Builder
R
eports
Saved Queries
Open Bugs
Bugs waiting for Feedback
Open Bugs in Releases
Open Enhancements
Enhancements waiting for Feedback
Bugs with Patches
Enhancements with Patches
Release Showstoppers
Stalled Tickets
New Tickets
Horde 5 Showstoppers