View Issue Details

IDProjectCategoryView StatusLast Update
0003672SOGoActiveSyncpublic2016-10-07 10:52
ReporterMcMichaeli Assigned Toludovic  
PrioritynormalSeverityminorReproducibilityalways
Status resolvedResolutionfixed 
Platform[Server] LinuxOSUbuntuOS Version14.04 LTS
Product Versionnightly v2 
Summary0003672: EAS Continuous Loop with Android Client when Mail Sync Disabled
Description

We have been using ActiveSync with Android 6 for some months now. As we do not like the GMail client that Google push for mail we disable e-mail sync via ActiveSync and use it for Calendar and Contacts only. (We use K9Mail as a "proper" e-mail client on Android!)

This has been fine until the last few days when all our Android handsets (Nexus 5 running stock Android 6) have gone into "continuous sync" mode. The attached (anonymised) log shows an EAS debug of what happens. Even though the phone is not set to synchronise mail the ping response from SOGo lists changes to two mail folders. The Android responds by doing a sync request for all the enabled folders (which excludes the two mail ones). The next ping says there is still the same data to be updated and so the loop goes on...

I have set the severity to major as this kills the battery life of the phone, eats mobile data and keeps the SOGo server pretty busy too!

Steps To Reproduce

Install the current 3.0.2 nightly build on an Ubuntu 14.04 LTS server. Create two account and share the personal calendar, address book and inbox with the other user.

On a Nexus 5 (stock Android 6.0.1 with May 2016 security patches) create an Exchange account. When configuring the services, leave everything ticked apart from the "Sync email" check-box. Complete the set-up and wait for the account to complete sync.

Sometimes the initial set-up works, but I guess this depends if any of the inboxes receive a new message during the process? If it does complete, the next message received will trigger a continuous loop where the calendar and contacts try sync one after another forever.

Additional Information

This was tested against nightly version 3.0.2 (build @shiva.inverse 201605120305) on Ubuntu 14.04 LTS 64-bit.

TagsNo tags attached.

Activities

McMichaeli

McMichaeli

2016-05-12 20:21

reporter  

sogo.log (173,793 bytes)   
May 12 19:03:32 sogod [19698]: version 3.0.2 (build @shiva.inverse 201605120305) -- starting
May 12 19:03:32 sogod [19698]: vmem size check enabled: shutting down app when vmem > 384 MB
May 12 19:03:32 sogod [19698]: <0x0x7f51909932b8[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo':
May 12 19:03:32 sogod [19698]: <0x0x7f51909932b8[SOGoProductLoader]>   CommonUI.SOGo, MailPartViewers.SOGo, Mailer.SOGo, PreferencesUI.SOGo, Contacts.SOGo, ActiveSync.SOGo, Appointments.SOGo, MainUI.SOGo, AdministrationUI.SOGo, MailerUI.SOGo, ContactsUI.SOGo, SchedulerUI.SOGo
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> listening on 127.0.0.1:20000
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> watchdog process pid: 19698
May 12 19:03:32 sogod [19698]: <0x0x7f518ec1d6a0[WOWatchDogChild]> watchdog request timeout set to 16 minutes
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> preparing 10 children
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19701
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19702
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19703
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19704
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19705
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19706
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19707
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19708
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19709
May 12 19:03:32 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> child spawned with pid 19710
May 12 19:03:34 sogod [19709]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=usera%40example.net&DeviceId=android3000786125&DeviceType=Android'
May 12 19:03:34 sogod [19709]: <0x0x7f5190801a28[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
May 12 19:03:34 sogod [19709]: <0x0x7f5190801a28[SOGoCache]> Using host(s) 'localhost' as server(s)
May 12 19:03:35 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> EAS - request for device android3000786125: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>780</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2Fc4f62f011fd7ce4e60260000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2F74895e06d5fc8453165100007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserb_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:03:35 sogod [19709]: [WARN] <0x0x7f51913cfd28[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
May 12 19:03:35 sogod [19709]: [WARN] <0x0x7f51913cfd28[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
May 12 19:03:35 sogod [19709]: [WARN] <0x0x7f51913cfd28[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
May 12 19:03:35 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 30 seconds while detecting changes in Ping...
May 12 19:03:40 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 25 seconds while detecting changes in Ping...
May 12 19:03:45 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 20 seconds while detecting changes in Ping...
May 12 19:03:50 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 15 seconds while detecting changes in Ping...
May 12 19:03:55 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 10 seconds while detecting changes in Ping...
May 12 19:04:00 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 5 seconds while detecting changes in Ping...
May 12 19:04:05 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 30 seconds while detecting changes in Ping...
May 12 19:04:10 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 25 seconds while detecting changes in Ping...
May 12 19:04:15 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 20 seconds while detecting changes in Ping...
May 12 19:04:19 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:19 sogod [19704]: <0x0x7f5190abb8a8[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
May 12 19:04:19 sogod [19704]: <0x0x7f5190abb8a8[SOGoCache]> Using host(s) 'localhost' as server(s)
May 12 19:04:19 sogod [19704]: <0x0x7f5190b14998[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>480</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2F43ff0f1981daed5084110000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2Fd7a7e42c75d2a153472f00007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fusera_A_example_D_net_personal</Id>
   <Class>Calendar</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:04:20 sogod [19704]: [WARN] <0x0x7f5190e6f808[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
May 12 19:04:20 sogod [19704]: [WARN] <0x0x7f5190e6f808[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
May 12 19:04:20 sogod [19704]: [WARN] <0x0x7f5190e6f808[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
May 12 19:04:20 sogod [19704]: <0x0x7f5190b14998[SOGoActiveSyncDispatcher]> Change detected using Ping, we let the EAS client know to send a Sync.
May 12 19:04:20 sogod [19704]: <0x0x7f5190b14998[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>2</Status>
 <Folders>
  <Folder>mail%2F43ff0f1981daed5084110000f0c6d462</Folder>
  <Folder>mail%2Fd7a7e42c75d2a153472f00007c417c47</Folder>
 </Folders>
</Ping>

May 12 19:04:20 sogod [19704]: |SOGo| request took 0.535098 seconds to execute
May 12 19:04:20 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 101/443 0.538 - - 5M
May 12 19:04:20 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:20 sogod [19704]: |SOGo| request took 0.002092 seconds to execute
May 12 19:04:20 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 4K
May 12 19:04:20 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:20 sogod [19704]: <0x0x7f5190e02508[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:20 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 15 seconds while detecting changes in Ping...
May 12 19:04:21 sogod [19704]: <0x0x7f5190e02508[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:21 sogod [19704]: |SOGo| request took 0.597281 seconds to execute
May 12 19:04:21 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.598 - - 4M
May 12 19:04:21 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:21 sogod [19704]: <0x0x7f519133d528[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:21 sogod [19704]: |SOGo| request took 0.020294 seconds to execute
May 12 19:04:21 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.022 - - 0
May 12 19:04:21 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:21 sogod [19704]: <0x0x7f5190fde598[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:21 sogod [19704]: |SOGo| request took 0.018047 seconds to execute
May 12 19:04:21 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.019 - - 0
May 12 19:04:22 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:22 sogod [19704]: <0x0x7f51912ec1d8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:22 sogod [19704]: |SOGo| request took 0.016770 seconds to execute
May 12 19:04:22 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.018 - - 0
May 12 19:04:22 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:22 sogod [19704]: <0x0x7f51912f1128[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:22 sogod [19704]: |SOGo| request took 0.019567 seconds to execute
May 12 19:04:22 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.021 - - -252K
May 12 19:04:22 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:22 sogod [19704]: <0x0x7f51912fa568[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:22 sogod [19704]: |SOGo| request took 0.013240 seconds to execute
May 12 19:04:22 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.015 - - 0
May 12 19:04:22 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:22 sogod [19704]: <0x0x7f5190e89718[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:22 sogod [19704]: |SOGo| request took 0.012035 seconds to execute
May 12 19:04:22 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.013 - - 0
May 12 19:04:22 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:22 sogod [19704]: |SOGo| request took 0.001817 seconds to execute
May 12 19:04:22 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:23 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:23 sogod [19704]: <0x0x7f5191339f28[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:23 sogod [19704]: <0x0x7f5191339f28[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:23 sogod [19704]: |SOGo| request took 0.394988 seconds to execute
May 12 19:04:23 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.396 - - 256K
May 12 19:04:24 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:24 sogod [19704]: <0x0x7f5190db8008[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:24 sogod [19704]: |SOGo| request took 0.021617 seconds to execute
May 12 19:04:24 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.023 - - 0
May 12 19:04:24 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:24 sogod [19704]: <0x0x7f51912ec2b8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:24 sogod [19704]: |SOGo| request took 0.019453 seconds to execute
May 12 19:04:24 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.021 - - 0
May 12 19:04:24 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:24 sogod [19704]: <0x0x7f5191350708[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:24 sogod [19704]: |SOGo| request took 0.013364 seconds to execute
May 12 19:04:24 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.014 - - 0
May 12 19:04:24 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:24 sogod [19704]: <0x0x7f5190e92278[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:24 sogod [19704]: |SOGo| request took 0.020725 seconds to execute
May 12 19:04:24 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.022 - - -276K
May 12 19:04:25 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 10 seconds while detecting changes in Ping...
May 12 19:04:26 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:26 sogod [19704]: <0x0x7f5190e79fb8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:26 sogod [19704]: |SOGo| request took 0.014075 seconds to execute
May 12 19:04:26 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.016 - - 0
May 12 19:04:26 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:26 sogod [19704]: <0x0x7f51909c6188[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:26 sogod [19704]: |SOGo| request took 0.012377 seconds to execute
May 12 19:04:26 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.013 - - 0
May 12 19:04:26 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:26 sogod [19704]: <0x0x7f5190e94f78[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>480</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2F43ff0f1981daed5084110000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2Fd7a7e42c75d2a153472f00007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fusera_A_example_D_net_personal</Id>
   <Class>Calendar</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:04:27 sogod [19704]: <0x0x7f5190e94f78[SOGoActiveSyncDispatcher]> Change detected using Ping, we let the EAS client know to send a Sync.
May 12 19:04:27 sogod [19704]: <0x0x7f5190e94f78[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>2</Status>
 <Folders>
  <Folder>mail%2F43ff0f1981daed5084110000f0c6d462</Folder>
  <Folder>mail%2Fd7a7e42c75d2a153472f00007c417c47</Folder>
 </Folders>
</Ping>

May 12 19:04:27 sogod [19704]: |SOGo| request took 0.534414 seconds to execute
May 12 19:04:27 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 101/443 0.583 - - 1M
May 12 19:04:28 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:28 sogod [19704]: |SOGo| request took 0.002008 seconds to execute
May 12 19:04:28 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:28 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:28 sogod [19704]: <0x0x7f519133d528[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:29 sogod [19704]: <0x0x7f519133d528[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:29 sogod [19704]: |SOGo| request took 0.387784 seconds to execute
May 12 19:04:29 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.389 - - -728K
May 12 19:04:29 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:29 sogod [19704]: <0x0x7f5191301cd8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:29 sogod [19704]: |SOGo| request took 0.022645 seconds to execute
May 12 19:04:29 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.024 - - 0
May 12 19:04:29 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:29 sogod [19704]: <0x0x7f519133f1a8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:29 sogod [19704]: |SOGo| request took 0.016285 seconds to execute
May 12 19:04:29 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.017 - - 0
May 12 19:04:30 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:30 sogod [19704]: <0x0x7f51912ff0f8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:30 sogod [19704]: |SOGo| request took 0.016039 seconds to execute
May 12 19:04:30 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.017 - - 0
May 12 19:04:30 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:30 sogod [19704]: <0x0x7f519100c578[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:30 sogod [19704]: |SOGo| request took 0.023150 seconds to execute
May 12 19:04:30 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.024 - - 0
May 12 19:04:30 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 5 seconds while detecting changes in Ping...
May 12 19:04:30 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:30 sogod [19704]: <0x0x7f51913358e8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:31 sogod [19704]: |SOGo| request took 0.013269 seconds to execute
May 12 19:04:31 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.014 - - 0
May 12 19:04:31 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:31 sogod [19704]: <0x0x7f519081f0b8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:31 sogod [19704]: |SOGo| request took 0.011510 seconds to execute
May 12 19:04:31 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.013 - - 0
May 12 19:04:31 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:31 sogod [19704]: |SOGo| request took 0.001813 seconds to execute
May 12 19:04:31 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:31 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:31 sogod [19704]: <0x0x7f5190fdea78[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:31 sogod [19704]: <0x0x7f5190fdea78[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:31 sogod [19704]: |SOGo| request took 0.386453 seconds to execute
May 12 19:04:31 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.387 - - -124K
May 12 19:04:32 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:32 sogod [19704]: <0x0x7f519133c018[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:32 sogod [19704]: |SOGo| request took 0.022467 seconds to execute
May 12 19:04:32 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.024 - - 0
May 12 19:04:32 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:32 sogod [19704]: <0x0x7f519100ac58[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:32 sogod [19704]: |SOGo| request took 0.017134 seconds to execute
May 12 19:04:32 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.018 - - 0
May 12 19:04:33 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:33 sogod [19704]: <0x0x7f519081e348[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:33 sogod [19704]: |SOGo| request took 0.017045 seconds to execute
May 12 19:04:33 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.019 - - 0
May 12 19:04:33 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:33 sogod [19704]: <0x0x7f5190fe4118[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:33 sogod [19704]: |SOGo| request took 0.019596 seconds to execute
May 12 19:04:33 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.021 - - -336K
May 12 19:04:33 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:33 sogod [19704]: <0x0x7f5191340848[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:33 sogod [19704]: |SOGo| request took 0.011999 seconds to execute
May 12 19:04:33 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.013 - - 0
May 12 19:04:33 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:33 sogod [19704]: <0x0x7f5191346f68[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:33 sogod [19704]: |SOGo| request took 0.012113 seconds to execute
May 12 19:04:33 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.013 - - 0
May 12 19:04:34 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:34 sogod [19704]: <0x0x7f5191338db8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>480</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2F43ff0f1981daed5084110000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2Fd7a7e42c75d2a153472f00007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fusera_A_example_D_net_personal</Id>
   <Class>Calendar</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:04:34 sogod [19704]: <0x0x7f5191338db8[SOGoActiveSyncDispatcher]> Change detected using Ping, we let the EAS client know to send a Sync.
May 12 19:04:34 sogod [19704]: <0x0x7f5191338db8[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>2</Status>
 <Folders>
  <Folder>mail%2F43ff0f1981daed5084110000f0c6d462</Folder>
  <Folder>mail%2Fd7a7e42c75d2a153472f00007c417c47</Folder>
 </Folders>
</Ping>

May 12 19:04:34 sogod [19704]: |SOGo| request took 0.522730 seconds to execute
May 12 19:04:34 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 101/443 0.569 - - 1M
May 12 19:04:34 sogod [19698]: [WARN] <0x0x7f5190a6f278[WOWatchDogChild]> pid 19709 has been hanging in the same request for 1 minutes
May 12 19:04:35 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:35 sogod [19704]: |SOGo| request took 0.001903 seconds to execute
May 12 19:04:35 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:35 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:35 sogod [19704]: <0x0x7f519133f1a8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:35 sogod [19704]: <0x0x7f519133f1a8[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:35 sogod [19704]: |SOGo| request took 0.390219 seconds to execute
May 12 19:04:35 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.391 - - -412K
May 12 19:04:35 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:35 sogod [19704]: <0x0x7f5191333a18[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:35 sogod [19704]: |SOGo| request took 0.022356 seconds to execute
May 12 19:04:35 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.024 - - 0
May 12 19:04:36 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 30 seconds while detecting changes in Ping...
May 12 19:04:36 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:36 sogod [19704]: <0x0x7f5190ded238[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:36 sogod [19704]: |SOGo| request took 0.019812 seconds to execute
May 12 19:04:36 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.021 - - 0
May 12 19:04:36 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:36 sogod [19704]: <0x0x7f5191053618[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:36 sogod [19704]: |SOGo| request took 0.015161 seconds to execute
May 12 19:04:36 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.017 - - 0
May 12 19:04:36 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:36 sogod [19704]: <0x0x7f51907c2218[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:36 sogod [19704]: |SOGo| request took 0.018718 seconds to execute
May 12 19:04:36 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.020 - - 0
May 12 19:04:36 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:36 sogod [19704]: <0x0x7f5191340848[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:36 sogod [19704]: |SOGo| request took 0.014095 seconds to execute
May 12 19:04:36 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.016 - - 0
May 12 19:04:37 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:37 sogod [19704]: <0x0x7f51913272c8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:37 sogod [19704]: |SOGo| request took 0.012979 seconds to execute
May 12 19:04:37 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.014 - - 0
May 12 19:04:37 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:37 sogod [19704]: |SOGo| request took 0.001764 seconds to execute
May 12 19:04:37 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:37 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:37 sogod [19704]: <0x0x7f519133d908[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:37 sogod [19704]: <0x0x7f519133d908[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:37 sogod [19704]: |SOGo| request took 0.311284 seconds to execute
May 12 19:04:37 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.312 - - 0
May 12 19:04:38 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:38 sogod [19704]: <0x0x7f51913332b8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:38 sogod [19704]: |SOGo| request took 0.023482 seconds to execute
May 12 19:04:38 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.025 - - 0
May 12 19:04:38 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:38 sogod [19704]: <0x0x7f5191340848[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:38 sogod [19704]: |SOGo| request took 0.013528 seconds to execute
May 12 19:04:38 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.015 - - 0
May 12 19:04:38 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:38 sogod [19704]: <0x0x7f5190fe2ea8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:38 sogod [19704]: |SOGo| request took 0.014629 seconds to execute
May 12 19:04:38 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.016 - - 0
May 12 19:04:38 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:38 sogod [19704]: <0x0x7f5190bbc5a8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:38 sogod [19704]: |SOGo| request took 0.020250 seconds to execute
May 12 19:04:38 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.021 - - 0
May 12 19:04:39 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:39 sogod [19704]: <0x0x7f519104e228[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:39 sogod [19704]: |SOGo| request took 0.012703 seconds to execute
May 12 19:04:39 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.014 - - 0
May 12 19:04:40 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:41 sogod [19704]: <0x0x7f5190e083f8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:41 sogod [19704]: |SOGo| request took 0.013380 seconds to execute
May 12 19:04:41 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.015 - - 0
May 12 19:04:41 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 25 seconds while detecting changes in Ping...
May 12 19:04:41 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:41 sogod [19704]: <0x0x7f51912edf08[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>480</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2F43ff0f1981daed5084110000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2Fd7a7e42c75d2a153472f00007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fusera_A_example_D_net_personal</Id>
   <Class>Calendar</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:04:41 sogod [19704]: <0x0x7f51912edf08[SOGoActiveSyncDispatcher]> Change detected using Ping, we let the EAS client know to send a Sync.
May 12 19:04:41 sogod [19704]: <0x0x7f51912edf08[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>2</Status>
 <Folders>
  <Folder>mail%2F43ff0f1981daed5084110000f0c6d462</Folder>
  <Folder>mail%2Fd7a7e42c75d2a153472f00007c417c47</Folder>
 </Folders>
</Ping>

May 12 19:04:41 sogod [19704]: |SOGo| request took 0.525705 seconds to execute
May 12 19:04:41 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 101/443 0.572 - - 260K
May 12 19:04:42 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:42 sogod [19704]: |SOGo| request took 0.002073 seconds to execute
May 12 19:04:42 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:42 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:42 sogod [19704]: <0x0x7f5191321b08[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:43 sogod [19704]: <0x0x7f5191321b08[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:43 sogod [19704]: |SOGo| request took 0.389006 seconds to execute
May 12 19:04:43 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.390 - - -412K
May 12 19:04:43 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:43 sogod [19704]: <0x0x7f519133e0f8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:43 sogod [19704]: |SOGo| request took 0.016342 seconds to execute
May 12 19:04:43 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.018 - - 0
May 12 19:04:43 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:43 sogod [19704]: <0x0x7f51907bd8c8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:43 sogod [19704]: |SOGo| request took 0.019830 seconds to execute
May 12 19:04:43 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.022 - - 0
May 12 19:04:44 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:44 sogod [19704]: <0x0x7f5191331718[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:44 sogod [19704]: |SOGo| request took 0.014920 seconds to execute
May 12 19:04:44 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.016 - - 0
May 12 19:04:45 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:45 sogod [19704]: <0x0x7f519134e378[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:45 sogod [19704]: |SOGo| request took 0.020927 seconds to execute
May 12 19:04:45 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.022 - - 0
May 12 19:04:45 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:45 sogod [19704]: <0x0x7f519130d378[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:45 sogod [19704]: |SOGo| request took 0.013897 seconds to execute
May 12 19:04:45 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.015 - - 0
May 12 19:04:45 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:45 sogod [19704]: <0x0x7f51912f1128[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:46 sogod [19704]: |SOGo| request took 0.013022 seconds to execute
May 12 19:04:46 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.015 - - 0
May 12 19:04:46 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 20 seconds while detecting changes in Ping...
May 12 19:04:46 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:46 sogod [19704]: |SOGo| request took 0.001783 seconds to execute
May 12 19:04:46 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:46 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:46 sogod [19704]: <0x0x7f51912eeee8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:46 sogod [19704]: <0x0x7f51912eeee8[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:46 sogod [19704]: |SOGo| request took 0.384148 seconds to execute
May 12 19:04:46 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.385 - - 0
May 12 19:04:46 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:46 sogod [19704]: <0x0x7f5190e37268[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:46 sogod [19704]: |SOGo| request took 0.020106 seconds to execute
May 12 19:04:46 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.022 - - 0
May 12 19:04:47 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:47 sogod [19704]: <0x0x7f5191314588[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:47 sogod [19704]: |SOGo| request took 0.015234 seconds to execute
May 12 19:04:47 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.016 - - 0
May 12 19:04:47 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:47 sogod [19704]: <0x0x7f5190e37268[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:47 sogod [19704]: |SOGo| request took 0.012250 seconds to execute
May 12 19:04:47 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.013 - - 0
May 12 19:04:48 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:48 sogod [19704]: <0x0x7f5191314588[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:48 sogod [19704]: |SOGo| request took 0.019443 seconds to execute
May 12 19:04:48 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.021 - - 0
May 12 19:04:48 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:48 sogod [19704]: <0x0x7f519134c708[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:48 sogod [19704]: |SOGo| request took 0.013036 seconds to execute
May 12 19:04:48 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.014 - - 0
May 12 19:04:48 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:48 sogod [19704]: <0x0x7f51912f97e8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:48 sogod [19704]: |SOGo| request took 0.012676 seconds to execute
May 12 19:04:48 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.014 - - 0
May 12 19:04:48 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:48 sogod [19704]: <0x0x7f5190d49cf8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>480</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2F43ff0f1981daed5084110000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2Fd7a7e42c75d2a153472f00007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fusera_A_example_D_net_personal</Id>
   <Class>Calendar</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:04:49 sogod [19704]: <0x0x7f5190d49cf8[SOGoActiveSyncDispatcher]> Change detected using Ping, we let the EAS client know to send a Sync.
May 12 19:04:49 sogod [19704]: <0x0x7f5190d49cf8[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>2</Status>
 <Folders>
  <Folder>mail%2F43ff0f1981daed5084110000f0c6d462</Folder>
  <Folder>mail%2Fd7a7e42c75d2a153472f00007c417c47</Folder>
 </Folders>
</Ping>

May 12 19:04:49 sogod [19704]: |SOGo| request took 0.521779 seconds to execute
May 12 19:04:49 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 101/443 0.569 - - 260K
May 12 19:04:50 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:50 sogod [19704]: |SOGo| request took 0.001906 seconds to execute
May 12 19:04:50 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:50 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:50 sogod [19704]: <0x0x7f5190e71ef8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:50 sogod [19704]: <0x0x7f5190e71ef8[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:50 sogod [19704]: |SOGo| request took 0.387082 seconds to execute
May 12 19:04:50 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.388 - - -412K
May 12 19:04:51 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:51 sogod [19704]: <0x0x7f51912e3978[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:51 sogod [19704]: |SOGo| request took 0.026710 seconds to execute
May 12 19:04:51 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.028 - - 0
May 12 19:04:51 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 15 seconds while detecting changes in Ping...
May 12 19:04:51 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:51 sogod [19704]: <0x0x7f5190fdf258[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:51 sogod [19704]: |SOGo| request took 0.016398 seconds to execute
May 12 19:04:51 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.018 - - 0
May 12 19:04:51 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:51 sogod [19704]: <0x0x7f5191330958[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:51 sogod [19704]: |SOGo| request took 0.013838 seconds to execute
May 12 19:04:51 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.015 - - 0
May 12 19:04:52 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:52 sogod [19704]: <0x0x7f51909c6248[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:52 sogod [19704]: |SOGo| request took 0.016683 seconds to execute
May 12 19:04:52 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.018 - - 0
May 12 19:04:52 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:52 sogod [19704]: <0x0x7f5191324a68[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:52 sogod [19704]: |SOGo| request took 0.011693 seconds to execute
May 12 19:04:52 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.013 - - 0
May 12 19:04:52 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:52 sogod [19704]: <0x0x7f519132a398[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:52 sogod [19704]: |SOGo| request took 0.009649 seconds to execute
May 12 19:04:52 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.011 - - 0
May 12 19:04:52 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:52 sogod [19704]: |SOGo| request took 0.001792 seconds to execute
May 12 19:04:52 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:52 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:52 sogod [19704]: <0x0x7f5191309d38[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:53 sogod [19704]: <0x0x7f5191309d38[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:53 sogod [19704]: |SOGo| request took 0.387368 seconds to execute
May 12 19:04:53 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.388 - - 0
May 12 19:04:53 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:53 sogod [19704]: <0x0x7f5191326cc8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:53 sogod [19704]: |SOGo| request took 0.022296 seconds to execute
May 12 19:04:53 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.024 - - 0
May 12 19:04:53 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:53 sogod [19704]: <0x0x7f5191303348[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:53 sogod [19704]: |SOGo| request took 0.019032 seconds to execute
May 12 19:04:53 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.021 - - 0
May 12 19:04:54 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:54 sogod [19704]: <0x0x7f519133dee8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:54 sogod [19704]: |SOGo| request took 0.020224 seconds to execute
May 12 19:04:54 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.022 - - 0
May 12 19:04:54 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:54 sogod [19704]: <0x0x7f5191314588[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:54 sogod [19704]: |SOGo| request took 0.019834 seconds to execute
May 12 19:04:54 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.021 - - 0
May 12 19:04:55 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:55 sogod [19704]: <0x0x7f5191056d78[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:55 sogod [19704]: |SOGo| request took 0.012628 seconds to execute
May 12 19:04:55 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.014 - - 0
May 12 19:04:55 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:55 sogod [19704]: <0x0x7f519132fdc8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:55 sogod [19704]: |SOGo| request took 0.012660 seconds to execute
May 12 19:04:55 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.014 - - 0
May 12 19:04:55 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:55 sogod [19704]: <0x0x7f51912e1c48[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>480</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2F43ff0f1981daed5084110000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2Fd7a7e42c75d2a153472f00007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fusera_A_example_D_net_personal</Id>
   <Class>Calendar</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:04:56 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 10 seconds while detecting changes in Ping...
May 12 19:04:56 sogod [19704]: <0x0x7f51912e1c48[SOGoActiveSyncDispatcher]> Change detected using Ping, we let the EAS client know to send a Sync.
May 12 19:04:56 sogod [19704]: <0x0x7f51912e1c48[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>2</Status>
 <Folders>
  <Folder>mail%2F43ff0f1981daed5084110000f0c6d462</Folder>
  <Folder>mail%2Fd7a7e42c75d2a153472f00007c417c47</Folder>
 </Folders>
</Ping>

May 12 19:04:56 sogod [19704]: |SOGo| request took 0.535363 seconds to execute
May 12 19:04:56 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 101/443 0.583 - - 260K
May 12 19:04:56 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:56 sogod [19704]: |SOGo| request took 0.001603 seconds to execute
May 12 19:04:56 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:57 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:57 sogod [19704]: <0x0x7f5190e8aa28[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:04:57 sogod [19704]: <0x0x7f5190e8aa28[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:04:57 sogod [19704]: |SOGo| request took 0.378405 seconds to execute
May 12 19:04:57 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.379 - - -412K
May 12 19:04:57 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:57 sogod [19704]: <0x0x7f51912e1c48[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:57 sogod [19704]: |SOGo| request took 0.022054 seconds to execute
May 12 19:04:57 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.024 - - 0
May 12 19:04:58 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:58 sogod [19704]: <0x0x7f51912eb3b8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:58 sogod [19704]: |SOGo| request took 0.013049 seconds to execute
May 12 19:04:58 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.014 - - 0
May 12 19:04:58 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:58 sogod [19704]: <0x0x7f519133d1c8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:58 sogod [19704]: |SOGo| request took 0.016799 seconds to execute
May 12 19:04:58 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.018 - - 0
May 12 19:04:58 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:58 sogod [19704]: <0x0x7f5190fe0a68[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:58 sogod [19704]: |SOGo| request took 0.021211 seconds to execute
May 12 19:04:58 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.022 - - 0
May 12 19:04:59 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:59 sogod [19704]: <0x0x7f519104e228[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:59 sogod [19704]: |SOGo| request took 0.013421 seconds to execute
May 12 19:04:59 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.015 - - 0
May 12 19:04:59 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:59 sogod [19704]: <0x0x7f5190fdeda8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:04:59 sogod [19704]: |SOGo| request took 0.013021 seconds to execute
May 12 19:04:59 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.014 - - 0
May 12 19:04:59 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:04:59 sogod [19704]: |SOGo| request took 0.001739 seconds to execute
May 12 19:04:59 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:04:59 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:04:59 sogod [19704]: <0x0x7f5191352b98[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:05:00 sogod [19704]: <0x0x7f5191352b98[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:05:00 sogod [19704]: |SOGo| request took 0.390858 seconds to execute
May 12 19:05:00 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.392 - - 0
May 12 19:05:00 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:00 sogod [19704]: <0x0x7f5190e0b0f8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:00 sogod [19704]: |SOGo| request took 0.023356 seconds to execute
May 12 19:05:00 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.025 - - 0
May 12 19:05:01 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 5 seconds while detecting changes in Ping...
May 12 19:05:01 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:01 sogod [19704]: <0x0x7f5190fe69b8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:01 sogod [19704]: |SOGo| request took 0.015947 seconds to execute
May 12 19:05:01 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.017 - - 0
May 12 19:05:01 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:01 sogod [19704]: <0x0x7f5191311308[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:01 sogod [19704]: |SOGo| request took 0.017114 seconds to execute
May 12 19:05:01 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.019 - - 0
May 12 19:05:01 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:01 sogod [19704]: <0x0x7f5191321fb8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:01 sogod [19704]: |SOGo| request took 0.021246 seconds to execute
May 12 19:05:01 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.023 - - 0
May 12 19:05:02 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:02 sogod [19704]: <0x0x7f5191311308[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:02 sogod [19704]: |SOGo| request took 0.013538 seconds to execute
May 12 19:05:02 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.015 - - 0
May 12 19:05:02 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:02 sogod [19704]: <0x0x7f5191346448[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:02 sogod [19704]: |SOGo| request took 0.013156 seconds to execute
May 12 19:05:02 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.014 - - 0
May 12 19:05:02 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:02 sogod [19704]: <0x0x7f5190e400d8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>480</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2F43ff0f1981daed5084110000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2Fd7a7e42c75d2a153472f00007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fusera_A_example_D_net_personal</Id>
   <Class>Calendar</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:05:03 sogod [19704]: <0x0x7f5190e400d8[SOGoActiveSyncDispatcher]> Change detected using Ping, we let the EAS client know to send a Sync.
May 12 19:05:03 sogod [19704]: <0x0x7f5190e400d8[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>2</Status>
 <Folders>
  <Folder>mail%2F43ff0f1981daed5084110000f0c6d462</Folder>
  <Folder>mail%2Fd7a7e42c75d2a153472f00007c417c47</Folder>
 </Folders>
</Ping>

May 12 19:05:03 sogod [19704]: |SOGo| request took 0.530286 seconds to execute
May 12 19:05:03 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 101/443 0.579 - - 260K
May 12 19:05:03 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:05:03 sogod [19704]: |SOGo| request took 0.001905 seconds to execute
May 12 19:05:03 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:05:03 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:03 sogod [19704]: <0x0x7f51913533b8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:05:04 sogod [19704]: <0x0x7f51913533b8[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:05:04 sogod [19704]: |SOGo| request took 0.382136 seconds to execute
May 12 19:05:04 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.383 - - -596K
May 12 19:05:04 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:04 sogod [19704]: <0x0x7f51912e5e68[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:04 sogod [19704]: |SOGo| request took 0.021558 seconds to execute
May 12 19:05:04 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.023 - - 0
May 12 19:05:05 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:05 sogod [19704]: <0x0x7f5190e8ef98[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:05 sogod [19704]: |SOGo| request took 0.016517 seconds to execute
May 12 19:05:05 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.018 - - 0
May 12 19:05:05 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:05 sogod [19704]: <0x0x7f51912f3818[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:05 sogod [19704]: |SOGo| request took 0.016695 seconds to execute
May 12 19:05:05 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.018 - - 0
May 12 19:05:06 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:06 sogod [19704]: <0x0x7f519135c648[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:06 sogod [19704]: |SOGo| request took 0.022477 seconds to execute
May 12 19:05:06 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.024 - - 0
May 12 19:05:06 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 30 seconds while detecting changes in Ping...
May 12 19:05:06 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:06 sogod [19704]: <0x0x7f5190e36668[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:06 sogod [19704]: |SOGo| request took 0.012709 seconds to execute
May 12 19:05:06 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.014 - - 0
May 12 19:05:06 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:06 sogod [19704]: <0x0x7f5191321b08[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:06 sogod [19704]: |SOGo| request took 0.013219 seconds to execute
May 12 19:05:06 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.015 - - 0
May 12 19:05:06 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:05:06 sogod [19704]: |SOGo| request took 0.001849 seconds to execute
May 12 19:05:06 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:05:07 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:07 sogod [19704]: <0x0x7f51912fbc18[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:05:07 sogod [19704]: <0x0x7f51912fbc18[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:05:07 sogod [19704]: |SOGo| request took 0.394317 seconds to execute
May 12 19:05:07 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.395 - - 0
May 12 19:05:07 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:07 sogod [19704]: <0x0x7f51913067a8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:07 sogod [19704]: |SOGo| request took 0.021694 seconds to execute
May 12 19:05:07 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.023 - - 0
May 12 19:05:08 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:08 sogod [19704]: <0x0x7f51912ef6a8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:08 sogod [19704]: |SOGo| request took 0.018056 seconds to execute
May 12 19:05:08 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.019 - - 0
May 12 19:05:08 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:08 sogod [19704]: <0x0x7f51912f2008[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:08 sogod [19704]: |SOGo| request took 0.016908 seconds to execute
May 12 19:05:08 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.018 - - 0
May 12 19:05:08 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:08 sogod [19704]: <0x0x7f51912ef6a8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:08 sogod [19704]: |SOGo| request took 0.016104 seconds to execute
May 12 19:05:08 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.017 - - 0
May 12 19:05:10 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:10 sogod [19704]: <0x0x7f51912f2008[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:10 sogod [19704]: |SOGo| request took 0.011832 seconds to execute
May 12 19:05:10 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.013 - - 0
May 12 19:05:10 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:10 sogod [19704]: <0x0x7f5190b7b168[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:10 sogod [19704]: |SOGo| request took 0.013091 seconds to execute
May 12 19:05:10 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.015 - - 0
May 12 19:05:10 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:10 sogod [19704]: <0x0x7f519132fc88[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>480</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2F43ff0f1981daed5084110000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2Fd7a7e42c75d2a153472f00007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fusera_A_example_D_net_personal</Id>
   <Class>Calendar</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:05:11 sogod [19704]: <0x0x7f519132fc88[SOGoActiveSyncDispatcher]> Change detected using Ping, we let the EAS client know to send a Sync.
May 12 19:05:11 sogod [19704]: <0x0x7f519132fc88[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>2</Status>
 <Folders>
  <Folder>mail%2F43ff0f1981daed5084110000f0c6d462</Folder>
  <Folder>mail%2Fd7a7e42c75d2a153472f00007c417c47</Folder>
 </Folders>
</Ping>

May 12 19:05:11 sogod [19704]: |SOGo| request took 0.533589 seconds to execute
May 12 19:05:11 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 101/443 0.583 - - 524K
May 12 19:05:11 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 25 seconds while detecting changes in Ping...
May 12 19:05:11 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:05:11 sogod [19704]: |SOGo| request took 0.001662 seconds to execute
May 12 19:05:11 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:05:12 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:12 sogod [19704]: <0x0x7f5190e94f78[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:05:12 sogod [19704]: <0x0x7f5190e94f78[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:05:12 sogod [19704]: |SOGo| request took 0.386213 seconds to execute
May 12 19:05:12 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.387 - - -412K
May 12 19:05:16 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 20 seconds while detecting changes in Ping...
May 12 19:05:16 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:16 sogod [19704]: <0x0x7f5191323eb8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:16 sogod [19704]: |SOGo| request took 0.022230 seconds to execute
May 12 19:05:16 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.024 - - 0
May 12 19:05:16 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:16 sogod [19704]: <0x0x7f5190fd9468[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:16 sogod [19704]: |SOGo| request took 0.017847 seconds to execute
May 12 19:05:16 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.019 - - 0
May 12 19:05:18 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:18 sogod [19704]: <0x0x7f5190e53e08[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:18 sogod [19704]: |SOGo| request took 0.017469 seconds to execute
May 12 19:05:18 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.019 - - 0
May 12 19:05:18 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:18 sogod [19704]: <0x0x7f51913597a8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:18 sogod [19704]: |SOGo| request took 0.019714 seconds to execute
May 12 19:05:18 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.021 - - 0
May 12 19:05:18 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:18 sogod [19704]: <0x0x7f5190e36a68[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:18 sogod [19704]: |SOGo| request took 0.012901 seconds to execute
May 12 19:05:18 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.014 - - 0
May 12 19:05:18 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:18 sogod [19704]: <0x0x7f51912f5a28[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:18 sogod [19704]: |SOGo| request took 0.012127 seconds to execute
May 12 19:05:18 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.013 - - 0
May 12 19:05:18 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:05:18 sogod [19704]: |SOGo| request took 0.001767 seconds to execute
May 12 19:05:18 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:05:19 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:19 sogod [19704]: <0x0x7f5190db4a28[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:05:19 sogod [19704]: <0x0x7f5190db4a28[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:05:19 sogod [19704]: |SOGo| request took 0.390220 seconds to execute
May 12 19:05:19 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.391 - - 0
May 12 19:05:19 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:19 sogod [19704]: <0x0x7f519081ee58[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:19 sogod [19704]: |SOGo| request took 0.021757 seconds to execute
May 12 19:05:19 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.023 - - 0
May 12 19:05:20 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:20 sogod [19704]: <0x0x7f5191353b68[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:20 sogod [19704]: |SOGo| request took 0.016532 seconds to execute
May 12 19:05:20 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.017 - - 0
May 12 19:05:20 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:20 sogod [19704]: <0x0x7f5191003828[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:20 sogod [19704]: |SOGo| request took 0.014417 seconds to execute
May 12 19:05:20 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.015 - - 0
May 12 19:05:20 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:20 sogod [19704]: <0x0x7f5191330e08[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:20 sogod [19704]: |SOGo| request took 0.019113 seconds to execute
May 12 19:05:20 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.021 - - 0
May 12 19:05:20 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:20 sogod [19704]: <0x0x7f5190e04158[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:20 sogod [19704]: |SOGo| request took 0.009388 seconds to execute
May 12 19:05:20 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.010 - - 0
May 12 19:05:21 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:21 sogod [19704]: <0x0x7f5190e8e568[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:21 sogod [19704]: |SOGo| request took 0.012169 seconds to execute
May 12 19:05:21 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.014 - - 0
May 12 19:05:21 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> Sleeping 15 seconds while detecting changes in Ping...
May 12 19:05:21 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:21 sogod [19704]: <0x0x7f5191330a78[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <HeartbeatInterval>480</HeartbeatInterval>
 <Folders>
  <Folder>
   <Id>mail%2F43ff0f1981daed5084110000f0c6d462</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>mail%2Fd7a7e42c75d2a153472f00007c417c47</Id>
   <Class>Email</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fpersonal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fuserc_A_example_D_co_D_uk_personal</Id>
   <Class>Calendar</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fpersonal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vcard%2Fuserd_A_example_D_co_D_uk_personal</Id>
   <Class>Contacts</Class>
  </Folder>
  <Folder>
   <Id>vevent%2Fusera_A_example_D_net_personal</Id>
   <Class>Calendar</Class>
  </Folder>
 </Folders>
</Ping>

May 12 19:05:22 sogod [19704]: <0x0x7f5191330a78[SOGoActiveSyncDispatcher]> Change detected using Ping, we let the EAS client know to send a Sync.
May 12 19:05:22 sogod [19704]: <0x0x7f5191330a78[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>2</Status>
 <Folders>
  <Folder>mail%2F43ff0f1981daed5084110000f0c6d462</Folder>
  <Folder>mail%2Fd7a7e42c75d2a153472f00007c417c47</Folder>
 </Folders>
</Ping>

May 12 19:05:22 sogod [19704]: |SOGo| request took 0.526012 seconds to execute
May 12 19:05:22 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 101/443 0.573 - - 260K
May 12 19:05:22 sogod [19704]: |SOGo| starting method 'OPTIONS' on uri '/SOGo/Microsoft-Server-ActiveSync'
May 12 19:05:22 sogod [19704]: |SOGo| request took 0.001941 seconds to execute
May 12 19:05:22 sogod [19704]: 82.132.224.26 "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.1" 200 0/0 0.003 - - 0
May 12 19:05:22 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:22 sogod [19704]: <0x0x7f519133fd28[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
</FolderSync>

May 12 19:05:23 sogod [19704]: <0x0x7f519133fd28[SOGoActiveSyncDispatcher]> EAS - response for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<FolderSync xmlns="FolderHierarchy:">
 <Status>1</Status>
 <SyncKey>server_example_net_2761_1ce4ee10_3</SyncKey>
 <Changes>
  <Count>0</Count>
 </Changes>
</FolderSync>

May 12 19:05:23 sogod [19704]: |SOGo| request took 0.380189 seconds to execute
May 12 19:05:23 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 58/46 0.381 - - -412K
May 12 19:05:23 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:23 sogod [19704]: <0x0x7f519081f0b8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462617107</SyncKey>
   <CollectionId>vevent%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:23 sogod [19704]: |SOGo| request took 0.021813 seconds to execute
May 12 19:05:23 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/79 0.023 - - 0
May 12 19:05:23 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:23 sogod [19704]: <0x0x7f519133d1c8[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463063612</SyncKey>
   <CollectionId>vevent%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:23 sogod [19704]: |SOGo| request took 0.019643 seconds to execute
May 12 19:05:23 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/109 0.021 - - 0
May 12 19:05:24 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:24 sogod [19704]: <0x0x7f5191317a98[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462898132</SyncKey>
   <CollectionId>vevent%2Fuserc_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:24 sogod [19704]: |SOGo| request took 0.014374 seconds to execute
May 12 19:05:24 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/108 0.016 - - 0
May 12 19:05:24 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:24 sogod [19704]: <0x0x7f519134c708[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463072977</SyncKey>
   <CollectionId>vevent%2Fusera_A_example_D_net_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <FilterType>4</FilterType>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:24 sogod [19704]: |SOGo| request took 0.015814 seconds to execute
May 12 19:05:24 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/100 0.017 - - 0
May 12 19:05:25 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:25 sogod [19704]: <0x0x7f51912ea338[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1463035563</SyncKey>
   <CollectionId>vcard%2Fpersonal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:25 sogod [19704]: |SOGo| request took 0.012530 seconds to execute
May 12 19:05:25 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/73 0.014 - - 0
May 12 19:05:25 sogod [19704]: |SOGo| starting method 'POST' on uri '/SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android'
May 12 19:05:25 sogod [19704]: <0x0x7f5191343388[SOGoActiveSyncDispatcher]> EAS - request for device android2989930679: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Sync xmlns="AirSync:">
 <Collections>
  <Collection>
   <SyncKey>1462983897</SyncKey>
   <CollectionId>vcard%2Fuserd_A_example_D_co_D_uk_personal</CollectionId>
   <DeletesAsMoves/>
   <GetChanges/>
   <WindowSize>10</WindowSize>
   <Options>
    <BodyPreference xmlns="AirSyncBase:">
     <Type>1</Type>
     <TruncationSize>200000</TruncationSize>
    </BodyPreference>
   </Options>
  </Collection>
 </Collections>
</Sync>

May 12 19:05:25 sogod [19704]: |SOGo| request took 0.012317 seconds to execute
May 12 19:05:25 sogod [19704]: 82.132.224.26 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Sync&User=userb%40example.co.uk&DeviceId=android2989930679&DeviceType=Android HTTP/1.1" 200 0/103 0.014 - - 0
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6f4b8[WOWatchDogChild]> sending terminate signal to pid 19710
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6f278[WOWatchDogChild]> sending terminate signal to pid 19709
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6edf8[WOWatchDogChild]> sending terminate signal to pid 19708
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6ecd8[WOWatchDogChild]> sending terminate signal to pid 19707
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6ea08[WOWatchDogChild]> sending terminate signal to pid 19706
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6e7a8[WOWatchDogChild]> sending terminate signal to pid 19705
2016-05-12 19:05:25.257 sogod[19709] Forcing termination of EAS loop.
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6e688[WOWatchDogChild]> sending terminate signal to pid 19704
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6dc68[WOWatchDogChild]> sending terminate signal to pid 19703
May 12 19:05:25 sogod [19698]: <0x0x7f5190a761b8[WOWatchDogChild]> sending terminate signal to pid 19702
May 12 19:05:25 sogod [19698]: <0x0x7f5190a4bb48[WOWatchDogChild]> sending terminate signal to pid 19701
May 12 19:05:25 sogod [19709]: <0x0x7f5191238358[SOGoActiveSyncDispatcher]> EAS - response for device android3000786125: <?xml version="1.0"?>
<!DOCTYPE ActiveSync PUBLIC "-//MICROSOFT//DTD ActiveSync//EN" "http://www.microsoft.com/">
<Ping xmlns="Ping:">
 <Status>1</Status>
</Ping>

May 12 19:05:25 sogod [19709]: |SOGo| request took 110.588123 seconds to execute
May 12 19:05:25 sogod [19709]: 10.42.0.118 "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=usera%40example.net&DeviceId=android3000786125&DeviceType=Android HTTP/1.1" 200 13/452 110.593 - - 12M
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6f278[WOWatchDogChild]> sending terminate signal to pid 19709
2016-05-12 19:05:25.262 sogod[19704] Forcing termination of EAS loop.
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6ecd8[WOWatchDogChild]> child 19707 exited2016-05-12 19:05:25.262 sogod[19709] Forcing termination of EAS loop.

May 12 19:05:25 sogod [19698]: <0x0x7f5190a6edf8[WOWatchDogChild]> child 19708 exited
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190a761b8[WOWatchDogChild]> child 19702 exited
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190a4bb48[WOWatchDogChild]> child 19701 exited
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6f4b8[WOWatchDogChild]> child 19710 exited
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6dc68[WOWatchDogChild]> child 19703 exited
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6e7a8[WOWatchDogChild]> child 19705 exited
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190a6ea08[WOWatchDogChild]> child 19706 exited
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:25 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190a6f278[WOWatchDogChild]> child 19709 exited
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> Terminating with SIGINT or SIGTERM
May 12 19:05:26 sogod [19698]: <0x0x7f5190a6e688[WOWatchDogChild]> child 19704 exited
May 12 19:05:26 sogod [19698]: <0x0x7f5190aa0918[WOWatchDog]> all children exited. We now terminate.
sogo.log (173,793 bytes)   
dsp3

dsp3

2016-05-13 12:16

reporter   ~0010134

I can confirm this. However, the behavior isn't limited to SOGo. It happens on other EAS enabled servers. The problem started when Android updated Exchange Services to Version 6.4.121434427.release A quick look at the Play Store and you will see how many other people have been affected by this 'upgrade.'

ludovic

ludovic

2016-05-13 12:19

administrator   ~0010135

The problem only happens if you disable mail sync? ie., whenever mail sync is also enabled, it works as expected?

dsp3

dsp3

2016-05-13 13:04

reporter   ~0010136

That appears to be the case, although more time is needed to be certain.

McMichaeli

McMichaeli

2016-05-13 13:32

reporter   ~0010137

After extensive testing yesterday, before logging this bug, I can confirm that the loop only occurs if email sync is disabled on the client end.

I was aware of the Exchange Services update from Google and at one stage tested with it removed (which should have returned to the original Android 6.0.1 behaviour). I even rebooted the phone and the sync loop restarted as soon as it reconnected to the network.

The workaround, at the moment, is to enable email sync and limit it to one day's history, no attachments and no notifications. Although it is not wanted (or desired with Google's horrible GMail client!) the bandwidth wasted this way is considerably less than the continuous sync that ensues if I disable email sync!

ludovic

ludovic

2016-09-29 19:53

administrator   ~0010708

I don't have this issue with the latest development version + Android 6. Retry.

McMichaeli

McMichaeli

2016-10-07 10:13

reporter   ~0010725

Sorry it took a while to re-test this. In the end I have used the release version of SOGo 3.2.0 and Android 6.0.1 build M4B30X running on a stock Nexus 5.

I deleted the pre-existing Exchange account on the Android device and ran a "sogo-tool manage-eas resetdevice" on the server end. I then proceeded to re-add the account via Android with the Sync e-mail box de-selected.

Initial sync completed fine and subsequent updates have not generated a sync loop. Therefore I conclude, as you did that this bug is fixed.

Many thanks.

Issue History

Date Modified Username Field Change
2016-05-12 20:21 McMichaeli New Issue
2016-05-12 20:21 McMichaeli File Added: sogo.log
2016-05-13 12:16 dsp3 Note Added: 0010134
2016-05-13 12:19 ludovic Note Added: 0010135
2016-05-13 13:04 dsp3 Note Added: 0010136
2016-05-13 13:32 McMichaeli Note Added: 0010137
2016-09-29 19:52 ludovic Severity major => minor
2016-09-29 19:53 ludovic Note Added: 0010708
2016-10-07 10:13 McMichaeli Note Added: 0010725
2016-10-07 10:52 ludovic Status new => resolved
2016-10-07 10:52 ludovic Resolution open => fixed
2016-10-07 10:52 ludovic Assigned To => ludovic