[horde] Active Sync - new calnedar entry

Martin Hochreiter linuxbox at wavenet.at
Fri Jul 29 16:58:05 UTC 2011 

No I dont think that php is crashing - Horde just is not recognizing a 
new appointment.

I saved 2 test appointments in the next week directly in kronolith and 
did a sync with my
mobile device afterwards .... as you see no changes are announced ...


2011-07-29T18:48:26+02:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for:
2011-07-29T18:48:36+02:00 DEBUG: [] OPTIONS request received for user
2011-07-29T18:48:37+02:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: martin_hochreiter
2011-07-29T18:48:37+02:00 DEBUG: [] OPTIONS request received for user 
martin_hochreiter
2011-07-29T18:48:38+02:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: martin_hochreiter
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
GETITEMESTIMATE request received for user martin_hochreiter
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
loadDeviceInfo: martin_hochreiter
2011-07-29T18:48:38+02:00 DEBUG: Resetting PING state
2011-07-29T18:48:38+02:00 INFO: Request being handled for device: 
D07C514FE4229142CC2053896751894A Supporting protocol version: 2.5
2011-07-29T18:48:38+02:00 INFO: [D07C514FE4229142CC2053896751894A] 
Beginning GETITEMESTIMATE
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
Checking policykey for device  Key: 7016545326 User: martin_hochreiter
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
loadDeviceInfo: martin_hochreiter
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
Stored key: 7016545326
2011-07-29T18:48:38+02:00 DEBUG: Policykey: 7016545326 verified.
2011-07-29T18:48:38+02:00 DEBUG: I <GetItemEstimate:GetItemEstimate>
2011-07-29T18:48:38+02:00 DEBUG: I <GetItemEstimate:Folders>
2011-07-29T18:48:38+02:00 DEBUG: I <GetItemEstimate:Folder>
2011-07-29T18:48:38+02:00 DEBUG: I <GetItemEstimate:FolderType>
2011-07-29T18:48:38+02:00 DEBUG: I      Contacts
2011-07-29T18:48:38+02:00 DEBUG: I </GetItemEstimate:FolderType>
2011-07-29T18:48:38+02:00 DEBUG: I <GetItemEstimate:FolderId>
2011-07-29T18:48:38+02:00 DEBUG: I      Contacts
2011-07-29T18:48:38+02:00 DEBUG: I </GetItemEstimate:FolderId>
2011-07-29T18:48:38+02:00 DEBUG: I <FilterType>
2011-07-29T18:48:38+02:00 DEBUG: I      0
2011-07-29T18:48:38+02:00 DEBUG: I </FilterType>
2011-07-29T18:48:38+02:00 DEBUG: I <SyncKey>
2011-07-29T18:48:38+02:00 DEBUG: I 
{4e305637-3b5c-47f5-b019-0405c0a80168}4
2011-07-29T18:48:38+02:00 DEBUG: I </SyncKey>
2011-07-29T18:48:38+02:00 DEBUG: I </GetItemEstimate:Folder>
2011-07-29T18:48:38+02:00 DEBUG: I <GetItemEstimate:Folder>
2011-07-29T18:48:38+02:00 DEBUG: I <GetItemEstimate:FolderType>
2011-07-29T18:48:38+02:00 DEBUG: I      Calendar
2011-07-29T18:48:38+02:00 DEBUG: I </GetItemEstimate:FolderType>
2011-07-29T18:48:38+02:00 DEBUG: I <GetItemEstimate:FolderId>
2011-07-29T18:48:38+02:00 DEBUG: I      Calendar
2011-07-29T18:48:38+02:00 DEBUG: I </GetItemEstimate:FolderId>
2011-07-29T18:48:38+02:00 DEBUG: I <FilterType>
2011-07-29T18:48:38+02:00 DEBUG: I      4
2011-07-29T18:48:38+02:00 DEBUG: I </FilterType>
2011-07-29T18:48:38+02:00 DEBUG: I <SyncKey>
2011-07-29T18:48:38+02:00 DEBUG: I 
{4e3056c6-4814-4a2c-aa3d-03fcc0a80168}3
2011-07-29T18:48:38+02:00 DEBUG: I </SyncKey>
2011-07-29T18:48:38+02:00 DEBUG: I </GetItemEstimate:Folder>
2011-07-29T18:48:38+02:00 DEBUG: I </GetItemEstimate:Folders>
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
Loading state for synckey {4e305637-3b5c-47f5-b019-0405c0a80168}4
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] SQL 
query by Horde_ActiveSync_State:_gc(): SELECT sync_key FROM 
horde_activesync_state WHERE sync_devid = ? AND sync_folderid = ? 
VALUES: Array
(
     [0] => D07C514FE4229142CC2053896751894A
     [1] => Contacts
)

2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:GetItemEstimate>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Response>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Status>
2011-07-29T18:48:38+02:00 DEBUG: O     1
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Status/>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Folder>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:FolderType>
2011-07-29T18:48:38+02:00 DEBUG: O      Contacts
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:FolderType/>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:FolderId>
2011-07-29T18:48:38+02:00 DEBUG: O      Contacts
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:FolderId/>
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
Initializing message diff engine for Contacts
2011-07-29T18:48:38+02:00 DEBUG: 
Horde_ActiveSync_Driver_Horde::getServerChanges(Contacts, 1311794052, 
1311958118, 0)
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
Found 0 message changes, checking for PIM initiated changes.
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] No 
PIM changes present, returning all messages.
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Estimate>
2011-07-29T18:48:38+02:00 DEBUG: O      0
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Estimate/>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Folder/>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Response/>
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
Loading state for synckey {4e3056c6-4814-4a2c-aa3d-03fcc0a80168}3
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] SQL 
query by Horde_ActiveSync_State:_gc(): SELECT sync_key FROM 
horde_activesync_state WHERE sync_devid = ? AND sync_folderid = ? 
VALUES: Array
(
     [0] => D07C514FE4229142CC2053896751894A
     [1] => Calendar
)

2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Response>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Status>
2011-07-29T18:48:38+02:00 DEBUG: O     1
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Status/>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Folder>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:FolderType>
2011-07-29T18:48:38+02:00 DEBUG: O      Calendar
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:FolderType/>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:FolderId>
2011-07-29T18:48:38+02:00 DEBUG: O      Calendar
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:FolderId/>
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
Initializing message diff engine for Calendar
2011-07-29T18:48:38+02:00 DEBUG: 
Horde_ActiveSync_Driver_Horde::getServerChanges(Calendar, 1311834653, 
1311958118, 1310748518)
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] 
Found 0 message changes, checking for PIM initiated changes.
2011-07-29T18:48:38+02:00 DEBUG: [D07C514FE4229142CC2053896751894A] No 
PIM changes present, returning all messages.
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Estimate>
2011-07-29T18:48:38+02:00 DEBUG: O      0
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Estimate/>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Folder/>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:Response/>
2011-07-29T18:48:38+02:00 DEBUG: O <GetItemEstimate:GetItemEstimate/>
2011-07-29T18:48:38+02:00 INFO: User martin_hochreiter logged off

More information about the horde mailing list