Tickets :: Comment on [#14364] ACtive SYNC only way update calendar

* Your Email Address
* Spam protection	Enter the letters below: . .. . ..___.__ \|\/\|\| \ /[__ [__) \| \|\|___ \/ [___\|
Comment	> LOG: The device is configured with Activesync Andorid 6.0 > > > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] > Horde_Core_ActiveSync_Driver::authenticate() attempt for orozas > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] > FOLDERSYNC request received for user orozas > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] Device > entry exists for ANDROID1452105599376, updating userAgent and version. > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] Request > being handled for device: ANDROID1452105599376, Supporting protocol > version: 14.1, Using Horde_ActiveSync v2.27.0 > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] GET > VARIABLES: Array > ( > [Cmd] => FolderSync > [User] => orozas > [DeviceId] => android1452105599376 > [DeviceType] => Android > ) > > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] Handling > FOLDERSYNC command. > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] Checking > policykey for device: ANDROID1452105599376 user: orozas > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] > Policykey: 0 verified. > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] I > <FolderHierarchy:FolderSync> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] I > <FolderHierarchy:SyncKey> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] I > {573c8224-bc84-4d93-ae9e-23430a07c411}1 > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] I > </FolderHierarchy:SyncKey> > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] Loading > state for synckey {573c8224-bc84-4d93-ae9e-23430a07c411}1 > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] Loading > FOLDERSYNC state containing 10 folders. > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] I > </FolderHierarchy:FolderSync> > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] > Initializing folder diff engine > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] > Horde_Core_ActiveSync_Driver::getFolderList() > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] No > folder changes found. > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > <FolderHierarchy:FolderSync> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > <FolderHierarchy:Status> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O 1 > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > </FolderHierarchy:Status> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > <FolderHierarchy:SyncKey> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > {573c8224-bc84-4d93-ae9e-23430a07c411}1 > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > </FolderHierarchy:SyncKey> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > <FolderHierarchy:Changes> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > <FolderHierarchy:Count> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O 0 > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > </FolderHierarchy:Count> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > </FolderHierarchy:Changes> > 2016-05-19T12:11:42-04:00 android1452105599376 DEBUG: [32624] O > </FolderHierarchy:FolderSync> > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] > Replacing SYNC_CACHE entry for user orozas and device > ANDROID1452105599376: > a:11:{s:18:"confirmed_synckeys";a:0:{}s:17:"lasthbsyncstarted";i:1463674198;s:17:"lastsyncendnormal";i:1463674197;s:9:"timestamp";s:10:"1463674302";s:4:"wait";b:0;s:10:"hbinterval";s:4:"1680";s:7:"folders";a:10:{s:5:"Trash";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"Trash";}s:9:"T867f1a73";a:2:{s:5:"class";s:5:"Tasks";s:8:"serverid";s:7:"@Tasks@";}s:4:"Sent";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:4:"Sent";}s:2:"RI";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:2:"RI";}s:6:"OUTBOX";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"OUTBOX";}s:9:"N435f4656";a:2:{s:5:"class";s:5:"Notes";s:8:"serverid";s:7:"@Notes@";}s:5:"INBOX";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"INBOX";}s:6:"DRAFTS";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"DRAFTS";}s:9:"Cad5bd662";a:2:{s:5:"class";s:8:"Contacts";s:8:"serverid";s:10:"@Contacts@";}s:9:"A0a5c5e9a";a:2:{s:5:"class";s:8:"Calendar";s:8:"serverid";s:10:"@Calendar@";}}s:9:"hierarchy";s:39:"{573c8224-bc84-4d93-ae9e-23430a07c411 > }1";s:11:"collections";a:1:{s:9:"A0a5c5e9a";a:11:{s:5:"class";s:8:"Calendar";s:10:"windowsize";s:2:"10";s:11:"mimesupport";i:0;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:1;a:2:{s:4:"type";s:1:"1";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:10:"@Calendar@";s:11:"lastsynckey";s:39:"{573c8225-b3bc-4c07-8466-23430a07c411}8";s:14:"deletesasmoves";b:1;s:10:"filtertype";s:1:"4";s:8:"pingable";b:1;s:2:"id";s:9:"A0a5c5e9a";}}s:13:"pingheartbeat";b:0;s:14:"synckeycounter";a:0:{}} > 2016-05-19T12:11:42-04:00 android1452105599376 INFO: [32624] Maximum > memory usage for ActiveSync request: 17766984 bytes. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Horde_Core_ActiveSync_Driver::authenticate() attempt for orozas > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] SYNC > request received for user orozas > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Device > entry exists for ANDROID1452105599376, updating userAgent and version. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Request > being handled for device: ANDROID1452105599376, Supporting protocol > version: 14.1, Using Horde_ActiveSync v2.27.0 > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] GET > VARIABLES: Array > ( > [Cmd] => Sync > [User] => orozas > [DeviceId] => android1452105599376 > [DeviceType] => Android > ) > > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Handling > SYNC command. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Checking > policykey for device: ANDROID1452105599376 user: orozas > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Policykey: 0 verified. > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <Synchronize> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I <Folders> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I <Folder> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I <SyncKey> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > {573c8225-b3bc-4c07-8466-23430a07c411}8 > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </SyncKey> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <FolderId> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > A0a5c5e9a > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </FolderId> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <DeletesAsMoves /> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <GetChanges /> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <WindowSize> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I 10 > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </WindowSize> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I <Options> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <FilterType> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I 4 > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </FilterType> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <AirSyncBase:BodyPreference> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <AirSyncBase:Type> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I 1 > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </AirSyncBase:Type> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <AirSyncBase:TruncationSize> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > 200000 > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </AirSyncBase:TruncationSize> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </AirSyncBase:BodyPreference> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </Options> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I </Folder> > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Obtaining collection class of Calendar for collection id A0a5c5e9a > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Collection added to collection handler: collection: @Calendar@, > synckey: {573c8225-b3bc-4c07-8466-23430a07c411}8. > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I </Folders> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </Synchronize> > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Loading > default OPTIONS for A0a5c5e9a collection. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Clearing > all collection synckeys from the cache. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: Have syncable > collections > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Replacing SYNC_CACHE entry for user orozas and device > ANDROID1452105599376: > a:11:{s:18:"confirmed_synckeys";a:0:{}s:17:"lasthbsyncstarted";i:1463674198;s:17:"lastsyncendnormal";i:1463674197;s:9:"timestamp";s:10:"1463674303";s:4:"wait";b:0;s:10:"hbinterval";s:4:"1680";s:7:"folders";a:10:{s:5:"Trash";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"Trash";}s:9:"T867f1a73";a:2:{s:5:"class";s:5:"Tasks";s:8:"serverid";s:7:"@Tasks@";}s:4:"Sent";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:4:"Sent";}s:2:"RI";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:2:"RI";}s:6:"OUTBOX";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"OUTBOX";}s:9:"N435f4656";a:2:{s:5:"class";s:5:"Notes";s:8:"serverid";s:7:"@Notes@";}s:5:"INBOX";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"INBOX";}s:6:"DRAFTS";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"DRAFTS";}s:9:"Cad5bd662";a:2:{s:5:"class";s:8:"Contacts";s:8:"serverid";s:10:"@Contacts@";}s:9:"A0a5c5e9a";a:2:{s:5:"class";s:8:"Calendar";s:8:"serverid";s:10:"@Calendar@";}}s:9:"hierarchy";s:39:"{573c8224-bc84-4d93-ae9e-23430a07c411 > }1";s:11:"collections";a:1:{s:9:"A0a5c5e9a";a:11:{s:5:"class";s:8:"Calendar";s:10:"windowsize";s:2:"10";s:11:"mimesupport";i:0;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:1;a:2:{s:4:"type";s:1:"1";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:10:"@Calendar@";s:11:"lastsynckey";s:39:"{573c8225-b3bc-4c07-8466-23430a07c411}8";s:14:"deletesasmoves";b:1;s:10:"filtertype";s:1:"4";s:8:"pingable";b:1;s:2:"id";s:9:"A0a5c5e9a";}}s:13:"pingheartbeat";b:0;s:14:"synckeycounter";a:0:{}} > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] All > synckeys confirmed. Continuing with SYNC > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O > <Synchronize> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O <Status> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O 1 > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O </Status> > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Initializing state for collection: @Calendar@, synckey: > {573c8225-b3bc-4c07-8466-23430a07c411}8 > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Loading > state for synckey {573c8225-b3bc-4c07-8466-23430a07c411}8 > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Initializing message diff engine for A0a5c5e9a (@Calendar@) > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Horde_Core_ActiveSync_Driver::getSyncStamp(@Calendar@, 0); > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] > SyncCache collections refreshed. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] > Refreshing A0a5c5e9a from the cache. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] > Initializing state for collection: @Calendar@, synckey: > {573c8225-b3bc-4c07-8466-23430a07c411}8 > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] Loading > state for synckey {573c8225-b3bc-4c07-8466-23430a07c411}8 > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] > Initializing message diff engine for A0a5c5e9a (@Calendar@) > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] > Horde_Core_ActiveSync_Driver::getSyncStamp(@Calendar@, 0); > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] Using > SYNCSTAMP 0 for A0a5c5e9a. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] > Horde_Core_ActiveSync_Driver::getServerChanges(@Calendar@, 0, 0, > 1462464703, 1, 1, 100, ) > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] Fetching > changes for calendar using MODSEQ. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] Found 0 > message changes in A0a5c5e9a. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [26884] Sleeping > for 15 seconds. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Using > SYNCSTAMP 0 for A0a5c5e9a. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Horde_Core_ActiveSync_Driver::getServerChanges(@Calendar@, 0, 0, > 1462464703, 0, 1, 100, ) > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Fetching > changes for calendar using MODSEQ. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Found 0 > message changes in A0a5c5e9a. > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O <Folders> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O <Folder> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O <SyncKey> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O > {573c8225-b3bc-4c07-8466-23430a07c411}8 > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O > </SyncKey> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O > <FolderId> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O > A0a5c5e9a > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O > </FolderId> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O <Status> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O 1 > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O </Status> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O </Folder> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O </Folders> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] O > </Synchronize> > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Replacing SYNC_CACHE entry for user orozas and device > ANDROID1452105599376: > a:11:{s:18:"confirmed_synckeys";a:0:{}s:17:"lasthbsyncstarted";i:1463674198;s:17:"lastsyncendnormal";i:1463674303;s:9:"timestamp";s:10:"1463674303";s:4:"wait";b:0;s:10:"hbinterval";s:4:"1680";s:7:"folders";a:10:{s:5:"Trash";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"Trash";}s:9:"T867f1a73";a:2:{s:5:"class";s:5:"Tasks";s:8:"serverid";s:7:"@Tasks@";}s:4:"Sent";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:4:"Sent";}s:2:"RI";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:2:"RI";}s:6:"OUTBOX";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"OUTBOX";}s:9:"N435f4656";a:2:{s:5:"class";s:5:"Notes";s:8:"serverid";s:7:"@Notes@";}s:5:"INBOX";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"INBOX";}s:6:"DRAFTS";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"DRAFTS";}s:9:"Cad5bd662";a:2:{s:5:"class";s:8:"Contacts";s:8:"serverid";s:10:"@Contacts@";}s:9:"A0a5c5e9a";a:2:{s:5:"class";s:8:"Calendar";s:8:"serverid";s:10:"@Calendar@";}}s:9:"hierarchy";s:39:"{573c8224-bc84-4d93-ae9e-23430a07c411 > }1";s:11:"collections";a:1:{s:9:"A0a5c5e9a";a:11:{s:5:"class";s:8:"Calendar";s:10:"windowsize";s:2:"10";s:11:"mimesupport";i:0;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:1;a:2:{s:4:"type";s:1:"1";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:10:"@Calendar@";s:11:"lastsynckey";s:39:"{573c8225-b3bc-4c07-8466-23430a07c411}8";s:14:"deletesasmoves";b:1;s:10:"filtertype";s:1:"4";s:8:"pingable";b:1;s:2:"id";s:9:"A0a5c5e9a";}}s:13:"pingheartbeat";b:0;s:14:"synckeycounter";a:0:{}} > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Maximum > memory usage for ActiveSync request: 14145400 bytes. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Horde_Core_ActiveSync_Driver::authenticate() attempt for orozas > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] PING > request received for user orozas > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Device > entry exists for ANDROID1452105599376, updating userAgent and version. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Request > being handled for device: ANDROID1452105599376, Supporting protocol > version: 14.1, Using Horde_ActiveSync v2.27.0 > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] GET > VARIABLES: Array > ( > [Cmd] => Ping > [User] => orozas > [DeviceId] => android1452105599376 > [DeviceType] => Android > ) > > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Handling > PING command received at timestamp: 1463674303. > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I <Ping:Ping> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <Ping:HeartbeatInterval> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I 1680 > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </Ping:HeartbeatInterval> > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Actual > heartbeat value in use is 1680. > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <Ping:Folders> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <Ping:Folder> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <Ping:ServerEntryId> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > A0a5c5e9a > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </Ping:ServerEntryId> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > <Ping:FolderType> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > Calendar > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </Ping:FolderType> > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </Ping:Folder> > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Obtained > synckey for collection A0a5c5e9a from cache: > {573c8225-b3bc-4c07-8466-23430a07c411}8 > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Collection added to collection handler: collection: @Calendar@, > synckey: {573c8225-b3bc-4c07-8466-23430a07c411}8. > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I > </Ping:Folders> > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: Setting > collection @Calendar@ (A0a5c5e9a) PINGABLE. > 2016-05-19T12:11:43-04:00 android1452105599376 DEBUG: [32624] I </Ping:Ping> > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: Waiting for > changes for 1680 seconds > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Replacing SYNC_CACHE entry for user orozas and device > ANDROID1452105599376: > a:11:{s:18:"confirmed_synckeys";a:0:{}s:17:"lasthbsyncstarted";i:1463674303;s:17:"lastsyncendnormal";i:1463674303;s:9:"timestamp";s:10:"1463674303";s:4:"wait";b:0;s:10:"hbinterval";s:4:"1680";s:7:"folders";a:10:{s:5:"Trash";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"Trash";}s:9:"T867f1a73";a:2:{s:5:"class";s:5:"Tasks";s:8:"serverid";s:7:"@Tasks@";}s:4:"Sent";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:4:"Sent";}s:2:"RI";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:2:"RI";}s:6:"OUTBOX";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"OUTBOX";}s:9:"N435f4656";a:2:{s:5:"class";s:5:"Notes";s:8:"serverid";s:7:"@Notes@";}s:5:"INBOX";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"INBOX";}s:6:"DRAFTS";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"DRAFTS";}s:9:"Cad5bd662";a:2:{s:5:"class";s:8:"Contacts";s:8:"serverid";s:10:"@Contacts@";}s:9:"A0a5c5e9a";a:2:{s:5:"class";s:8:"Calendar";s:8:"serverid";s:10:"@Calendar@";}}s:9:"hierarchy";s:39:"{573c8224-bc84-4d93-ae9e-23430a07c411 > }1";s:11:"collections";a:1:{s:9:"A0a5c5e9a";a:11:{s:5:"class";s:8:"Calendar";s:10:"windowsize";s:2:"10";s:11:"mimesupport";i:0;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:1;a:2:{s:4:"type";s:1:"1";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:10:"@Calendar@";s:11:"lastsynckey";s:39:"{573c8225-b3bc-4c07-8466-23430a07c411}8";s:14:"deletesasmoves";b:1;s:10:"filtertype";s:1:"4";s:8:"pingable";b:1;s:2:"id";s:9:"A0a5c5e9a";}}s:13:"pingheartbeat";b:0;s:14:"synckeycounter";a:0:{}} > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Initializing state for collection: @Calendar@, synckey: > {573c8225-b3bc-4c07-8466-23430a07c411}8 > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Loading > state for synckey {573c8225-b3bc-4c07-8466-23430a07c411}8 > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Initializing message diff engine for A0a5c5e9a (@Calendar@) > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Horde_Core_ActiveSync_Driver::getSyncStamp(@Calendar@, 0); > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Using > SYNCSTAMP 0 for A0a5c5e9a. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] > Horde_Core_ActiveSync_Driver::getServerChanges(@Calendar@, 0, 0, > 1462464703, 1, 1, 100, ) > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Fetching > changes for calendar using MODSEQ. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Found 0 > message changes in A0a5c5e9a. > 2016-05-19T12:11:43-04:00 android1452105599376 INFO: [32624] Sleeping > for 15 seconds. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] SyncCache collections refreshed. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Refreshing INBOX from the cache. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Refreshing A2b6e20a9 from the cache. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Refreshing C790ebb6b from the cache. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Refreshing Trash from the cache. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Refreshing Sent from the cache. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Refreshing Tf3cf0f56 from the cache. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing state for collection: INBOX, synckey: > {573dd1a9-a784-4fed-9aaa-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Loading state for synckey > {573dd1a9-a784-4fed-9aaa-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing message diff engine for INBOX (INBOX) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getSyncStamp(INBOX, 1463669163); > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Using SYNCSTAMP 1463674308 for INBOX. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getServerChanges(INBOX, > 1463669163, 1463674308, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Found 0 message changes in INBOX. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing state for collection: @Calendar@, synckey: > {573dd1a9-8fb4-4012-82ed-7e100a07c411}3 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Loading state for synckey > {573dd1a9-8fb4-4012-82ed-7e100a07c411}3 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing message diff engine for A2b6e20a9 (@Calendar@) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getSyncStamp(@Calendar@, 0); > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Using SYNCSTAMP 0 for A2b6e20a9. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getServerChanges(@Calendar@, 0, > 0, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Fetching changes for calendar using MODSEQ. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Found 0 message changes in A2b6e20a9. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing state for collection: @Contacts@, synckey: > {573dd1a9-9470-4b52-b19a-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Loading state for synckey > {573dd1a9-9470-4b52-b19a-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing message diff engine for C790ebb6b (@Contacts@) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getSyncStamp(@Contacts@, 0); > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Using SYNCSTAMP 0 for C790ebb6b. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getServerChanges(@Contacts@, 0, > 0, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Fetching changes for contacts using MODSEQ. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Found 0 message changes in C790ebb6b. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing state for collection: Trash, synckey: > {573dd1a9-52dc-4ff1-a538-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Loading state for synckey > {573dd1a9-52dc-4ff1-a538-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing message diff engine for Trash (Trash) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getSyncStamp(Trash, 1463669163); > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Using SYNCSTAMP 1463674308 for Trash. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getServerChanges(Trash, > 1463669163, 1463674308, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Found 0 message changes in Trash. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing state for collection: Sent, synckey: > {573dd1a9-0a40-4b11-95af-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Loading state for synckey > {573dd1a9-0a40-4b11-95af-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing message diff engine for Sent (Sent) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getSyncStamp(Sent, 1463669163); > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Using SYNCSTAMP 1463674308 for Sent. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getServerChanges(Sent, > 1463669163, 1463674308, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Found 0 message changes in Sent. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing state for collection: @Tasks@, synckey: > {573dd1a9-f9e4-4bd0-8d9b-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Loading state for synckey > {573dd1a9-f9e4-4bd0-8d9b-7e100a07c411}2 > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Initializing message diff engine for Tf3cf0f56 (@Tasks@) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getSyncStamp(@Tasks@, 0); > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Using SYNCSTAMP 0 for Tf3cf0f56. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Horde_Core_ActiveSync_Driver::getServerChanges(@Tasks@, 0, 0, > 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Fetching changes for tasks using MODSEQ. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Found 0 message changes in Tf3cf0f56. > 2016-05-19T12:11:48-04:00 0A9D7E1A72E040A898967CE5A82E714F INFO: > [31991] Sleeping for 15 seconds. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] SyncCache collections refreshed. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Refreshing INBOX from the cache. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Refreshing Ab4e5b44f from the cache. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Refreshing Cfde9cd73 from the cache. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Refreshing Trash from the cache. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Refreshing Sent from the cache. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Refreshing T67b34954 from the cache. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing state for collection: INBOX, synckey: > {573c81d2-de94-40ef-9a7e-136e0a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Loading state for synckey > {573c81d2-de94-40ef-9a7e-136e0a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing message diff engine for INBOX (INBOX) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getSyncStamp(INBOX, 1463583199); > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Using SYNCSTAMP 1463674308 for INBOX. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getServerChanges(INBOX, > 1463583199, 1463674308, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Found 0 message changes in INBOX. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing state for collection: @Calendar@, synckey: > {573c81cc-32a8-4b52-9739-18e10a07c411}4 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Loading state for synckey > {573c81cc-32a8-4b52-9739-18e10a07c411}4 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing message diff engine for Ab4e5b44f (@Calendar@) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getSyncStamp(@Calendar@, 0); > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Using SYNCSTAMP 0 for Ab4e5b44f. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getServerChanges(@Calendar@, 0, > 0, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Fetching changes for calendar using MODSEQ. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Found 0 message changes in Ab4e5b44f. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing state for collection: @Contacts@, synckey: > {573c81cc-6238-4bd0-b2d0-18e10a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Loading state for synckey > {573c81cc-6238-4bd0-b2d0-18e10a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing message diff engine for Cfde9cd73 (@Contacts@) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getSyncStamp(@Contacts@, 0); > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Using SYNCSTAMP 0 for Cfde9cd73. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getServerChanges(@Contacts@, 0, > 0, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Fetching changes for contacts using MODSEQ. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Found 0 message changes in Cfde9cd73. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing state for collection: Trash, synckey: > {573c81d3-14d0-45b8-98e9-136e0a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Loading state for synckey > {573c81d3-14d0-45b8-98e9-136e0a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing message diff engine for Trash (Trash) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getSyncStamp(Trash, 1463583199); > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Using SYNCSTAMP 1463674308 for Trash. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getServerChanges(Trash, > 1463583199, 1463674308, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Found 0 message changes in Trash. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing state for collection: Sent, synckey: > {573c81d3-7ed4-4d91-8a0e-136e0a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Loading state for synckey > {573c81d3-7ed4-4d91-8a0e-136e0a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing message diff engine for Sent (Sent) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getSyncStamp(Sent, 1463583199); > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Using SYNCSTAMP 1463674308 for Sent. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getServerChanges(Sent, > 1463583199, 1463674308, 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Found 0 message changes in Sent. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing state for collection: @Tasks@, synckey: > {573c81cc-8024-4b63-a6c8-18e10a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Loading state for synckey > {573c81cc-8024-4b63-a6c8-18e10a07c411}2 > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Initializing message diff engine for T67b34954 (@Tasks@) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getSyncStamp(@Tasks@, 0); > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Using SYNCSTAMP 0 for T67b34954. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Horde_Core_ActiveSync_Driver::getServerChanges(@Tasks@, 0, 0, > 0, 1, 1, 100, ) > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Fetching changes for tasks using MODSEQ. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Found 0 message changes in T67b34954. > 2016-05-19T12:11:48-04:00 4BC5D0F85E3545E8802F9E4EE76557F8 INFO: > [13800] Sleeping for 15 seconds. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] SyncCache collections refreshed. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Refreshing INBOX from the cache. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Refreshing A3b53f715 from the cache. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Refreshing C3a272d15 from the cache. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Refreshing Trash from the cache. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Refreshing Sent from the cache. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Refreshing T6efa9fe6 from the cache. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing state for collection: INBOX, synckey: > {573dccf2-da3c-48dd-b561-7e850a07c411}2 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Loading state for synckey > {573dccf2-da3c-48dd-b561-7e850a07c411}2 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing message diff engine for INBOX (INBOX) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getSyncStamp(INBOX, 1463667956); > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Using SYNCSTAMP 1463674309 for INBOX. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getServerChanges(INBOX, > 1463667956, 1463674309, 0, 1, 1, 100, ) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Found 0 message changes in INBOX. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing state for collection: @Calendar@, synckey: > {573dccf1-d7ec-4be5-a7ac-7e850a07c411}3 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Loading state for synckey > {573dccf1-d7ec-4be5-a7ac-7e850a07c411}3 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing message diff engine for A3b53f715 (@Calendar@) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getSyncStamp(@Calendar@, 0); > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Using SYNCSTAMP 0 for A3b53f715. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getServerChanges(@Calendar@, 0, > 0, 0, 1, 1, 100, ) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Fetching changes for calendar using MODSEQ. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Found 0 message changes in A3b53f715. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing state for collection: @Contacts@, synckey: > {573dccf1-1e88-41ea-94d0-7e850a07c411}4 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Loading state for synckey > {573dccf1-1e88-41ea-94d0-7e850a07c411}4 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing message diff engine for C3a272d15 (@Contacts@) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getSyncStamp(@Contacts@, 0); > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Using SYNCSTAMP 0 for C3a272d15. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getServerChanges(@Contacts@, 0, > 0, 0, 1, 1, 100, ) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Fetching changes for contacts using MODSEQ. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Found 0 message changes in C3a272d15. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing state for collection: Trash, synckey: > {573dccf2-a654-4446-a0ac-7e850a07c411}2 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Loading state for synckey > {573dccf2-a654-4446-a0ac-7e850a07c411}2 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing message diff engine for Trash (Trash) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getSyncStamp(Trash, 1463667957); > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Using SYNCSTAMP 1463674309 for Trash. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getServerChanges(Trash, > 1463667957, 1463674309, 0, 1, 1, 100, ) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Found 0 message changes in Trash. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing state for collection: Sent, synckey: > {573dccf2-5028-480f-857a-7e850a07c411}2 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Loading state for synckey > {573dccf2-5028-480f-857a-7e850a07c411}2 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing message diff engine for Sent (Sent) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getSyncStamp(Sent, 1463667957); > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Using SYNCSTAMP 1463674309 for Sent. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getServerChanges(Sent, > 1463667957, 1463674309, 0, 1, 1, 100, ) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Found 0 message changes in Sent. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing state for collection: @Tasks@, synckey: > {573dccf1-ca9c-400c-a687-7e850a07c411}4 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Loading state for synckey > {573dccf1-ca9c-400c-a687-7e850a07c411}4 > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Initializing message diff engine for T6efa9fe6 (@Tasks@) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getSyncStamp(@Tasks@, 0); > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Using SYNCSTAMP 0 for T6efa9fe6. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Horde_Core_ActiveSync_Driver::getServerChanges(@Tasks@, 0, 0, > 0, 1, 1, 100, ) > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Fetching changes for tasks using MODSEQ. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Found 0 message changes in T6efa9fe6. > 2016-05-19T12:11:49-04:00 720F678883DC44CE82187F2D5D52DD8A INFO: > [11398] Sleeping for 15 seconds. > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] SyncCache collections refreshed. > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Refreshing A2d94bffe from the cache. > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Refreshing RI from the cache. > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Initializing state for collection: @Calendar@, synckey: > {55c4efd0-08f8-4807-9c9e-3a2d0a07c411}34 > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Loading state for synckey > {55c4efd0-08f8-4807-9c9e-3a2d0a07c411}34 > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Initializing message diff engine for A2d94bffe (@Calendar@) > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Horde_Core_ActiveSync_Driver::getSyncStamp(@Calendar@, 0); > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Using SYNCSTAMP 0 for A2d94bffe. > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Horde_Core_ActiveSync_Driver::getServerChanges(@Calendar@, 0, > 0, 1462464710, 1, 1, 100, ) > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Fetching changes for calendar using MODSEQ. > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Found 0 message changes in A2d94bffe. > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Initializing state for collection: RI, synckey: > {55c4efd0-5c14-46d2-bd64-3a2d0a07c411}2 > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Loading state for synckey > {55c4efd0-5c14-46d2-bd64-3a2d0a07c411}2 > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Initializing message diff engine for RI (RI) > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Horde_Core_ActiveSync_Driver::getSyncStamp(RI, 1438969809); > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Using SYNCSTAMP 1463674310 for RI. > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Horde_Core_ActiveSync_Driver::getServerChanges(RI, > 1438969809, 1463674310, 0, 1, , 100, ) > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Found 0 message changes in RI. > 2016-05-19T12:11:50-04:00 5f6c2b4491816a4754c250ee4ad2dbf6 INFO: > [20141] Sleeping for 15 seconds. > > > > > > > > > > >> To further debug this issue, we need details of the Horde -> Device >> connection. >> >> To enable debugging, see instructions contained in the ActiveSync >> section of Horde's configuration. Also, see >> http://wiki.horde.org/ActiveSync for more details. >> >> Attach/post only the portion of the log that directly deals with the >> problem reported (it may be simplest to clear the log file and then >> perform the event that causes the error). >
Attachment
Watch this ticket

Saved Queries