[horde] Can't sync calendar & contacts, ActiveSync, horde4, android 4.0.2

Daniel Basa daniel at luli.de
Thu Feb 2 21:18:42 UTC 2012


Am 02.02.2012 16:24, schrieb Michael J Rubinsky:
> Quoting Daniel Basa <daniel at luli.de>:
>> Am 02.02.2012 15:47, schrieb Michael J Rubinsky:
>>
>> As long as there is no other setting which i can use to squeeze more out
>> of horde, what you see aboveis the abbreviated part of my complete sync
>> log. My settings for Active Sync Logging are as follows:
>>
>> Logging
>> * $conf[activesync][logging][type] = Custom
>> * $conf[activesync][logging][path] = /path/to/activesync.log
>>
>> Horde logging is set the debug, but the messages displayed there seem to
>> be associated with syncing. (new syncing does not provide new entries
>> there)
>>
>> I got no php errors
>>
>> Here my complete activesync.log:
>
> You should have a device-specific log file in that same directory. Named
> something like androidxxxxxxxxxx.log. That's where all the entries go,
> once we know the device id. Otherwise, it's impossible to debug a
> problem on a server with more than 1 or 2 devices actively syncing :)
>
> The log you posted below looks like it was from the default
> activesync.log file, which would only receive messages when we don't
> have a device_id.
>
>> 2012-01-13T08:28:06+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon
>> attempt for:
>
> <snip>
>
>>> Even better would be a synclog AND a wiretrace, but a synclog
>>> would be the place to start. See the above mentioned wiki page for
>>> instructions if you can't find the options for activesync logging in the
>>> configuration.
>>
>> I don't know about wiretrace, but I will check out what it is and how
>> its done.
>
> Let's try the above mentioned device specific log first...

Thank you very much. I simply overlooked the device specific logfile.
I checked that logfile. I am not sure what and when horde logs stuff to
this file. But my last sync attempts where today (2012-02-02), but
neither today or yesterday anything was written to this logfile. The
last entry is from th 31st of Jnuary 2012. I don't remember exactly what
I did that day, but I think I created new accounts on my phone several
times. Is it possible that horde just logs these first logon attempts?
I also recognized that there are lines indicating a sync of mail
(inbox). I don't want to sync mail using horde (thought that would not
work?). I am using z-push to sync/push mail.

Here's the log file. I think it's five times the same log for different
login attempts. But I am not sure so I didn't snip it.

2012-01-31T15:34:42+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon
attempt for: daniel at example.com
2012-01-31T15:34:43+01:00 DEBUG: [androidc1771218180] FOLDERSYNC request
received for user daniel at example.com
2012-01-31T15:34:43+01:00 DEBUG: [androidc1771218180] Device entry does
not exist, creating it.
2012-01-31T15:34:43+01:00 DEBUG: [androidc1771218180] Device entry does
not exist for user daniel at example.com, creating it.
2012-01-31T15:34:43+01:00 INFO: Request being handled for device:
androidc1771218180 Supporting protocol version: 2.5
2012-01-31T15:34:43+01:00 INFO: [Horde_ActiveSync::handleFolderSync]
Beginning FOLDERSYNC
2012-01-31T15:34:43+01:00 DEBUG: [androidc1771218180] Checking policykey
for device  Key: 0 User: daniel at example.com
2012-01-31T15:34:43+01:00 DEBUG: [androidc1771218180] loadDeviceInfo:
daniel at example.com
2012-01-31T15:34:43+01:00 DEBUG: Policykey: 0 verified.
2012-01-31T15:34:43+01:00 DEBUG: I  <FolderHierarchy:FolderSync>
2012-01-31T15:34:43+01:00 DEBUG: I   <FolderHierarchy:SyncKey>
2012-01-31T15:34:43+01:00 DEBUG: I    0
2012-01-31T15:34:43+01:00 DEBUG: I   </FolderHierarchy:SyncKey>
2012-01-31T15:34:43+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
syncKey: 0
2012-01-31T15:34:43+01:00 DEBUG: [androidc1771218180] Resetting device
state.
2012-01-31T15:34:43+01:00 DEBUG: I  </FolderHierarchy:FolderSync>
2012-01-31T15:34:43+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
Preparing to send changes to PIM
2012-01-31T15:34:43+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
newSyncKey: {4f27fc03-61b8-486d-ab0a-3766551fbb0c}1
2012-01-31T15:34:43+01:00 DEBUG: [androidc1771218180] Initializing
folder diff engine
2012-01-31T15:34:43+01:00 DEBUG: Horde::getFolderList()
2012-01-31T15:34:43+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T15:34:43+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T15:34:43+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T15:34:43+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T15:34:43+01:00 DEBUG: [androidc1771218180] Found 4 folder changes
2012-01-31T15:34:43+01:00 DEBUG: Horde::getFolder(Tasks)
2012-01-31T15:34:43+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T15:34:43+01:00 DEBUG: Updating state during foldersync
2012-01-31T15:34:43+01:00 DEBUG: Horde::getFolder(Inbox)
2012-01-31T15:34:43+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T15:34:43+01:00 DEBUG: Updating state during foldersync
2012-01-31T15:34:43+01:00 DEBUG: Horde::getFolder(Contacts)
2012-01-31T15:34:43+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T15:34:43+01:00 DEBUG: Updating state during foldersync
2012-01-31T15:34:43+01:00 DEBUG: Horde::getFolder(Calendar)
2012-01-31T15:34:43+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T15:34:43+01:00 DEBUG: Updating state during foldersync
2012-01-31T15:34:43+01:00 DEBUG: O  <FolderHierarchy:FolderSync>
2012-01-31T15:34:43+01:00 DEBUG: O   <FolderHierarchy:Status>
2012-01-31T15:34:43+01:00 DEBUG: O    1
2012-01-31T15:34:43+01:00 DEBUG: O   <FolderHierarchy:Status/>
2012-01-31T15:34:43+01:00 DEBUG: O   <FolderHierarchy:SyncKey>
2012-01-31T15:34:43+01:00 DEBUG: O
{4f27fc03-61b8-486d-ab0a-3766551fbb0c}1
2012-01-31T15:34:43+01:00 DEBUG: O   <FolderHierarchy:SyncKey/>
2012-01-31T15:34:43+01:00 DEBUG: O   <FolderHierarchy:Changes>
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Count>
2012-01-31T15:34:43+01:00 DEBUG: O     4
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Count/>
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T15:34:43+01:00 DEBUG: O      Tasks
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T15:34:43+01:00 DEBUG: O      0
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T15:34:43+01:00 DEBUG: O      Tasks
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T15:34:43+01:00 DEBUG: O      7
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T15:34:43+01:00 DEBUG: O      Inbox
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T15:34:43+01:00 DEBUG: O      0
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T15:34:43+01:00 DEBUG: O      Inbox
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T15:34:43+01:00 DEBUG: O      2
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T15:34:43+01:00 DEBUG: O      Contacts
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T15:34:43+01:00 DEBUG: O      0
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T15:34:43+01:00 DEBUG: O      Contacts
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T15:34:43+01:00 DEBUG: O      9
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T15:34:43+01:00 DEBUG: O      Calendar
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T15:34:43+01:00 DEBUG: O      0
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T15:34:43+01:00 DEBUG: O      Calendar
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T15:34:43+01:00 DEBUG: O      8
2012-01-31T15:34:43+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T15:34:43+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T15:34:43+01:00 DEBUG: O   <FolderHierarchy:Changes/>
2012-01-31T15:34:43+01:00 DEBUG: O  <FolderHierarchy:FolderSync/>
2012-01-31T15:34:43+01:00 DEBUG: [androidc1771218180] Saving state: Array
(
    [0] => {4f27fc03-61b8-486d-ab0a-3766551fbb0c}1
    [1] =>
a:4:{i:0;a:3:{s:2:"id";s:5:"Tasks";s:3:"mod";s:5:"Tasks";s:6:"parent";i:0;}i:1;a:3:{s:2:"id";s:5:"Inbox";s:3:"mod";s:5:"Inbox";s:6:"parent";i:0;}i:2;a:3:{s:2:"id";s:8:"Contacts";s:3:"mod";s:8:"Contacts";s:6:"parent";i:0;}i:3;a:3:{s:2:"id";s:8:"Calendar";s:3:"mod";s:8:"Calendar";s:6:"parent";i:0;}}
    [2] => androidc1771218180
    [3] => 1328020483
    [4] => foldersync
    [5] => daniel at example.com
)

2012-01-31T15:34:43+01:00 INFO: User daniel at example.com logged off
2012-01-31T16:15:21+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon
attempt for: daniel at example.com
2012-01-31T16:15:21+01:00 DEBUG: [androidc1771218180] FOLDERSYNC request
received for user daniel at example.com
2012-01-31T16:15:21+01:00 DEBUG: [androidc1771218180] Device entry does
not exist, creating it.
2012-01-31T16:15:21+01:00 DEBUG: [androidc1771218180] Device entry does
not exist for user daniel at example.com, creating it.
2012-01-31T16:15:21+01:00 INFO: Request being handled for device:
androidc1771218180 Supporting protocol version: 2.5
2012-01-31T16:15:21+01:00 INFO: [Horde_ActiveSync::handleFolderSync]
Beginning FOLDERSYNC
2012-01-31T16:15:21+01:00 DEBUG: [androidc1771218180] Checking policykey
for device  Key: 0 User: daniel at example.com
2012-01-31T16:15:21+01:00 DEBUG: [androidc1771218180] loadDeviceInfo:
daniel at example.com
2012-01-31T16:15:21+01:00 DEBUG: Policykey: 0 verified.
2012-01-31T16:15:21+01:00 DEBUG: I  <FolderHierarchy:FolderSync>
2012-01-31T16:15:21+01:00 DEBUG: I   <FolderHierarchy:SyncKey>
2012-01-31T16:15:21+01:00 DEBUG: I    0
2012-01-31T16:15:21+01:00 DEBUG: I   </FolderHierarchy:SyncKey>
2012-01-31T16:15:21+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
syncKey: 0
2012-01-31T16:15:21+01:00 DEBUG: [androidc1771218180] Resetting device
state.
2012-01-31T16:15:21+01:00 DEBUG: I  </FolderHierarchy:FolderSync>
2012-01-31T16:15:21+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
Preparing to send changes to PIM
2012-01-31T16:15:21+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
newSyncKey: {4f280589-7144-4908-b72c-37c5551fbb0c}1
2012-01-31T16:15:21+01:00 DEBUG: [androidc1771218180] Initializing
folder diff engine
2012-01-31T16:15:21+01:00 DEBUG: Horde::getFolderList()
2012-01-31T16:15:21+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T16:15:21+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T16:15:21+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T16:15:21+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T16:15:21+01:00 DEBUG: [androidc1771218180] Found 4 folder changes
2012-01-31T16:15:21+01:00 DEBUG: Horde::getFolder(Tasks)
2012-01-31T16:15:21+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T16:15:21+01:00 DEBUG: Updating state during foldersync
2012-01-31T16:15:21+01:00 DEBUG: Horde::getFolder(Inbox)
2012-01-31T16:15:21+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T16:15:21+01:00 DEBUG: Updating state during foldersync
2012-01-31T16:15:21+01:00 DEBUG: Horde::getFolder(Contacts)
2012-01-31T16:15:21+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T16:15:21+01:00 DEBUG: Updating state during foldersync
2012-01-31T16:15:21+01:00 DEBUG: Horde::getFolder(Calendar)
2012-01-31T16:15:21+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T16:15:21+01:00 DEBUG: Updating state during foldersync
2012-01-31T16:15:21+01:00 DEBUG: O  <FolderHierarchy:FolderSync>
2012-01-31T16:15:21+01:00 DEBUG: O   <FolderHierarchy:Status>
2012-01-31T16:15:21+01:00 DEBUG: O    1
2012-01-31T16:15:21+01:00 DEBUG: O   <FolderHierarchy:Status/>
2012-01-31T16:15:21+01:00 DEBUG: O   <FolderHierarchy:SyncKey>
2012-01-31T16:15:21+01:00 DEBUG: O
{4f280589-7144-4908-b72c-37c5551fbb0c}1
2012-01-31T16:15:21+01:00 DEBUG: O   <FolderHierarchy:SyncKey/>
2012-01-31T16:15:21+01:00 DEBUG: O   <FolderHierarchy:Changes>
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Count>
2012-01-31T16:15:21+01:00 DEBUG: O     4
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Count/>
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T16:15:21+01:00 DEBUG: O      Tasks
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T16:15:21+01:00 DEBUG: O      0
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T16:15:21+01:00 DEBUG: O      Tasks
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T16:15:21+01:00 DEBUG: O      7
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T16:15:21+01:00 DEBUG: O      Inbox
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T16:15:21+01:00 DEBUG: O      0
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T16:15:21+01:00 DEBUG: O      Inbox
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T16:15:21+01:00 DEBUG: O      2
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T16:15:21+01:00 DEBUG: O      Contacts
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T16:15:21+01:00 DEBUG: O      0
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T16:15:21+01:00 DEBUG: O      Contacts
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T16:15:21+01:00 DEBUG: O      9
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T16:15:21+01:00 DEBUG: O      Calendar
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T16:15:21+01:00 DEBUG: O      0
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T16:15:21+01:00 DEBUG: O      Calendar
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T16:15:21+01:00 DEBUG: O      8
2012-01-31T16:15:21+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T16:15:21+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T16:15:21+01:00 DEBUG: O   <FolderHierarchy:Changes/>
2012-01-31T16:15:21+01:00 DEBUG: O  <FolderHierarchy:FolderSync/>
2012-01-31T16:15:21+01:00 DEBUG: [androidc1771218180] Saving state: Array
(
    [0] => {4f280589-7144-4908-b72c-37c5551fbb0c}1
    [1] =>
a:4:{i:0;a:3:{s:2:"id";s:5:"Tasks";s:3:"mod";s:5:"Tasks";s:6:"parent";i:0;}i:1;a:3:{s:2:"id";s:5:"Inbox";s:3:"mod";s:5:"Inbox";s:6:"parent";i:0;}i:2;a:3:{s:2:"id";s:8:"Contacts";s:3:"mod";s:8:"Contacts";s:6:"parent";i:0;}i:3;a:3:{s:2:"id";s:8:"Calendar";s:3:"mod";s:8:"Calendar";s:6:"parent";i:0;}}
    [2] => androidc1771218180
    [3] => 1328022921
    [4] => foldersync
    [5] => daniel at example.com
)

2012-01-31T16:15:21+01:00 INFO: User daniel at example.com logged off
2012-01-31T16:44:33+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon
attempt for: daniel at example.com
2012-01-31T16:44:33+01:00 DEBUG: [androidc1771218180] FOLDERSYNC request
received for user daniel at example.com
2012-01-31T16:44:33+01:00 DEBUG: [androidc1771218180] Device entry does
not exist, creating it.
2012-01-31T16:44:33+01:00 DEBUG: [androidc1771218180] Device entry does
not exist for user daniel at example.com, creating it.
2012-01-31T16:44:33+01:00 INFO: Request being handled for device:
androidc1771218180 Supporting protocol version: 2.5
2012-01-31T16:44:33+01:00 INFO: [Horde_ActiveSync::handleFolderSync]
Beginning FOLDERSYNC
2012-01-31T16:44:33+01:00 DEBUG: [androidc1771218180] Checking policykey
for device  Key: 0 User: daniel at example.com
2012-01-31T16:44:33+01:00 DEBUG: [androidc1771218180] loadDeviceInfo:
daniel at example.com
2012-01-31T16:44:33+01:00 DEBUG: Policykey: 0 verified.
2012-01-31T16:44:33+01:00 DEBUG: I  <FolderHierarchy:FolderSync>
2012-01-31T16:44:33+01:00 DEBUG: I   <FolderHierarchy:SyncKey>
2012-01-31T16:44:33+01:00 DEBUG: I    0
2012-01-31T16:44:33+01:00 DEBUG: I   </FolderHierarchy:SyncKey>
2012-01-31T16:44:33+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
syncKey: 0
2012-01-31T16:44:33+01:00 DEBUG: [androidc1771218180] Resetting device
state.
2012-01-31T16:44:33+01:00 DEBUG: I  </FolderHierarchy:FolderSync>
2012-01-31T16:44:33+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
Preparing to send changes to PIM
2012-01-31T16:44:33+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
newSyncKey: {4f280c61-9c6c-45fe-989b-37c5551fbb0c}1
2012-01-31T16:44:33+01:00 DEBUG: [androidc1771218180] Initializing
folder diff engine
2012-01-31T16:44:33+01:00 DEBUG: Horde::getFolderList()
2012-01-31T16:44:33+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T16:44:33+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T16:44:33+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T16:44:33+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T16:44:33+01:00 DEBUG: [androidc1771218180] Found 4 folder changes
2012-01-31T16:44:33+01:00 DEBUG: Horde::getFolder(Tasks)
2012-01-31T16:44:33+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T16:44:33+01:00 DEBUG: Updating state during foldersync
2012-01-31T16:44:33+01:00 DEBUG: Horde::getFolder(Inbox)
2012-01-31T16:44:33+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T16:44:33+01:00 DEBUG: Updating state during foldersync
2012-01-31T16:44:33+01:00 DEBUG: Horde::getFolder(Contacts)
2012-01-31T16:44:33+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T16:44:33+01:00 DEBUG: Updating state during foldersync
2012-01-31T16:44:33+01:00 DEBUG: Horde::getFolder(Calendar)
2012-01-31T16:44:33+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T16:44:33+01:00 DEBUG: Updating state during foldersync
2012-01-31T16:44:33+01:00 DEBUG: O  <FolderHierarchy:FolderSync>
2012-01-31T16:44:33+01:00 DEBUG: O   <FolderHierarchy:Status>
2012-01-31T16:44:33+01:00 DEBUG: O    1
2012-01-31T16:44:33+01:00 DEBUG: O   <FolderHierarchy:Status/>
2012-01-31T16:44:33+01:00 DEBUG: O   <FolderHierarchy:SyncKey>
2012-01-31T16:44:33+01:00 DEBUG: O
{4f280c61-9c6c-45fe-989b-37c5551fbb0c}1
2012-01-31T16:44:33+01:00 DEBUG: O   <FolderHierarchy:SyncKey/>
2012-01-31T16:44:33+01:00 DEBUG: O   <FolderHierarchy:Changes>
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Count>
2012-01-31T16:44:33+01:00 DEBUG: O     4
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Count/>
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T16:44:33+01:00 DEBUG: O      Tasks
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T16:44:33+01:00 DEBUG: O      0
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T16:44:33+01:00 DEBUG: O      Tasks
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T16:44:33+01:00 DEBUG: O      7
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T16:44:33+01:00 DEBUG: O      Inbox
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T16:44:33+01:00 DEBUG: O      0
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T16:44:33+01:00 DEBUG: O      Inbox
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T16:44:33+01:00 DEBUG: O      2
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T16:44:33+01:00 DEBUG: O      Contacts
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T16:44:33+01:00 DEBUG: O      0
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T16:44:33+01:00 DEBUG: O      Contacts
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T16:44:33+01:00 DEBUG: O      9
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T16:44:33+01:00 DEBUG: O      Calendar
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T16:44:33+01:00 DEBUG: O      0
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T16:44:33+01:00 DEBUG: O      Calendar
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T16:44:33+01:00 DEBUG: O      8
2012-01-31T16:44:33+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T16:44:33+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T16:44:33+01:00 DEBUG: O   <FolderHierarchy:Changes/>
2012-01-31T16:44:33+01:00 DEBUG: O  <FolderHierarchy:FolderSync/>
2012-01-31T16:44:33+01:00 DEBUG: [androidc1771218180] Saving state: Array
(
    [0] => {4f280c61-9c6c-45fe-989b-37c5551fbb0c}1
    [1] =>
a:4:{i:0;a:3:{s:2:"id";s:5:"Tasks";s:3:"mod";s:5:"Tasks";s:6:"parent";i:0;}i:1;a:3:{s:2:"id";s:5:"Inbox";s:3:"mod";s:5:"Inbox";s:6:"parent";i:0;}i:2;a:3:{s:2:"id";s:8:"Contacts";s:3:"mod";s:8:"Contacts";s:6:"parent";i:0;}i:3;a:3:{s:2:"id";s:8:"Calendar";s:3:"mod";s:8:"Calendar";s:6:"parent";i:0;}}
    [2] => androidc1771218180
    [3] => 1328024673
    [4] => foldersync
    [5] => daniel at example.com
)

2012-01-31T16:44:33+01:00 INFO: User daniel at example.com logged off
2012-01-31T17:23:37+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon
attempt for: daniel at example.com
2012-01-31T17:23:37+01:00 DEBUG: [androidc1771218180] FOLDERSYNC request
received for user daniel at example.com
2012-01-31T17:23:37+01:00 DEBUG: [androidc1771218180] Device entry does
not exist, creating it.
2012-01-31T17:23:37+01:00 DEBUG: [androidc1771218180] Device entry does
not exist for user daniel at example.com, creating it.
2012-01-31T17:23:37+01:00 INFO: Request being handled for device:
androidc1771218180 Supporting protocol version: 2.5
2012-01-31T17:23:37+01:00 INFO: [Horde_ActiveSync::handleFolderSync]
Beginning FOLDERSYNC
2012-01-31T17:23:37+01:00 DEBUG: [androidc1771218180] Checking policykey
for device  Key: 0 User: daniel at example.com
2012-01-31T17:23:37+01:00 DEBUG: [androidc1771218180] loadDeviceInfo:
daniel at example.com
2012-01-31T17:23:37+01:00 DEBUG: Policykey: 0 verified.
2012-01-31T17:23:37+01:00 DEBUG: I  <FolderHierarchy:FolderSync>
2012-01-31T17:23:37+01:00 DEBUG: I   <FolderHierarchy:SyncKey>
2012-01-31T17:23:37+01:00 DEBUG: I    0
2012-01-31T17:23:37+01:00 DEBUG: I   </FolderHierarchy:SyncKey>
2012-01-31T17:23:37+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
syncKey: 0
2012-01-31T17:23:37+01:00 DEBUG: [androidc1771218180] Resetting device
state.
2012-01-31T17:23:37+01:00 DEBUG: I  </FolderHierarchy:FolderSync>
2012-01-31T17:23:37+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
Preparing to send changes to PIM
2012-01-31T17:23:37+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
newSyncKey: {4f281589-33d8-42b4-9b8d-37c5551fbb0c}1
2012-01-31T17:23:37+01:00 DEBUG: [androidc1771218180] Initializing
folder diff engine
2012-01-31T17:23:37+01:00 DEBUG: Horde::getFolderList()
2012-01-31T17:23:37+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T17:23:37+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T17:23:37+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T17:23:37+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T17:23:37+01:00 DEBUG: [androidc1771218180] Found 4 folder changes
2012-01-31T17:23:37+01:00 DEBUG: Horde::getFolder(Tasks)
2012-01-31T17:23:37+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T17:23:37+01:00 DEBUG: Updating state during foldersync
2012-01-31T17:23:37+01:00 DEBUG: Horde::getFolder(Inbox)
2012-01-31T17:23:37+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T17:23:37+01:00 DEBUG: Updating state during foldersync
2012-01-31T17:23:37+01:00 DEBUG: Horde::getFolder(Contacts)
2012-01-31T17:23:37+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T17:23:37+01:00 DEBUG: Updating state during foldersync
2012-01-31T17:23:37+01:00 DEBUG: Horde::getFolder(Calendar)
2012-01-31T17:23:37+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T17:23:37+01:00 DEBUG: Updating state during foldersync
2012-01-31T17:23:37+01:00 DEBUG: O  <FolderHierarchy:FolderSync>
2012-01-31T17:23:37+01:00 DEBUG: O   <FolderHierarchy:Status>
2012-01-31T17:23:37+01:00 DEBUG: O    1
2012-01-31T17:23:37+01:00 DEBUG: O   <FolderHierarchy:Status/>
2012-01-31T17:23:37+01:00 DEBUG: O   <FolderHierarchy:SyncKey>
2012-01-31T17:23:37+01:00 DEBUG: O
{4f281589-33d8-42b4-9b8d-37c5551fbb0c}1
2012-01-31T17:23:37+01:00 DEBUG: O   <FolderHierarchy:SyncKey/>
2012-01-31T17:23:37+01:00 DEBUG: O   <FolderHierarchy:Changes>
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Count>
2012-01-31T17:23:37+01:00 DEBUG: O     4
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Count/>
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T17:23:37+01:00 DEBUG: O      Tasks
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T17:23:37+01:00 DEBUG: O      0
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T17:23:37+01:00 DEBUG: O      Tasks
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T17:23:37+01:00 DEBUG: O      7
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T17:23:37+01:00 DEBUG: O      Inbox
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T17:23:37+01:00 DEBUG: O      0
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T17:23:37+01:00 DEBUG: O      Inbox
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T17:23:37+01:00 DEBUG: O      2
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T17:23:37+01:00 DEBUG: O      Contacts
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T17:23:37+01:00 DEBUG: O      0
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T17:23:37+01:00 DEBUG: O      Contacts
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T17:23:37+01:00 DEBUG: O      9
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T17:23:37+01:00 DEBUG: O      Calendar
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T17:23:37+01:00 DEBUG: O      0
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T17:23:37+01:00 DEBUG: O      Calendar
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T17:23:37+01:00 DEBUG: O      8
2012-01-31T17:23:37+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T17:23:37+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T17:23:37+01:00 DEBUG: O   <FolderHierarchy:Changes/>
2012-01-31T17:23:37+01:00 DEBUG: O  <FolderHierarchy:FolderSync/>
2012-01-31T17:23:37+01:00 DEBUG: [androidc1771218180] Saving state: Array
(
    [0] => {4f281589-33d8-42b4-9b8d-37c5551fbb0c}1
    [1] =>
a:4:{i:0;a:3:{s:2:"id";s:5:"Tasks";s:3:"mod";s:5:"Tasks";s:6:"parent";i:0;}i:1;a:3:{s:2:"id";s:5:"Inbox";s:3:"mod";s:5:"Inbox";s:6:"parent";i:0;}i:2;a:3:{s:2:"id";s:8:"Contacts";s:3:"mod";s:8:"Contacts";s:6:"parent";i:0;}i:3;a:3:{s:2:"id";s:8:"Calendar";s:3:"mod";s:8:"Calendar";s:6:"parent";i:0;}}
    [2] => androidc1771218180
    [3] => 1328027017
    [4] => foldersync
    [5] => daniel at example.com
)

2012-01-31T17:23:37+01:00 INFO: User daniel at example.com logged off
2012-01-31T17:44:18+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon
attempt for: daniel at example.com
2012-01-31T17:44:18+01:00 DEBUG: [androidc1771218180] FOLDERSYNC request
received for user daniel at example.com
2012-01-31T17:44:18+01:00 DEBUG: [androidc1771218180] loadDeviceInfo:
daniel at example.com
2012-01-31T17:44:18+01:00 DEBUG: Resetting PING state
2012-01-31T17:44:18+01:00 INFO: Request being handled for device:
androidc1771218180 Supporting protocol version: 2.5
2012-01-31T17:44:18+01:00 INFO: [Horde_ActiveSync::handleFolderSync]
Beginning FOLDERSYNC
2012-01-31T17:44:18+01:00 DEBUG: [androidc1771218180] Checking policykey
for device  Key: 0 User: daniel at example.com
2012-01-31T17:44:18+01:00 DEBUG: [androidc1771218180] loadDeviceInfo:
daniel at example.com
2012-01-31T17:44:18+01:00 DEBUG: Policykey: 0 verified.
2012-01-31T17:44:18+01:00 DEBUG: I  <FolderHierarchy:FolderSync>
2012-01-31T17:44:18+01:00 DEBUG: I   <FolderHierarchy:SyncKey>
2012-01-31T17:44:18+01:00 DEBUG: I    0
2012-01-31T17:44:18+01:00 DEBUG: I   </FolderHierarchy:SyncKey>
2012-01-31T17:44:18+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
syncKey: 0
2012-01-31T17:44:18+01:00 DEBUG: [androidc1771218180] Resetting device
state.
2012-01-31T17:44:18+01:00 DEBUG: I  </FolderHierarchy:FolderSync>
2012-01-31T17:44:18+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
Preparing to send changes to PIM
2012-01-31T17:44:18+01:00 DEBUG: [Horde_ActiveSync::handleFolderSync]
newSyncKey: {4f281a62-edfc-4242-8dfb-3ad2551fbb0c}1
2012-01-31T17:44:18+01:00 DEBUG: [androidc1771218180] Initializing
folder diff engine
2012-01-31T17:44:18+01:00 DEBUG: Horde::getFolderList()
2012-01-31T17:44:18+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T17:44:18+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T17:44:18+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T17:44:18+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T17:44:18+01:00 DEBUG: [androidc1771218180] Found 4 folder changes
2012-01-31T17:44:18+01:00 DEBUG: Horde::getFolder(Tasks)
2012-01-31T17:44:18+01:00 DEBUG: Horde::statFolder(Tasks)
2012-01-31T17:44:18+01:00 DEBUG: Updating state during foldersync
2012-01-31T17:44:18+01:00 DEBUG: Horde::getFolder(Inbox)
2012-01-31T17:44:18+01:00 DEBUG: Horde::statFolder(Inbox)
2012-01-31T17:44:18+01:00 DEBUG: Updating state during foldersync
2012-01-31T17:44:18+01:00 DEBUG: Horde::getFolder(Contacts)
2012-01-31T17:44:18+01:00 DEBUG: Horde::statFolder(Contacts)
2012-01-31T17:44:18+01:00 DEBUG: Updating state during foldersync
2012-01-31T17:44:18+01:00 DEBUG: Horde::getFolder(Calendar)
2012-01-31T17:44:18+01:00 DEBUG: Horde::statFolder(Calendar)
2012-01-31T17:44:18+01:00 DEBUG: Updating state during foldersync
2012-01-31T17:44:18+01:00 DEBUG: O  <FolderHierarchy:FolderSync>
2012-01-31T17:44:18+01:00 DEBUG: O   <FolderHierarchy:Status>
2012-01-31T17:44:18+01:00 DEBUG: O    1
2012-01-31T17:44:18+01:00 DEBUG: O   <FolderHierarchy:Status/>
2012-01-31T17:44:18+01:00 DEBUG: O   <FolderHierarchy:SyncKey>
2012-01-31T17:44:18+01:00 DEBUG: O
{4f281a62-edfc-4242-8dfb-3ad2551fbb0c}1
2012-01-31T17:44:18+01:00 DEBUG: O   <FolderHierarchy:SyncKey/>
2012-01-31T17:44:18+01:00 DEBUG: O   <FolderHierarchy:Changes>
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Count>
2012-01-31T17:44:18+01:00 DEBUG: O     4
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Count/>
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T17:44:18+01:00 DEBUG: O      Tasks
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T17:44:18+01:00 DEBUG: O      0
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T17:44:18+01:00 DEBUG: O      Tasks
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T17:44:18+01:00 DEBUG: O      7
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T17:44:18+01:00 DEBUG: O      Inbox
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T17:44:18+01:00 DEBUG: O      0
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T17:44:18+01:00 DEBUG: O      Inbox
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T17:44:18+01:00 DEBUG: O      2
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T17:44:18+01:00 DEBUG: O      Contacts
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T17:44:18+01:00 DEBUG: O      0
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T17:44:18+01:00 DEBUG: O      Contacts
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T17:44:18+01:00 DEBUG: O      9
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Add>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId>
2012-01-31T17:44:18+01:00 DEBUG: O      Calendar
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ServerEntryId/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ParentId>
2012-01-31T17:44:18+01:00 DEBUG: O      0
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:ParentId/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:DisplayName>
2012-01-31T17:44:18+01:00 DEBUG: O      Calendar
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:DisplayName/>
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:Type>
2012-01-31T17:44:18+01:00 DEBUG: O      8
2012-01-31T17:44:18+01:00 DEBUG: O     <FolderHierarchy:Type/>
2012-01-31T17:44:18+01:00 DEBUG: O    <FolderHierarchy:Add/>
2012-01-31T17:44:18+01:00 DEBUG: O   <FolderHierarchy:Changes/>
2012-01-31T17:44:18+01:00 DEBUG: O  <FolderHierarchy:FolderSync/>
2012-01-31T17:44:18+01:00 DEBUG: [androidc1771218180] Saving state: Array
(
    [0] => {4f281a62-edfc-4242-8dfb-3ad2551fbb0c}1
    [1] =>
a:4:{i:0;a:3:{s:2:"id";s:5:"Tasks";s:3:"mod";s:5:"Tasks";s:6:"parent";i:0;}i:1;a:3:{s:2:"id";s:5:"Inbox";s:3:"mod";s:5:"Inbox";s:6:"parent";i:0;}i:2;a:3:{s:2:"id";s:8:"Contacts";s:3:"mod";s:8:"Contacts";s:6:"parent";i:0;}i:3;a:3:{s:2:"id";s:8:"Calendar";s:3:"mod";s:8:"Calendar";s:6:"parent";i:0;}}
    [2] => androidc1771218180
    [3] => 1328028258
    [4] => foldersync
    [5] => daniel at example.com
)

2012-01-31T17:44:18+01:00 INFO: User daniel at example.com logged off




More information about the horde mailing list