[sync] Funambol and outlook

Thu Aug 9 15:19:18 UTC 2007

You were right: 
- I had  $conf['compress_pages'] set to  'true'.
- sync doesn't work from horde to outlook but looks like it works the
other way arround.

I've attached the logs. There are errors in horde's log file :
Unsupported Content-Type: text/x-s4j-sifc

Ronan.

Le jeudi 09 aoÃ»t 2007 Ã  09:11 -0400, Jamie McClelland a Ã©crit :
> -----BEGIN PGP SIGNED MESSAGE-----
> Hash: SHA1
> 
> On Thu Aug 09, Ronan SALMON wrote:
> > 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.
> 
> I tried a few months ago and was able to get it to work in one direction, but
> not the other (I think it worked Outlook -> Horde, but not Horde -> Outlook).
> A lot has changed since then, so you might have better luck.
> 
> <snip>
> 
> > 10:03:46 GMT +1:00 [DEBUG] - Response read:
> > x??Tmo?0?+(??)?Xe\uehTP?V???H???1???oIm??C|>???y?I???,z/TT9gC????,?Y??Co??/?5F?Kg???e?????,??}???????7?d??gk????c[???????OTDQ??????f?Z"`
> ????)O???xq?,?~M??6?19????<Y???????{????`?tOJ?g???"PW]??HiS}#??
> > 
> 
> 
> This could be caused by the compress_pages variable. Try changing your horde
> conf.php file:
> 
> $conf['compress_pages'] = true;
> 
> To:
> 
> $conf['compress_pages'] = false;
> 
> jamie
> 
> - -- 
> Jamie McClelland
> 718-303-3204 ext. 101
> 
> May First/People Link
> Growing networks to build a just world
> http://www.mayfirst.org
> Members Local 1180, Communications Workers of America, AFL-CIO
> 
> PGP Key: http://mayfirst.org/jamie-pgp
> -----BEGIN PGP SIGNATURE-----
> Version: GnuPG v1.4.6 (GNU/Linux)
> 
> iD8DBQFGuxKDnq83YnbMBX0RAt9xAJwO2xN+HXbkWjZiBlNrKOPfYhFcpgCfb4yp
> UHSof99JqluxSjP+0N+03LE=
> =gdSc
> -----END PGP SIGNATURE-----
-------------- next part --------------
DEBUG:  Backend of class SyncML_Backend_Horde created
DEBUG:  New session created: 5af5303f8f4c94574bf53b14c8e393b7
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 18:27:21. Packet logged in /tmp/sync/syncml_server_10.xml

DEBUG: Backend of class SyncML_Backend_Horde created
DEBUG: Existing session continued: 5af5303f8f4c94574bf53b14c8e393b7
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: Handling client sent Replace
DEBUG: replace in db contacts cuid 00000000DFF17A2F3489704AA02A0F476A2D5C8184022000 suid 20070809182625.4o89kqb8zti5 at 192.168.1.22
DEBUG: replaced entry 20070809182625.4o89kqb8zti5 at 192.168.1.22 due to client request
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 18:27:25. Packet logged in /tmp/sync/syncml_server_11.xml
WARNING:Caught output: Notice: Undefined index: NickName in /usr/share/pear/SyncML/Device/Sync4j.php on line 239 Notice: Undefined index: MobileTelephoneNumber in /usr/share/pear/SyncML/Device/Sync4j.php on line 244 Notice: Undefined index: BusinessFaxNumber in /usr/share/pear/SyncML/Device/Sync4j.php on line 246 Notice: Undefined index: JobTitle in /usr/share/pear/SyncML/Device/Sync4j.php on line 249 Notice: Undefined index: CompanyName in /usr/share/pear/SyncML/Device/Sync4j.php on line 250 Notice: Undefined index: Department in /usr/share/pear/SyncML/Device/Sync4j.php on line 251 Notice: Undefined index: Body in /usr/share/pear/SyncML/Device/Sync4j.php on line 252 Notice: Undefined index: WebPage in /usr/share/pear/SyncML/Device/Sync4j.php on line 253 Notice: Undefined index: Birthday in /usr/share/pear/SyncML/Device/Sync4j.php on line 254 Notice: Undefined index: Title in /usr/share/pear/SyncML/Device/Sync4j.php on line 260 Notice: Undefined index: Suffix in /usr/share/pear/SyncML/Device/Sync4j.php on line 261 Notice: Undefined index: HomeAddressPostOfficeBox in /usr/share/pear/SyncML/Device/Sync4j.php on line 266 Notice: Undefined index: HomeAddressStreet in /usr/share/pear/SyncML/Device/Sync4j.php on line 268 Notice: Undefined index: HomeAddressCity in /usr/share/pear/SyncML/Device/Sync4j.php on line 269 Notice: Undefined index: HomeAddressState in /usr/share/pear/SyncML/Device/Sync4j.php on line 270 Notice: Undefined index: HomeAddressPostalCode in /usr/share/pear/SyncML/Device/Sync4j.php on line 271 Notice: Undefined index: HomeAddressCountry in /usr/share/pear/SyncML/Device/Sync4j.php on line 272 Notice: Undefined index: BusinessAddressPostOfficeBox in /usr/share/pear/SyncML/Device/Sync4j.php on line 277 Notice: Undefined index: BusinessAddressStreet in /usr/share/pear/SyncML/Device/Sync4j.php on line 279 Notice: Undefined index: BusinessAddressCity in /usr/share/pear/SyncML/Device/Sync4j.php on line 280 Notice: Undefined index: BusinessAddressState in /usr/share/pear/SyncML/Device/Sync4j.php on line 281 Notice: Undefined index: BusinessAddressPostalCode in /usr/share/pear/SyncML/Device/Sync4j.php on line 282 Notice: Undefined index: BusinessAddressCountry in /usr/share/pear/SyncML/Device/Sync4j.php on line 283

DEBUG:  Backend of class SyncML_Backend_Horde created
DEBUG:  Existing session continued: 5af5303f8f4c94574bf53b14c8e393b7
DEBUG:  authorized=1 version=1 msgid=3 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:  server create sync output for syncType=scard
DEBUG:  Compiling server changes from 1970-01-01 01:00:00 to 2007-08-09 18:27:21
DEBUG:  slowsync-add: 20070809182625.4o89kqb8zti5 at 192.168.1.22 ignored
DEBUG:  sending 3 server changes for syncType=scard
DEBUG:  add: 20070809182526.skrtf057g2p6 at 192.168.1.22
ERR:    api export call for 20070809182526.skrtf057g2p6 at 192.168.1.22 failed:  Unsupported Content-Type: text/x-s4j-sifc
DEBUG:  add: 20070801105044.sqa9n9q825d4 at 192.168.1.22
ERR:    api export call for 20070801105044.sqa9n9q825d4 at 192.168.1.22 failed:  Unsupported Content-Type: text/x-s4j-sifc
DEBUG:  add: 20070801105044.0omby0k8fiq4 at 192.168.1.22
ERR:    api export call for 20070801105044.0omby0k8fiq4 at 192.168.1.22 failed:  Unsupported Content-Type: text/x-s4j-sifc
DEBUG:  HandleFinal for state=3
DEBUG:  Received Final from client.
DEBUG:  Sending Final to client.
DEBUG:  SyncML: return message completed
DEBUG:  Finished at 2007-08-09 18:27:25. Packet logged in /tmp/sync/syncml_server_12.xml

DEBUG:  Backend of class SyncML_Backend_Horde created
DEBUG:  Existing session continued: 5af5303f8f4c94574bf53b14c8e393b7
DEBUG:  authorized=1 version=1 msgid=4 source=fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24= target=http://192.168.1.22/horde/rpc.php user=ronan charset=UTF-8 wbxml=
DEBUG:  HandleFinal for state=3
DEBUG:  Received Final from client.
DEBUG:  Sending Final to client.
INFO:   Successful sync of scard! Summary: failures=0; client(Add,Replace,Delete,AddReplaces)=0,1,0,0; server(Add,Replace,Delete)=0,0,0
DEBUG:  Finished at 2007-08-09 18:27:25. Packet logged in /tmp/sync/syncml_server_13.xml

-------------- next part --------------
18:27:19 GMT +1:00 [DEBUG] - Writing configuration settings to the management tree
18:27:20 GMT +1:00 [DEBUG] - [UI] StartSync begin
18:27:20 GMT +1:00 [DEBUG] - [UI] Hide menu
18:27:20 GMT +1:00 [DEBUG] - [UI] Starting the syncThread...
18:27:20 GMT +1:00 [DEBUG] - Starting the Sync process...
18:27:20 GMT +1:00 [DEBUG] - Set a lower priority to the process
18:27:20 GMT +1:00 [DEBUG] - Set listeners
18:27:20 GMT +1:00 [DEBUG] - Creating SyncSources...
18:27:20 GMT +1:00 [DEBUG] - Creating the sync-mutex ("fol-SyncInProgress-1186676840")
18:27:20 GMT +1:00 [DEBUG] - Start SyncClient::Sync() with 1 sources
18:27:20 GMT +1:00 [INFO] - 
 ************************** BEGIN of Synchronization session **************************
18:27:20 GMT +1:00 [INFO] - Synchronization URL: http://192.168.1.22/horde/rpc.php
18:27:20 GMT +1:00 [INFO] - Preparing synchronization of contact...
18:27:20 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>

18:27:20 GMT +1:00 [DEBUG] - devinfo hash: NCALW21byiDk3ma5Z2Qczg==
18:27:20 GMT +1:00 [DEBUG] - devinfo unchanged, no need to send
18:27:20 GMT +1:00 [DEBUG] - Initialization message:
18:27:20 GMT +1:00 [DEBUG] - <?xml version="1.0" encoding="UTF-8"?>
<SyncML>
<SyncHdr><VerDTD>1.1</VerDTD>
<VerProto>SyncML/1.1</VerProto>
<SessionID>1186676840</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>1186676781</Last>
<Next>1186676840</Next>
</Anchor>
</Meta>
</Item>
</Alert>
<Final/></SyncBody>
</SyncML>
18:27:20 GMT +1:00 [DEBUG] - User Agent = Funambol Outlook Plug-in v. 6.0.14
18:27:20 GMT +1:00 [DEBUG] - Initialization sent.
18:27:20 GMT +1:00 [DEBUG] - Connecting to 192.168.1.22:80
18:27:20 GMT +1:00 [DEBUG] - Requesting resource /horde/rpc.php
18:27:20 GMT +1:00 [DEBUG] - Sending data of size 832...
18:27:20 GMT +1:00 [DEBUG] - Message sent
18:27:20 GMT +1:00 [DEBUG] - Finished sending data of size 832.
18:27:20 GMT +1:00 [DEBUG] - Header: 
18:27:20 GMT +1:00 [DEBUG] - Reading response...
18:27:20 GMT +1:00 [DEBUG] - Content-length: 1449
18:27:20 GMT +1:00 [DEBUG] - Receiving data of size 1449...
18:27:20 GMT +1:00 [DEBUG] - Finished receiving data of size 1449.
18:27:20 GMT +1:00 [DEBUG] - Response read:
<?xml version="1.0" encoding="UTF-8"?><SyncML xmlns="syncml:syncml1.1"><SyncHdr><VerDTD>1.1</VerDTD><VerProto>SyncML/1.1</VerProto><SessionID>1186676840</SessionID><MsgID>1</MsgID><Target><LocURI>fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24=</LocURI><LocName>ronan</LocName></Target><Source><LocURI>http://192.168.1.22/horde/rpc.php</LocURI></Source><Meta><MaxMsgSize xmlns="syncml:metinf">1000000</MaxMsgSize><MaxObjSize xmlns="syncml:metinf">31000</MaxObjSize></Meta></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>212</Data></Status><Status><CmdID>2</CmdID><MsgRef>1</MsgRef><CmdRef>1</CmdRef><Cmd>Alert</Cmd><TargetRef>scard</TargetRef><SourceRef>contact</SourceRef><Data>508</Data><Item><Data><Anchor xmlns="syncml:metinf"><Last>1186676781</Last><Next>1186676840</Next></Anchor></Data></Item></Status><Alert><CmdID>3</CmdID><Data>201</Data><Item><Target><LocURI>contact</LocURI></Target><Source><LocURI>scard</LocURI></Source><Meta><Anchor xmlns="syncml:metinf"><Last>0</Last><Next>1186676841</Next></Anchor><MaxObjSize xmlns="syncml:metinf">31000</MaxObjSize></Meta></Item></Alert><Get><CmdID>4</CmdID><Meta><Type xmlns="syncml:metinf">application/vnd.syncml-devinf+xml</Type></Meta><Item><Target><LocURI>./devinf11</LocURI></Target></Item></Get><Final></Final></SyncBody></SyncML>nVtYmVyŽ
18:27:20 GMT +1:00 [DEBUG] - Server requested syncmode "slow" for contact.
18:27:20 GMT +1:00 [DEBUG] - Checking for forced slow-sync...
18:27:21 GMT +1:00 [DEBUG] - ---------------------- contact BEGIN (mode "slow") ----------------------
18:27:21 GMT +1:00 [DEBUG] - beginSync of contact source: opening Outlook session...
18:27:21 GMT +1:00 [DEBUG] - Initialize COM library
18:27:21 GMT +1:00 [DEBUG] - Create Outlook.Application instance...
18:27:21 GMT +1:00 [DEBUG] - Logon to Outlook MAPI: default profile, show-dialog = true, new-session = false
18:27:21 GMT +1:00 [INFO] - Outlook session opened successfully! Using: Outlook 2003.
18:27:22 GMT +1:00 [DEBUG] - Reading ALL contacts from folder '\\Dossiers personnels\Contacts' (1 found)...
18:27:22 GMT +1:00 [INFO] - Total contact items to send: 1
18:27:24 GMT +1:00 [INFO] - Retrieved contact item: "Test From Outlook"
18:27:24 GMT +1:00 [DEBUG] - Modification message: estimated size 2784, allowed size 250000, real size 4909 / estimated size 2784 = 176%
18:27:24 GMT +1:00 [DEBUG] - <?xml version="1.0" encoding="UTF-8"?>
<SyncML>
<SyncHdr><VerDTD>1.1</VerDTD>
<VerProto>SyncML/1.1</VerProto>
<SessionID>1186676840</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>
<Status><CmdID>2</CmdID>
<MsgRef>1</MsgRef>
<CmdRef>3</CmdRef>
<Cmd>Alert</Cmd>
<TargetRef>scard</TargetRef>
<SourceRef>contact</SourceRef>
<Data>200</Data>
<Item><Data><Anchor xmlns="syncml:metinf"><Next>1186676841</Next>
</Anchor>
</Data>
</Item>
</Status>
<Status><CmdID>4</CmdID>
<MsgRef>1</MsgRef>
<CmdRef>4</CmdRef>
<Cmd>Get</Cmd>
<Data>200</Data>
</Status>
<Results><CmdID>3</CmdID>
<MsgRef>1</MsgRef>
<CmdRef>4</CmdRef>
<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>
</Results>
<Sync><CmdID>5</CmdID>
<Target><LocURI>scard</LocURI>
</Target>
<Source><LocURI>contact</LocURI>
</Source>
<Replace><CmdID>6</CmdID>
<Meta><Type xmlns="syncml:metinf">text/x-s4j-sifc</Type>
</Meta>
<Item><Source><LocURI>00000000DFF17A2F3489704AA02A0F476A2D5C8184022000</LocURI>
</Source>
<Meta><Format xmlns="syncml:metinf">b64</Format>
</Meta>
<Data><![CDATA[PD94bWwgdmVyc2lvbj0iMS4wIiBlbmNvZGluZz0iVVRGLTgiPz4KPGNvbnRhY3Q+CjxGb2xkZXI+REVGQVVMVF9GT0xERVI8L0ZvbGRlcj4KPEFubml2ZXJzYXJ5Lz4KPEFzc2lzdGFudE5hbWUvPgo8QXNzaXN0YW50VGVsZXBob25lTnVtYmVyLz4KPEJpbGxpbmdJbmZvcm1hdGlvbi8+CjxCaXJ0aGRheS8+CjxCb2R5Lz4KPEJ1c2luZXNzMlRlbGVwaG9uZU51bWJlci8+CjxCdXNpbmVzc0FkZHJlc3NDaXR5Lz4KPEJ1c2luZXNzQWRkcmVzc0NvdW50cnkvPgo8QnVzaW5lc3NBZGRyZXNzUG9zdGFsQ29kZS8+CjxCdXNpbmVzc0FkZHJlc3NQb3N0T2ZmaWNlQm94Lz4KPEJ1c2luZXNzQWRkcmVzc1N0YXRlLz4KPEJ1c2luZXNzQWRkcmVzc1N0cmVldC8+CjxCdXNpbmVzc0ZheE51bWJlci8+CjxCdXNpbmVzc1RlbGVwaG9uZU51bWJlcj4yMzEzPC9CdXNpbmVzc1RlbGVwaG9uZU51bWJlcj4KPEJ1c2luZXNzV2ViUGFnZS8+CjxDYWxsYmFja1RlbGVwaG9uZU51bWJlci8+CjxDYXJUZWxlcGhvbmVOdW1iZXIvPgo8Q2F0ZWdvcmllcy8+CjxDaGlsZHJlbi8+CjxDb21wYW5pZXMvPgo8Q29tcGFueU1haW5UZWxlcGhvbmVOdW1iZXIvPgo8Q29tcGFueU5hbWUvPgo8Q29tcHV0ZXJOZXR3b3JrTmFtZS8+CjxEZXBhcnRtZW50Lz4KPEVtYWlsMUFkZHJlc3M+c2RmZHNAbWJwLmxvY2FsPC9FbWFpbDFBZGRyZXNzPgo8RW1haWwxQWRkcmVzc1R5cGU+U01UUDwvRW1haWwxQWRkcmVzc1R5cGU+CjxFbWFpbDJBZGRyZXNzLz4KPEVtYWlsMkFkZHJlc3NUeXBlLz4KPEVtYWlsM0FkZHJlc3MvPgo8RW1haWwzQWRkcmVzc1R5cGUvPgo8RmlsZUFzPk91dGxvb2ssIFRlc3QgRnJvbTwvRmlsZUFzPgo8Rmlyc3ROYW1lPlRlc3Q8L0ZpcnN0TmFtZT4KPEdlbmRlcj4wPC9HZW5kZXI+CjxIb2JieS8+CjxIb21lMlRlbGVwaG9uZU51bWJlci8+CjxIb21lQWRkcmVzc0NpdHkvPgo8SG9tZUFkZHJlc3NDb3VudHJ5Lz4KPEhvbWVBZGRyZXNzUG9zdGFsQ29kZS8+CjxIb21lQWRkcmVzc1Bvc3RPZmZpY2VCb3gvPgo8SG9tZUFkZHJlc3NTdGF0ZS8+CjxIb21lQWRkcmVzc1N0cmVldC8+CjxIb21lRmF4TnVtYmVyLz4KPEhvbWVUZWxlcGhvbmVOdW1iZXI+NjQ2NTQ2NTQ5ODc8L0hvbWVUZWxlcGhvbmVOdW1iZXI+CjxIb21lV2ViUGFnZS8+CjxJTUFkZHJlc3MvPgo8SW1wb3J0YW5jZT4xPC9JbXBvcnRhbmNlPgo8SW5pdGlhbHM+VC5GLk8uPC9Jbml0aWFscz4KPEpvYlRpdGxlLz4KPExhbmd1YWdlLz4KPExhc3ROYW1lPk91dGxvb2s8L0xhc3ROYW1lPgo8TWFpbGluZ0FkZHJlc3MvPgo8TWFuYWdlck5hbWUvPgo8TWlkZGxlTmFtZT5Gcm9tPC9NaWRkbGVOYW1lPgo8TWlsZWFnZS8+CjxNb2JpbGVUZWxlcGhvbmVOdW1iZXIvPgo8Tmlja05hbWUvPgo8T2ZmaWNlTG9jYXRpb24vPgo8T3JnYW5pemF0aW9uYWxJRE51bWJlci8+CjxPdGhlckFkZHJlc3NDaXR5Lz4KPE90aGVyQWRkcmVzc0NvdW50cnkvPgo8T3RoZXJBZGRyZXNzUG9zdGFsQ29kZS8+CjxPdGhlckFkZHJlc3NQb3N0T2ZmaWNlQm94Lz4KPE90aGVyQWRkcmVzc1N0YXRlLz4KPE90aGVyQWRkcmVzc1N0cmVldC8+CjxPdGhlckZheE51bWJlci8+CjxPdGhlclRlbGVwaG9uZU51bWJlci8+CjxQYWdlck51bWJlci8+CjxQcmltYXJ5VGVsZXBob25lTnVtYmVyLz4KPFByb2Zlc3Npb24vPgo8UmFkaW9UZWxlcGhvbmVOdW1iZXIvPgo8U2Vuc2l0aXZpdHk+MDwvU2Vuc2l0aXZpdHk+CjxTcG91c2UvPgo8U3ViamVjdD5UZXN0IEZyb20gT3V0bG9vazwvU3ViamVjdD4KPFN1ZmZpeC8+CjxUZWxleE51bWJlci8+CjxUaXRsZS8+CjxXZWJQYWdlLz4KPFlvbWlDb21wYW55TmFtZS8+CjxZb21pRmlyc3ROYW1lLz4KPFlvbWlMYXN0TmFtZS8+CjwvY29udGFjdD4K]]></Data>
</Item>
</Replace>
</Sync>
<Final/></SyncBody>
</SyncML>
18:27:24 GMT +1:00 [DEBUG] - Modifications sent.
18:27:24 GMT +1:00 [DEBUG] - Connecting to 192.168.1.22:80
18:27:24 GMT +1:00 [DEBUG] - Requesting resource /horde/rpc.php
18:27:24 GMT +1:00 [DEBUG] - Sending data of size 4909...
18:27:24 GMT +1:00 [DEBUG] - Message sent
18:27:24 GMT +1:00 [DEBUG] - Finished sending data of size 4909.
18:27:24 GMT +1:00 [DEBUG] - Header: 
18:27:24 GMT +1:00 [DEBUG] - Reading response...
18:27:24 GMT +1:00 [DEBUG] - Content-length: 1186
18:27:24 GMT +1:00 [DEBUG] - Receiving data of size 1186...
18:27:24 GMT +1:00 [DEBUG] - Finished receiving data of size 1186.
18:27:24 GMT +1:00 [DEBUG] - Response read:
<?xml version="1.0" encoding="UTF-8"?><SyncML xmlns="syncml:syncml1.1"><SyncHdr><VerDTD>1.1</VerDTD><VerProto>SyncML/1.1</VerProto><SessionID>1186676840</SessionID><MsgID>2</MsgID><Target><LocURI>fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24=</LocURI><LocName>ronan</LocName></Target><Source><LocURI>http://192.168.1.22/horde/rpc.php</LocURI></Source><Meta><MaxMsgSize xmlns="syncml:metinf">1000000</MaxMsgSize><MaxObjSize xmlns="syncml:metinf">31000</MaxObjSize></Meta></SyncHdr><SyncBody><Status><CmdID>1</CmdID><MsgRef>2</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><Status><CmdID>2</CmdID><MsgRef>2</MsgRef><CmdRef>3</CmdRef><Cmd>Results</Cmd><SourceRef>./devinf11</SourceRef><Data>200</Data></Status><Status><CmdID>3</CmdID><MsgRef>2</MsgRef><CmdRef>5</CmdRef><Cmd>Sync</Cmd><TargetRef>scard</TargetRef><SourceRef>contact</SourceRef><Data>200</Data></Status><Status><CmdID>4</CmdID><MsgRef>2</MsgRef><CmdRef>6</CmdRef><Cmd>Replace</Cmd><SourceRef>00000000DFF17A2F3489704AA02A0F476A2D5C8184022000</SourceRef><Data>200</Data></Status></SyncBody></SyncML>4KPEdl¯
18:27:24 GMT +1:00 [DEBUG] - contact item - Replace on server (key:00000000DFF17A2F3489704AA02A0F476A2D5C8184022000, code 200)
18:27:24 GMT +1:00 [DEBUG] - ---------------------- contact END (mode "slow") ----------------------
18:27:24 GMT +1:00 [DEBUG] - Server requested syncmode "slow" for contact.
18:27:24 GMT +1:00 [DEBUG] - Alert to request server changes
18:27:24 GMT +1:00 [DEBUG] - <?xml version="1.0" encoding="UTF-8"?>
<SyncML>
<SyncHdr><VerDTD>1.1</VerDTD>
<VerProto>SyncML/1.1</VerProto>
<SessionID>1186676840</SessionID>
<MsgID>3</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>2</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>
<Alert><CmdID>2</CmdID>
<Data>222</Data>
<Item><Target><LocURI>scard</LocURI>
</Target>
<Source><LocURI>contact</LocURI>
</Source>
</Item>
</Alert>
<Final/></SyncBody>
</SyncML>
18:27:24 GMT +1:00 [DEBUG] - Connecting to 192.168.1.22:80
18:27:24 GMT +1:00 [DEBUG] - Requesting resource /horde/rpc.php
18:27:24 GMT +1:00 [DEBUG] - Sending data of size 726...
18:27:25 GMT +1:00 [DEBUG] - Message sent
18:27:25 GMT +1:00 [DEBUG] - Finished sending data of size 726.
18:27:25 GMT +1:00 [DEBUG] - Header: 
18:27:25 GMT +1:00 [DEBUG] - Reading response...
18:27:25 GMT +1:00 [DEBUG] - Content-length: 979
18:27:25 GMT +1:00 [DEBUG] - Receiving data of size 979...
18:27:25 GMT +1:00 [DEBUG] - Finished receiving data of size 979.
18:27:25 GMT +1:00 [DEBUG] - Response read:
<?xml version="1.0" encoding="UTF-8"?><SyncML xmlns="syncml:syncml1.1"><SyncHdr><VerDTD>1.1</VerDTD><VerProto>SyncML/1.1</VerProto><SessionID>1186676840</SessionID><MsgID>3</MsgID><Target><LocURI>fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24=</LocURI><LocName>ronan</LocName></Target><Source><LocURI>http://192.168.1.22/horde/rpc.php</LocURI></Source><Meta><MaxMsgSize xmlns="syncml:metinf">1000000</MaxMsgSize><MaxObjSize xmlns="syncml:metinf">31000</MaxObjSize></Meta></SyncHdr><SyncBody><Status><CmdID>1</CmdID><MsgRef>3</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><Status><CmdID>2</CmdID><MsgRef>3</MsgRef><CmdRef>2</CmdRef><Cmd>Alert</Cmd><Data>200</Data></Status><Sync><CmdID>3</CmdID><Target><LocURI>contact</LocURI></Target><Source><LocURI>scard</LocURI></Source><NumberOfChanges>3</NumberOfChanges></Sync><Final></Final></SyncBody></SyncML>
18:27:25 GMT +1:00 [DEBUG] - ---------------------- contact BEGIN (mode "slow") ----------------------
18:27:25 GMT +1:00 [INFO] - Total contact items to receive: 3
18:27:25 GMT +1:00 [DEBUG] - ---------------------- contact END (mode "slow") ----------------------
18:27:25 GMT +1:00 [DEBUG] - Server requested syncmode "slow" for contact.
18:27:25 GMT +1:00 [DEBUG] - Mapping
18:27:25 GMT +1:00 [DEBUG] - <?xml version="1.0" encoding="UTF-8"?>
<SyncML>
<SyncHdr><VerDTD>1.1</VerDTD>
<VerProto>SyncML/1.1</VerProto>
<SessionID>1186676840</SessionID>
<MsgID>4</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>3</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>
<Status><CmdID>2</CmdID>
<MsgRef>3</MsgRef>
<CmdRef>3</CmdRef>
<Cmd>Sync</Cmd>
<TargetRef>scard</TargetRef>
<SourceRef>contact</SourceRef>
<Data>200</Data>
</Status>
<Final/></SyncBody>
</SyncML>
18:27:25 GMT +1:00 [DEBUG] - Finalization sent.
18:27:25 GMT +1:00 [DEBUG] - Connecting to 192.168.1.22:80
18:27:25 GMT +1:00 [DEBUG] - Requesting resource /horde/rpc.php
18:27:25 GMT +1:00 [DEBUG] - Sending data of size 744...
18:27:25 GMT +1:00 [DEBUG] - Message sent
18:27:25 GMT +1:00 [DEBUG] - Finished sending data of size 744.
18:27:25 GMT +1:00 [DEBUG] - Header: HTTP/1.0 200 OK
Date: Thu, 09 Aug 2007 16:27:25 GMT
Server: Apache/2.2.2 (Fedora)
X-Powered-By: PHP/5.2.1
Set-Cookie: PHPSESSID=5af5303f8f4c94574bf53b14c8e393b7; path=/
Expires: Thu, 19 Nov 1981 08:52:00 GMT
Cache-Control: no-store, no-cache, must-revalidate, post-check=0, pre-check=0
Pragma: no-cache
Content-Length: 733
Accept-Charset: UTF-8
Content-Type: application/vnd.syncml+xml
X-Cache: MISS from fw.mbp.local
Proxy-Connection: keep-alive

18:27:25 GMT +1:00 [DEBUG] - Reading response...
18:27:25 GMT +1:00 [DEBUG] - Content-length: 733
18:27:25 GMT +1:00 [DEBUG] - Receiving data of size 733...
18:27:25 GMT +1:00 [DEBUG] - Finished receiving data of size 733.
18:27:25 GMT +1:00 [DEBUG] - Response read:
<?xml version="1.0" encoding="UTF-8"?><SyncML xmlns="syncml:syncml1.1"><SyncHdr><VerDTD>1.1</VerDTD><VerProto>SyncML/1.1</VerProto><SessionID>1186676840</SessionID><MsgID>4</MsgID><Target><LocURI>fol-TUJQLTRCREIyRjhFOTUwOnJzYWxtb24=</LocURI><LocName>ronan</LocName></Target><Source><LocURI>http://192.168.1.22/horde/rpc.php</LocURI></Source><Meta><MaxMsgSize xmlns="syncml:metinf">1000000</MaxMsgSize><MaxObjSize xmlns="syncml:metinf">31000</MaxObjSize></Meta></SyncHdr><SyncBody><Status><CmdID>1</CmdID><MsgRef>4</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><Final></Final></SyncBody></SyncML>>

18:27:25 GMT +1:00 [DEBUG] - Committing source contact (next: 1186676840)
18:27:25 GMT +1:00 [DEBUG] - ret: 0, lastErrorCode: 0, lastErrorMessage: 
18:27:25 GMT +1:00 [INFO] - END of Synchronization session.
18:27:25 GMT +1:00 [INFO] - 
============================================================
================   SYNCHRONIZATION REPORT   ================
============================================================

SYNCHRONIZATION COMPLETED SUCCESSFULLY!
---------------------------------------

Contacts:
---------
    Sync completed successfully!
    Sync type: slow (requested by Server)

            | on Client | on Server
    --------|-----------|----------
    New     |    0/   0 |    0/   0 
    Updated |    0/   0 |    1/   1 
    Deleted |    0/   0 |    0/   0 

18:27:25 GMT +1:00 [DEBUG] - Saving configuration to winRegistry
18:27:25 GMT +1:00 [DEBUG] - Writing configuration settings to the management tree
18:27:25 GMT +1:00 [DEBUG] - Closing Outlook...
18:27:25 GMT +1:00 [DEBUG] - Deleting ClientApplication instance
18:27:25 GMT +1:00 [INFO] - Outlook session closed successfully.
18:27:25 GMT +1:00 [DEBUG] - Closing COM library...
18:27:25 GMT +1:00 [DEBUG] - Releasing sync-mutex...
18:27:25 GMT +1:00 [DEBUG] - Sync-mutex released - closing handle.
18:27:25 GMT +1:00 [DEBUG] - Delete SyncSources...
18:27:25 GMT +1:00 [INFO] - Syncronization process completed.