[sync] Funambol and outlook
Ronan SALMON
rsalmon at mbpgroup.com
Thu Aug 9 07:11:57 UTC 2007
Hi,
I can't get the funambol 6.0.14 plugin for outlook 2003 SP2 to sync with
horde. I'm using horde's latest cvs version.
Right now, I'm just trying to sync contacts. I have only 2 contact in
horde and nothing in outlook.
I've attached the funambol log file.
I don't see any errors in horde's logs.
Funambol seams to receive binary data at some stage which is wierd.
Any ideas?
Thanks,
Ronan.
-------------- next part --------------
2007-08-09 10:03:46 GMT +1:00 - # Funambol Outlook Plug-in v. 6.0.14 - LOG file
10:03:46 GMT +1:00 [DEBUG] - Starting the Sync process...
10:03:46 GMT +1:00 [DEBUG] - Set a lower priority to the process
10:03:46 GMT +1:00 [DEBUG] - Set listeners
10:03:46 GMT +1:00 [DEBUG] - Creating SyncSources...
10:03:46 GMT +1:00 [DEBUG] - Creating the sync-mutex ("fol-SyncInProgress-1186646626")
10:03:46 GMT +1:00 [DEBUG] - Start SyncClient::Sync() with 1 sources
10:03:46 GMT +1:00 [INFO] -
************************** BEGIN of Synchronization session **************************
10:03:46 GMT +1:00 [INFO] - Synchronization URL: http://192.168.1.22/horde/rpc.php
10:03:46 GMT +1:00 [INFO] - Preparing synchronization of contact...
10:03:46 GMT +1:00 [DEBUG] - devinfo: <DevInf xmlns="syncml:devinf"><VerDTD>1.1</VerDTD>
<Man>Funambol</Man>
<Mod>Funambol Outlook Plug-in</Mod>
<SwV>6.0.14</SwV>
<DevID>fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24=</DevID>
<DevTyp>workstation</DevTyp>
<UTC/><SupportLargeObjs/><SupportNumberOfChanges/><DataStore><SourceRef>contact</SourceRef>
<Rx-Pref><CTType>text/x-s4j-sifc</CTType>
<VerCT></VerCT>
</Rx-Pref>
<Rx><CTType>text/x-s4j-sifc</CTType>
<VerCT></VerCT>
</Rx>
<Rx><CTType>text/x-vcard</CTType>
<VerCT>2.1</VerCT>
</Rx>
<Tx-Pref><CTType>text/x-s4j-sifc</CTType>
<VerCT></VerCT>
</Tx-Pref>
<Tx><CTType>text/x-s4j-sifc</CTType>
<VerCT></VerCT>
</Tx>
<Tx><CTType>text/x-vcard</CTType>
<VerCT>2.1</VerCT>
</Tx>
<SyncCap><SyncType>2</SyncType>
<SyncType>1</SyncType>
<SyncType>5</SyncType>
<SyncType>3</SyncType>
<SyncType>6</SyncType>
<SyncType>4</SyncType>
</SyncCap>
</DataStore>
</DevInf>
10:03:46 GMT +1:00 [DEBUG] - devinfo hash: NCALW21byiDk3ma5Z2Qczg==
10:03:46 GMT +1:00 [DEBUG] - devinfo changed, retransmit
10:03:46 GMT +1:00 [DEBUG] - Initialization message:
10:03:46 GMT +1:00 [DEBUG] - <?xml version="1.0" encoding="UTF-8"?>
<SyncML>
<SyncHdr><VerDTD>1.1</VerDTD>
<VerProto>SyncML/1.1</VerProto>
<SessionID>1186646626</SessionID>
<MsgID>1</MsgID>
<Target><LocURI>http://192.168.1.22/horde/rpc.php</LocURI>
</Target>
<Source><LocURI>fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24=</LocURI>
</Source>
<Cred><Meta><Format xmlns="syncml:metinf">b64</Format>
<Type xmlns="syncml:metinf">syncml:auth-basic</Type>
</Meta>
<Data>cm9uYW46cm9uYW4xMjM0NQ==</Data>
</Cred>
<Meta><MaxMsgSize xmlns="syncml:metinf">250000</MaxMsgSize>
</Meta>
</SyncHdr>
<SyncBody><Alert><CmdID>1</CmdID>
<Data>200</Data>
<Item><Target><LocURI>scard</LocURI>
</Target>
<Source><LocURI>contact</LocURI>
</Source>
<Meta><Anchor xmlns="syncml:metinf"><Last>0</Last>
<Next>1186646626</Next>
</Anchor>
</Meta>
</Item>
</Alert>
<Put><CmdID>2</CmdID>
<Meta><Type xmlns="syncml:metinf">application/vnd.syncml-devinf+xml</Type>
</Meta>
<Item><Source><LocURI>./devinf11</LocURI>
</Source>
<Data><DevInf xmlns="syncml:devinf"><VerDTD>1.1</VerDTD>
<Man>Funambol</Man>
<Mod>Funambol Outlook Plug-in</Mod>
<SwV>6.0.14</SwV>
<DevID>fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24=</DevID>
<DevTyp>workstation</DevTyp>
<UTC/><SupportLargeObjs/><SupportNumberOfChanges/><DataStore><SourceRef>contact</SourceRef>
<Rx-Pref><CTType>text/x-s4j-sifc</CTType>
<VerCT></VerCT>
</Rx-Pref>
<Rx><CTType>text/x-s4j-sifc</CTType>
<VerCT></VerCT>
</Rx>
<Rx><CTType>text/x-vcard</CTType>
<VerCT>2.1</VerCT>
</Rx>
<Tx-Pref><CTType>text/x-s4j-sifc</CTType>
<VerCT></VerCT>
</Tx-Pref>
<Tx><CTType>text/x-s4j-sifc</CTType>
<VerCT></VerCT>
</Tx>
<Tx><CTType>text/x-vcard</CTType>
<VerCT>2.1</VerCT>
</Tx>
<SyncCap><SyncType>2</SyncType>
<SyncType>1</SyncType>
<SyncType>5</SyncType>
<SyncType>3</SyncType>
<SyncType>6</SyncType>
<SyncType>4</SyncType>
</SyncCap>
</DataStore>
</DevInf>
</Data>
</Item>
</Put>
<Final/></SyncBody>
</SyncML>
10:03:46 GMT +1:00 [DEBUG] - User Agent = Funambol Outlook Plug-in v. 6.0.14
10:03:46 GMT +1:00 [DEBUG] - Initialization sent.
10:03:46 GMT +1:00 [DEBUG] - Connecting to 192.168.1.22:80
10:03:46 GMT +1:00 [DEBUG] - Requesting resource /horde/rpc.php
10:03:46 GMT +1:00 [DEBUG] - Sending data of size 1862...
10:03:46 GMT +1:00 [DEBUG] - Message sent
10:03:46 GMT +1:00 [DEBUG] - Finished sending data of size 1862.
10:03:46 GMT +1:00 [DEBUG] - Header: H?
10:03:46 GMT +1:00 [DEBUG] - Reading response...
10:03:46 GMT +1:00 [DEBUG] - Content-length: 517
10:03:46 GMT +1:00 [DEBUG] - Receiving data of size 517...
10:03:46 GMT +1:00 [DEBUG] - Finished receiving data of size 517.
10:03:46 GMT +1:00 [DEBUG] - Response read:
x??Tmo??+(???e\uehTP?V?H??1 ?Im??>??I??,z/TT9gC???o??/?F?Kg??e???,??????7?d??gk??[????OT DQ?????f? "`
????)O??q?,???????????{??`?tOJ?g???PW]?S}#?
10:03:46 GMT +1:00 [ERROR] - Error processing SyncHdr Status
10:03:46 GMT +1:00 [DEBUG] - Checking for forced slow-sync...
10:03:46 GMT +1:00 [DEBUG] - ---------------------- contact BEGIN (mode "two-way") ----------------------
10:03:46 GMT +1:00 [DEBUG] - beginSync of contact source: opening Outlook session...
10:03:46 GMT +1:00 [DEBUG] - Initialize COM library
10:03:46 GMT +1:00 [DEBUG] - Create Outlook.Application instance...
10:03:46 GMT +1:00 [DEBUG] - Logon to Outlook MAPI: default profile, show-dialog = true, new-session = false
10:03:46 GMT +1:00 [INFO] - Outlook session opened successfully! Using: Outlook 2003.
10:03:47 GMT +1:00 [DEBUG] - Reading ALL contacts from folder '\\Dossiers personnels\Contacts' (0 found)...
10:03:47 GMT +1:00 [INFO] - Cannot find list of items from previous sync. All items will be sent as modified.
10:03:47 GMT +1:00 [INFO] - Total contact items to send: 0
10:03:47 GMT +1:00 [DEBUG] - Modification message: estimated size 0, allowed size 250000, real size 693 / estimated size 0 = 100%
10:03:47 GMT +1:00 [DEBUG] - <?xml version="1.0" encoding="UTF-8"?>
<SyncML>
<SyncHdr><VerDTD>1.1</VerDTD>
<VerProto>SyncML/1.1</VerProto>
<SessionID>1186646626</SessionID>
<MsgID>2</MsgID>
<Target><LocURI>http://192.168.1.22/horde/rpc.php</LocURI>
</Target>
<Source><LocURI>fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24=</LocURI>
</Source>
</SyncHdr>
<SyncBody><Status><CmdID>1</CmdID>
<MsgRef>1</MsgRef>
<CmdRef>0</CmdRef>
<Cmd>SyncHdr</Cmd>
<TargetRef>http://192.168.1.22/horde/rpc.php</TargetRef>
<SourceRef>fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24=</SourceRef>
<Data>200</Data>
</Status>
<Sync><CmdID>2</CmdID>
<Target><LocURI>scard</LocURI>
</Target>
<Source><LocURI>contact</LocURI>
</Source>
</Sync>
<Final/></SyncBody>
</SyncML>
10:03:47 GMT +1:00 [DEBUG] - Modifications sent.
10:03:47 GMT +1:00 [DEBUG] - Connecting to 192.168.1.22:80
10:03:47 GMT +1:00 [DEBUG] - Requesting resource /horde/rpc.php
10:03:47 GMT +1:00 [DEBUG] - Sending data of size 693...
10:03:47 GMT +1:00 [DEBUG] - Message sent
10:03:47 GMT +1:00 [DEBUG] - Finished sending data of size 693.
10:03:47 GMT +1:00 [DEBUG] - Header:
10:03:47 GMT +1:00 [DEBUG] - Reading response...
10:03:47 GMT +1:00 [DEBUG] - Content-length: 391
10:03:47 GMT +1:00 [DEBUG] - Receiving data of size 391...
10:03:47 GMT +1:00 [DEBUG] - Finished receiving data of size 391.
10:03:47 GMT +1:00 [DEBUG] - Response read:
x??R[O???IWA"Dw?X??X?tE?_o? ??=????sZ<<d???E*?kA?ku?D????o
??Z????????$?&???{?B R??Eb?f?}?9r0hY?(6z@T
10:03:47 GMT +1:00 [ERROR] - Server Failure: server returned error code -1
10:03:47 GMT +1:00 [DEBUG] - ---------------------- END (mode "none") ----------------------
10:03:47 GMT +1:00 [DEBUG] - Server requested syncmode "none" for .
10:03:47 GMT +1:00 [DEBUG] - Error occurred in sync: code 3 = Server Failure: server returned error code -1
10:03:47 GMT +1:00 [ERROR] - Error in syncing: Server Failure: server returned error code -1
10:03:47 GMT +1:00 [INFO] -
============================================================
================ SYNCHRONIZATION REPORT ================
============================================================
SYNCHRONIZATION COMPLETED WITH ERRORS
-------------------------------------
Last error message = "Server Failure: server returned error code -1"
Last error code = -1
Contacts:
---------
Sync completed successfully!
Sync type: two-way
| on Client | on Server
--------|-----------|----------
New | 0/ 0 | 0/ 0
Updated | 0/ 0 | 0/ 0
Deleted | 0/ 0 | 0/ 0
10:03:47 GMT +1:00 [DEBUG] - Saving configuration to winRegistry
10:03:47 GMT +1:00 [DEBUG] - Writing configuration settings to the management tree
10:03:47 GMT +1:00 [DEBUG] - Closing Outlook...
10:03:47 GMT +1:00 [DEBUG] - Deleting ClientApplication instance
10:03:47 GMT +1:00 [INFO] - Outlook session closed successfully.
10:03:47 GMT +1:00 [DEBUG] - Closing COM library...
10:03:47 GMT +1:00 [DEBUG] - Releasing sync-mutex...
10:03:47 GMT +1:00 [DEBUG] - Sync-mutex released - closing handle.
10:03:47 GMT +1:00 [DEBUG] - Delete SyncSources...
10:03:47 GMT +1:00 [INFO] - Syncronization process completed with errors (code = -1).
10:05:26 GMT +1:00 [DEBUG] - Reading configuration settings from the management tree
10:05:27 GMT +1:00 [DEBUG] - Deleting OutlookConfig instance
10:05:27 GMT +1:00 [DEBUG] - Outlook configuration closed.
10:05:27 GMT +1:00 [INFO] - Exiting from Outlook client.
-------------- next part --------------
DEBUG: Backend of class SyncML_Backend_Horde created
DEBUG: New session created: 2219927a28eecc9e752730a9a736699b
DEBUG: checking auth for user=ronan
DEBUG: authorized=1 version=1 msgid=1 source=fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24= target=http://192.168.1.22/horde/rpc.php user=ronan charset=UTF-8 wbxml=
DEBUG: SyncML: No info about previous syncs found for device fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24= and database scard
DEBUG: Create new sync for scard; synctype=201
DEBUG: HandleFinal for state=0
DEBUG: Received Final from client.
DEBUG: Sending Final to client.
DEBUG: SyncML: return message completed
DEBUG: Finished at 2007-08-09 10:03:47. Packet logged in /tmp/sync/syncml_server_10.xml
DEBUG: Backend of class SyncML_Backend_Horde created
DEBUG: Existing session continued: 2219927a28eecc9e752730a9a736699b
DEBUG: authorized=1 version=1 msgid=2 source=fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24= target=http://192.168.1.22/horde/rpc.php user=ronan charset=UTF-8 wbxml=
DEBUG: created device class SyncML_Device_Sync4j
DEBUG: HandleFinal for state=1
DEBUG: Not yet sending server sync data: special Funambol handling.
DEBUG: Received Final from client.
DEBUG: SyncML: return message completed
DEBUG: Finished at 2007-08-09 10:03:47. Packet logged in /tmp/sync/syncml_server_11.xml
More information about the sync
mailing list