[Tickets #12370] Re: Error 500 in communicating with ActiveSync server
noreply at bugs.horde.org
noreply at bugs.horde.org
Tue Jun 25 17:21:30 UTC 2013
DO NOT REPLY TO THIS MESSAGE. THIS EMAIL ADDRESS IS NOT MONITORED.
Ticket URL: http://bugs.horde.org/ticket/12370
------------------------------------------------------------------------------
Ticket | 12370
Updated By | software-horde at interfasys.ch
Summary | Error 500 in communicating with ActiveSync server
Queue | Synchronization
Version | Git master
Type | Bug
State | Feedback
Priority | 1. Low
Milestone |
Patch |
Owners |
------------------------------------------------------------------------------
software-horde at interfasys.ch (2013-06-25 17:21) wrote:
> The 500 response is probably due to the device still requesting the
> state that is no longer available on the server (since you say it's
> not listed as a device in Horde). This is supposed to trigger the
> device to initiate a new sync pairing with the server. Without a
> sync log, I can't tell you much more than this.
>
> DId you try re-creating the account on the client?
>
I've just checked the logs and it's still there.
So I had a look at the log and found an unmatched end tag error:
2013-06-25T19:08:29+02:00 DEBUG: [3478] SYNC request received for user
user at domain.com
2013-06-25T19:08:29+02:00 INFO: [3478] Device entry exists for
BB24XOXOX, updating userAgent and version.
2013-06-25T19:08:29+02:00 INFO: [3478] Request being handled for
device: BB24XOXO Supporting protocol version: 14.1
2013-06-25T19:08:29+02:00 INFO: [3478] Handling SYNC command.
2013-06-25T19:08:29+02:00 INFO: [3478] Checking policykey for device:
BB24XOXO user: user at domain.com
2013-06-25T19:08:29+02:00 INFO: [3478] Policykey: 0 verified.
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <Synchronize>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <Folders>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <Folder>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <SyncKey>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I
{51af577d-396c-4be0-9c84-39ca4e2e3851}28
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </SyncKey>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <FolderId>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I 57f5ffb8
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </FolderId>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <DeletesAsMoves />
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <GetChanges />
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <WindowSize>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I 100
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </WindowSize>
2013-06-25T19:08:29+02:00 INFO: [3478] Requesting WINDOWSIZE of 100
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <Options>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <FilterType>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I 0
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </FilterType>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <MIMESupport>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I 2
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </MIMESupport>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <MIMETruncation>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I 3
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </MIMETruncation>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <AirSyncBase:BodyPreference>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <AirSyncBase:Type>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I 4
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </AirSyncBase:Type>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <AirSyncBase:TruncationSize>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I 200000
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </AirSyncBase:TruncationSize>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </AirSyncBase:BodyPreference>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </Options>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <Commands>
2013-06-25T19:08:29+02:00 INFO: [3478] Obtaining collection class of
Email for collection id 57f5ffb8
2013-06-25T19:08:29+02:00 INFO: [3478] Initializing state for
collection: Drafts, synckey: {51af577d-396c-4be0-9c84-39ca4e2e3851}28
2013-06-25T19:08:29+02:00 INFO: [3478] Loading state for synckey
{51af577d-396c-4be0-9c84-39ca4e2e3851}28
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <Remove>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I <ServerEntryId />
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </Remove>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </Commands>
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </Folder>
2013-06-25T19:08:29+02:00 INFO: [3478] Polling
Horde_Core_ActiveSync_Driver::_getMailFolders()
2013-06-25T19:08:29+02:00 INFO: [3478] Found serverid for INBOX: 05108b74
2013-06-25T19:08:29+02:00 INFO: [3478] Found serverid for Drafts: 57f5ffb8
2013-06-25T19:08:29+02:00 INFO: [3478] Found serverid for Junk: 39b8f3c6
2013-06-25T19:08:29+02:00 INFO: [3478] Found serverid for Sent: fa37da9d
2013-06-25T19:08:29+02:00 INFO: [3478] Found serverid for Trash: a9249169
2013-06-25T19:08:29+02:00 INFO: [3478] Found serverid for INBOX/spam: c0c7a594
2013-06-25T19:08:29+02:00 INFO: [3478] Found serverid for INBOX: 05108b74
2013-06-25T19:08:29+02:00 INFO: [3478]
Horde_Core_ActiveSync_Driver::moveMessage(Drafts, [], Trash)
2013-06-25T19:08:29+02:00 INFO: [3478] Updating state during delete
2013-06-25T19:08:29+02:00 INFO: [3478] Processed 1 incoming changes
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </Folders>
2013-06-25T19:08:29+02:00 INFO: [3478] Collection added to collection
handler: collection: Drafts, synckey:
{51af577d-396c-4be0-9c84-39ca4e2e3851}28.
2013-06-25T19:08:29+02:00 DEBUG: [3478] I </Synchronize>
2013-06-25T19:08:29+02:00 ERR: [3478] Unmatched end tag:
2013-06-25T19:08:29+02:00 ERR:
2013-06-25T19:08:29+02:00 DEBUG: [3478] O <Synchronize>
2013-06-25T19:08:29+02:00 DEBUG: [3478] O <Status>
2013-06-25T19:08:29+02:00 DEBUG: [3478] O 4
2013-06-25T19:08:29+02:00 DEBUG: [3478] O </Status>
2013-06-25T19:08:29+02:00 DEBUG: [3478] O </Synchronize>
2013-06-25T19:08:29+02:00 ERR: PROTOCOL ERROR: Missing closing SYNC tag
2013-06-25T19:08:29+02:00 INFO: [3478] User user at domain.com logged off
More information about the bugs
mailing list