[Tickets #12013] Activesync - Email syncing stops working

[noreply at bugs.horde.org]

BITTE NICHT AUF DIESE NACHRICHT ANTWORTEN. NACHRICHTEN AN DIESE  
E-MAIL-ADRESSE WERDEN NICHT GELESEN.

Ticket-URL: http://bugs.horde.org/ticket/12013
------------------------------------------------------------------------------
  Ticket           | 12013
  Erstellt Von     | Klaus.Steinberger at physik.uni-muenchen.de
  Zusammenfassung  | Activesync - Email syncing stops working
  Warteschlange    | Horde Framework Packages
  Version          | Git master
  Typ              | Bug
  Status           | Unconfirmed
  Priorität        | 3. High
  Milestone        |
  Patch            |
  Zuständige       |
------------------------------------------------------------------------------


Klaus.Steinberger at physik.uni-muenchen.de (2013-02-02 15:29) hat geschrieben:

Email Syncing stops working with imap error.

The following happens:

- The active Sync client tries to delete messages which are already  
deleted on the imap server
   from this point on, no new messages will be shown on the active sync client.

Reason of this situation:

Often there is an UMTS connection problem (e.g. the UMTS network of  
some providers in germany is very crowded). The active sync client has  
no connection because network is switched off ...

Then during an access with another imap client (e.g. thunderbird)  
inbox is cleaned up.

Now after reconnetion the active sync client tries to remove messages  
which are already removed, and refuses to sync now.

The following sync log could be observed during this situation:

2013-02-02T16:13:27+01:00 INFO: [10635]  
Horde_Core_ActiveSync_Driver::authenticate() attempt for  
Klaus.Steinberger at Physik.Uni-Muenchen.de
2013-02-02T16:13:27+01:00 DEBUG: [10635] SYNC request received for  
user Klaus.Steinberger at Physik.Uni-Muenchen.de
2013-02-02T16:13:27+01:00 DEBUG: [SAMSUNG1359585048378456]  
loadDeviceInfo: Klaus.Steinberger at Physik.Uni-Muenchen.de
2013-02-02T16:13:27+01:00 INFO: Request being handled for device:  
SAMSUNG1359585048378456 Supporting protocol version: 12.1
2013-02-02T16:13:27+01:00 INFO: [10635] Handling SYNC command.
2013-02-02T16:13:27+01:00 DEBUG: [SAMSUNG1359585048378456] Checking  
policykey for device: 0 user: Klaus.Steinberger at Physik.Uni-Muenchen.de
2013-02-02T16:13:27+01:00 DEBUG: Policykey: 0 verified.
2013-02-02T16:13:27+01:00 DEBUG: [10635] I <Synchronize>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I  <Folders>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I   <Folder>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I    <SyncKey>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I       
{50f68036-3d10-4780-b549-74b700000000}246
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     </SyncKey>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I    <FolderId>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      INBOX
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     </FolderId>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I    <DeletesAsMoves />
2013-02-02T16:13:27+01:00 DEBUG: [10635] I    <GetChanges />
2013-02-02T16:13:27+01:00 INFO: Possible unmatched content (peeking or  
empty tag?)
2013-02-02T16:13:27+01:00 DEBUG: [10635] I    <WindowSize>
2013-02-02T16:13:27+01:00 INFO: Possible unmatched content (peeking or  
empty tag?)
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      100
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     </WindowSize>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I    <Options>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     <FilterType>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I       1
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      </FilterType>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     <AirSyncBase:BodyPreference>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      <AirSyncBase:Type>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I        2
2013-02-02T16:13:27+01:00 DEBUG: [10635] I       </AirSyncBase:Type>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      <AirSyncBase:TruncationSize>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I        5120
2013-02-02T16:13:27+01:00 DEBUG: [10635] I       </AirSyncBase:TruncationSize>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      </AirSyncBase:BodyPreference>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     </Options>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I    <Commands>
2013-02-02T16:13:27+01:00 DEBUG: Obtaining folder INBOX class from  
sync_cache: Email
2013-02-02T16:13:27+01:00 DEBUG: [10635] Initializing state for  
collection: INBOX, synckey: {50f68036-3d10-4780-b549-74b700000000}246
2013-02-02T16:13:27+01:00 DEBUG: [10635] Loading state for synckey  
{50f68036-3d10-4780-b549-74b700000000}246
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     <Remove>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      <ServerEntryId>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I        185337
2013-02-02T16:13:27+01:00 DEBUG: [10635] I       </ServerEntryId>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      </Remove>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     <Remove>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      <ServerEntryId>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I        185322
2013-02-02T16:13:27+01:00 DEBUG: [10635] I       </ServerEntryId>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      </Remove>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     <Remove>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      <ServerEntryId>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I        184436
2013-02-02T16:13:27+01:00 DEBUG: [10635] I       </ServerEntryId>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I      </Remove>
2013-02-02T16:13:27+01:00 DEBUG: [10635] I     </Commands>
2013-02-02T16:13:28+01:00 DEBUG: [10635]  
Horde_Core_ActiveSync_Driver::moveMessage(INBOX,  
[185337,185322,184436], Trash)
2013-02-02T16:13:28+01:00 ERR: Der E-Mail-Server hat einen IMAP-Fehler  
gemeldet.


It doesn't help to remove sync status!