[horde] ActiveSync and personal LDAP Addressbook?

Sun Apr 17 11:51:11 UTC 2011

Hi!

>> In theory there isn't any reason why this shouldn't work. Was there
>> any errors present in the Horde log? Please provide the log of a 
>> conversation between client/server where this fails. See 
>> http://wiki.horde.org/ActiveSync for instructions on how to obtain
>> this log.

Here you go, the output of the Sync-Log for a Contact-Sync:

2011-04-17T13:36:59+02:00 INFO: Horde_ActiveSync_Driver_Horde::logon
attempt for: flo
2011-04-17T13:37:00+02:00 DEBUG: SQL QUERY: SELECT device_type,
device_agent, device_ping, device_policykey, device_rwstatus,
device_supported FROM horde_activesync_device d INNER JOIN
horde_activesync_device_users u ON d.device_id = u.device_id WHERE
u.device_id = ? AND u.device_user = ? VALUES: androidc239454262 flo
2011-04-17T13:37:00+02:00 INFO: Request received from device:
androidc239454262 Supporting protocol version: 2.5
2011-04-17T13:37:00+02:00 INFO: [androidc239454262] Handling SYNC command.
2011-04-17T13:37:00+02:00 DEBUG: Policykey:  verified.
2011-04-17T13:37:00+02:00 DEBUG: I  <Synchronize>
2011-04-17T13:37:00+02:00 DEBUG: I   <Folders>
2011-04-17T13:37:00+02:00 DEBUG: I    <Folder>
2011-04-17T13:37:00+02:00 DEBUG: I     <FolderType>
2011-04-17T13:37:00+02:00 DEBUG: I      Contacts
2011-04-17T13:37:00+02:00 INFO: [androidc239454262] Syncing folder
class: Contacts
2011-04-17T13:37:00+02:00 DEBUG: I     </FolderType>
2011-04-17T13:37:00+02:00 DEBUG: I     <SyncKey>
2011-04-17T13:37:00+02:00 DEBUG: I
{4daad082-22c4-4797-8cd3-34d051a981c3}1
2011-04-17T13:37:00+02:00 DEBUG: I     </SyncKey>
2011-04-17T13:37:00+02:00 DEBUG: I     <FolderId>
2011-04-17T13:37:00+02:00 DEBUG: I      Contacts
2011-04-17T13:37:00+02:00 INFO: [androidc239454262] Folder server id:
Contacts
2011-04-17T13:37:00+02:00 DEBUG: I     </FolderId>
2011-04-17T13:37:00+02:00 DEBUG: I     <DeletesAsMoves/>
2011-04-17T13:37:00+02:00 DEBUG: Unmatched tagSupported:
2011-04-17T13:37:00+02:00 DEBUG: I     <GetChanges/>
2011-04-17T13:37:00+02:00 DEBUG: I     <WindowSize>
2011-04-17T13:37:00+02:00 DEBUG: I      4
2011-04-17T13:37:00+02:00 DEBUG: I     </WindowSize>
2011-04-17T13:37:00+02:00 DEBUG: I     <Options>
2011-04-17T13:37:00+02:00 DEBUG: I      <Truncation>
2011-04-17T13:37:00+02:00 DEBUG: Unmatched tagFilterType:
2011-04-17T13:37:00+02:00 DEBUG: I       7
2011-04-17T13:37:00+02:00 DEBUG: I      </Truncation>
2011-04-17T13:37:00+02:00 DEBUG: I     </Options>
2011-04-17T13:37:00+02:00 DEBUG: Unmatched tagRtfTruncation:
2011-04-17T13:37:00+02:00 DEBUG: Unmatched tagMIMESupport:
2011-04-17T13:37:00+02:00 DEBUG: Unmatched tagMIMETruncation:
2011-04-17T13:37:00+02:00 DEBUG: Unmatched tagConflict:
2011-04-17T13:37:00+02:00 DEBUG: [androidc239454262] Loading state for
synckey {4daad082-22c4-4797-8cd3-34d051a981c3}1
2011-04-17T13:37:00+02:00 DEBUG: [androidc239454262] SQL query by
Horde_ActiveSync_State:_gc(): SELECT sync_key FROM
horde_activesync_state WHERE sync_devid = ? AND sync_folderid = ?
VALUES: Array
(
    [0] => androidc239454262
    [1] => Contacts
)

2011-04-17T13:37:00+02:00 DEBUG: I    </Folder>
2011-04-17T13:37:00+02:00 DEBUG: Unmatched tagCommands:
2011-04-17T13:37:00+02:00 DEBUG: I   </Folders>
2011-04-17T13:37:00+02:00 DEBUG: Unmatched tagFolder:
2011-04-17T13:37:00+02:00 DEBUG: I  </Synchronize>
2011-04-17T13:37:00+02:00 INFO: [androidc239454262] Beginning SYNC Response.
2011-04-17T13:37:00+02:00 DEBUG: [androidc239454262] Initializing
message diff engine for Contacts
2011-04-17T13:37:00+02:00 DEBUG:
Horde_ActiveSync_Driver_Horde::getServerChanges(Contacts, 0, 1303040220, 0)
2011-04-17T13:37:00+02:00 ERR: Ungültiges Adressbuch: personal_ldap
2011-04-17T13:37:00+02:00 DEBUG: [androidc239454262] Found 0 message
changes, checking for PIM initiated changes.
2011-04-17T13:37:00+02:00 DEBUG: [androidc239454262] No PIM changes
present, returning all messages.
2011-04-17T13:37:00+02:00 DEBUG: O  <Synchronize>
2011-04-17T13:37:00+02:00 DEBUG: O   <Folders>
2011-04-17T13:37:00+02:00 DEBUG: O    <Folder>
2011-04-17T13:37:00+02:00 DEBUG: O     <FolderType>
2011-04-17T13:37:00+02:00 DEBUG: O     Contacts
2011-04-17T13:37:00+02:00 DEBUG: O      <FolderType/>
2011-04-17T13:37:00+02:00 DEBUG: O     <SyncKey>
2011-04-17T13:37:00+02:00 DEBUG: O
{4daad082-22c4-4797-8cd3-34d051a981c3}1
2011-04-17T13:37:00+02:00 DEBUG: O      <SyncKey/>
2011-04-17T13:37:00+02:00 DEBUG: O     <FolderId>
2011-04-17T13:37:00+02:00 DEBUG: O     Contacts
2011-04-17T13:37:00+02:00 DEBUG: O      <FolderId/>
2011-04-17T13:37:00+02:00 DEBUG: O     <Status>
2011-04-17T13:37:00+02:00 DEBUG: O     1
2011-04-17T13:37:00+02:00 DEBUG: O      <Status/>
2011-04-17T13:37:00+02:00 DEBUG: O     <Folder/>
2011-04-17T13:37:00+02:00 DEBUG: O    <Folders/>
2011-04-17T13:37:00+02:00 DEBUG: O   <Synchronize/>
2011-04-17T13:37:00+02:00 INFO: User flo logged off

In the Horde-Log I get this error:

2011-04-17T13:43:43+02:00 ERR: HORDE [turba] Verbindung fehlgeschlagen:
(53) Server is unwilling to perform [pid 22474 on line 99 of
"/var/www_horde/turba/lib/Driver/Ldap.php"]

The Address-Book "personal_ldap" is used by IMP and Kronolith, without
any problems. Is there any special entry needed by ActiveSync?

Thanks!

-- 
Mit freundlichen Grüssen,
Florian Brandner

WWW:    http://www.brandner.net        eMail:  florian at brandner.net
Skype:  derbrandy                      Jabber: fbr at jabber.ccc.de