Hi all,

TypeError: in method 'OSyncChange_set_uid', argument 1 of type 'OSyncChange *'

This has come up a number of times for me, and it's always a bit of
voodoo to get rid of it.  As a result I haven't synced my phone for 6
months or so (which is why I've been so quiet here!)

Today I decided to try it again, and after much reinstalling and
patching which didn't fix it, I factory reset my phone (Treo Pro).

I deleted all synce related settings from my PC and re-created the
partnership, and it worked!  Synced flawlessly about 6 or 7 times.  I
restored the contacts from evolution, started editing them, adding
details etc. (all from evolution) and all syncs were fine.

Then I added 2 calendar entries from the mobile, and when I try and
sync, I get this error again!  Attached is the msynctool output and the
sync-engine log file...

I know Dr Gow was looking into this some time ago but the results were
not repeatable for him.  There is some talk about it here:
https://www.opensync.org/ticket/1131 but the patch didn't work for me
this time (it's worked previously I think...)

Does anyone have any thoughts on this?  I'm happy to try any patches or
start again from scratch, since I've just done a factory reset anyway!

Much appreciated!
-- 
Iain Buchanan <iaindb at netspace dot net dot au>

Chemicals, n.:
        Noxious substances from which modern foods are made.
$ msynctool --sync synce-sync
Synchronizing group "synce-sync" 
DEBUG:SynCE:Connect() called
Member 2 of type synce-opensync-plugin just connected
Member 1 of type evo2-sync just connected
All clients connected or error
DEBUG:SynCE:get_changeinfo() called
INFO:SynCE:initiating device synchronization
INFO:SynCE:waiting for engine to complete sync
Received an entry cf69dbdc-a691-449f-9386-1d9abf76a8ed with data of size 4 from 
member 1 (evo2-sync). Changetype MODIFIED
Received an entry cf69dbdc-a691-449f-9386-1d9abf76a8ed with data of size 4 from 
member 1 (evo2-sync). Changetype MODIFIED
Member 1 of type evo2-sync just sent all changes
INFO:SynCE:device synchronization complete
DEBUG:SynCE:requesting remote changes
DEBUG:SynCE:got 2 changesets
DEBUG:SynCE:processing changes for 2 items of item type 0
Traceback (most recent call last):
  File "/usr/lib/opensync/python-plugins/synce-opensync-plugin.py", line 174, 
in get_changeinfo
    change.uid = array.array('B',guid).tostring() 
  File "/usr/lib/python2.6/site-packages/opensync.py", line 192, in set_uid
    def set_uid(self, *args): return _opensync.OSyncChange_set_uid(self, *args)
TypeError: in method 'OSyncChange_set_uid', argument 1 of type 'OSyncChange *'
Member 2 of type synce-opensync-plugin had an error while getting changes: 
Error during get_changeinfo() method
DEBUG:SynCE:disconnect() called
Member 2 of type synce-opensync-plugin just disconnected
Member 1 of type evo2-sync just disconnected
All clients have disconnected
The sync failed: Unable to read from one of the members
DEBUG:SynCE:finalize() called
All conflicts have been reported
Error while synchronizing: Unable to read from one of the members
2010-02-23 16:10:08,320 DEBUG syncengine : running main loop
2010-02-23 16:10:08,320 DEBUG syncengine : creating SyncEngine object
2010-02-23 16:10:08,330 INFO engine.syncengine.kernel : __init__: connected device found
2010-02-23 16:10:08,333 INFO engine.syncengine.kernel : _CBHalDeviceConnected: device connected at udi /org/freedesktop/Hal/devices/net_80_00_60_0f_e8_00
2010-02-23 16:10:08,333 INFO engine.config.Config : UpdateConfig - unable to open config file /etc/syncengine.conf.xml ([Errno 2] No such file or directory: '/etc/syncengine.conf.xml') - using defaults
2010-02-23 16:10:08,335 INFO engine.syncengine.kernel :  device Treo connected
2010-02-23 16:10:08,336 INFO engine.syncengine.kernel : ProcessAuth : processing authorization for device 'Treo'
2010-02-23 16:10:08,337 INFO engine.syncengine.kernel : ProcessAuth: authorization not required for device 'Treo'
2010-02-23 16:10:08,337 DEBUG engine.syncengine.kernel : OnConnect: setting up RAPI session
2010-02-23 16:10:08,369 DEBUG engine.syncengine.kernel : OnConnect: Attempting to bind partnerships
2010-02-23 16:10:08,369 INFO engine.partnerships.Partnerships : AttemptToBind: Reading partnerships and looking for host binding
2010-02-23 16:10:08,369 INFO engine.partnerships.Partnerships : ClearDevicePartnerships: clearing all device partnership info
2010-02-23 16:10:08,369 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: reading partnerships from device registry
2010-02-23 16:10:08,401 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: read partnership ID = 197400468, Hostname = orpheus
2010-02-23 16:10:08,402 DEBUG engine.partnerships.Partnerships : _read_device: Adding entry
2010-02-23 16:10:08,418 WARNING engine.partnerships.Partnerships : ReadDevicePartnerships: Error getting partnership key 2 from device registry: 2: The system cannot find the file specified.
2010-02-23 16:10:08,427 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: querying synchronization source information from device
2010-02-23 16:10:08,427 DEBUG engine.xmlutil : _config_query: CeProcessConfig request is 
<wap-provisioningdoc>
  <characteristic type="Sync">
    <characteristic-query recursive="false" type="Sources"/>
  </characteristic>
</wap-provisioningdoc>
2010-02-23 16:10:09,559 DEBUG engine.xmlutil : _config_query: CeProcessConfig response is 
<?xml version="1.0" encoding="utf-8"?>
<wap-provisioningdoc>
  <characteristic type="Sync">
    <characteristic recursive="false" type="Sources">
      <characteristic type="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}"/>
    </characteristic>
  </characteristic>
</wap-provisioningdoc>

2010-02-23 16:10:09,560 DEBUG engine.xmlutil : _config_query: CeProcessConfig request is 
<wap-provisioningdoc>
  <characteristic type="Sync">
    <characteristic type="Sources">
      <characteristic-query type="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}"/>
    </characteristic>
  </characteristic>
</wap-provisioningdoc>
2010-02-23 16:10:10,531 DEBUG engine.xmlutil : _config_query: CeProcessConfig response is 
<?xml version="1.0" encoding="utf-8"?>
<wap-provisioningdoc>
  <characteristic type="Sync">
    <characteristic type="Sources">
      <characteristic type="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}">
        <characteristic type="Engines">
          <characteristic type="{176F4FFD-F20C-4BD4-BDD7-01D0726C567B}">
            <characteristic type="CarrierConnectorList"/>
            <characteristic type="Providers">
              <characteristic type="{7E29B5F7-C686-4B0C-9892-FD8BAD8E0D08}">
                <parm name="Enabled" value="0"/>
                <parm name="Name" value="Favorites"/>
                <parm name="ReadOnly" value="1"/>
              </characteristic>
              <characteristic type="{0DD8685C-E272-4FCB-9ECF-2EAD7EA2497B}">
                <parm name="Enabled" value="1"/>
                <parm name="Name" value="Contacts"/>
                <parm name="ReadOnly" value="0"/>
              </characteristic>
              <characteristic type="{89768ABD-D173-18E3-16EC-98034F67B775}">
                <parm name="Enabled" value="0"/>
                <parm name="Name" value="WorldMate"/>
                <parm name="ReadOnly" value="0"/>
              </characteristic>
              <characteristic type="{C6D47067-6E92-480E-B0FC-4BA82182FAC7}">
                <parm name="Enabled" value="0"/>
                <parm name="Name" value="E-mail"/>
                <parm name="ReadOnly" value="0"/>
              </characteristic>
              <characteristic type="{8E98CB51-85A4-4777-8DEB-A0298DF8899F}">
                <parm name="Enabled" value="0"/>
                <parm name="Name" value="Notes"/>
                <parm name="ReadOnly" value="1"/>
              </characteristic>
              <characteristic type="{BEA275EB-E3B7-641F-3D77-752349BAAA63}">
                <parm name="Enabled" value="0"/>
                <parm name="Name" value="AvantGo"/>
                <parm name="ReadOnly" value="1"/>
              </characteristic>
              <characteristic type="{783AE4F6-4C12-4423-8270-66361260D4F1}">
                <parm name="Enabled" value="0"/>
                <parm name="Name" value="Tasks"/>
                <parm name="ReadOnly" value="0"/>
              </characteristic>
              <characteristic type="{A38DEEBF-C535-D8E2-AE24-8AE61845CF82}">
                <parm name="Enabled" value="0"/>
                <parm name="Name" value="Media"/>
                <parm name="ReadOnly" value="1"/>
              </characteristic>
              <characteristic type="{4A5D9FE0-F139-4A63-A5A4-4F31CEEA02AD}">
                <parm name="Enabled" value="1"/>
                <parm name="Name" value="Calendar"/>
                <parm name="ReadOnly" value="0"/>
              </characteristic>
              <characteristic type="{B7B6ACB2-AF1D-43F5-BF9A-586111B263EF}">
                <parm name="Enabled" value="0"/>
                <parm name="Name" value="Files"/>
                <parm name="ReadOnly" value="0"/>
              </characteristic>
            </characteristic>
            <characteristic type="Settings">
              <parm name="CarrierConnector" value=""/>
              <parm name="ClientNegotiated" value="1"/>
              <parm name="ClientProtocolVersion" value="2.5"/>
              <parm name="ConflictResolution" value="1"/>
              <parm name="DeviceAddressingMethod" value="0"/>
              <parm name="DevicePhoneNumber" value=""/>
              <parm name="DeviceSMSAddress" value=""/>
              <parm name="Domain" value="DEFAULT"/>
              <parm name="EmailAddress" value=""/>
              <parm name="Logging" value="0"/>
              <parm name="NotificationsSupported" value="0"/>
              <parm name="RefreshCertAuthXml" value="0"/>
              <parm name="SavePassword" value="1"/>
              <parm name="ServerAutdSupport" value="0"/>
              <parm name="ServerCertAuthRequired" value="0"/>
              <parm name="ServerHTMLMailSupport" value="0"/>
              <parm name="URI" value="Microsoft-Server-ActiveSync"/>
              <parm name="UseSSL" value="0"/>
              <parm name="User" value="DEFAULT"/>
            </characteristic>
          </characteristic>
        </characteristic>
        <parm name="Name" value="TreoPro"/>
        <parm name="Server" value="orpheus"/>
        <parm name="StoreType" value="2"/>
      </characteristic>
    </characteristic>
  </characteristic>
</wap-provisioningdoc>

2010-02-23 16:10:10,565 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: read source GUID = {FE585A55-CE5A-7163-4F4A-34E7810E5F69}, Hostname = orpheus, Description = TreoPro
2010-02-23 16:10:10,565 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: source matches partnerhip from registry.  Initializing partnership
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: querying partnerhip synchronization items (providers)
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider Files
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider Calendar
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: provider is enabled
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: provider ID is 0
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider Media
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider Tasks
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider AvantGo
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider Notes
2010-02-23 16:10:10,566 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider E-mail
2010-02-23 16:10:10,567 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider WorldMate
2010-02-23 16:10:10,567 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider Contacts
2010-02-23 16:10:10,567 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: provider is enabled
2010-02-23 16:10:10,567 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: provider ID is 1
2010-02-23 16:10:10,567 DEBUG engine.partnerships.Partnerships : ReadDevicePartnerships: found provider Favorites
2010-02-23 16:10:10,572 INFO engine.partnerships.Partnership : AttemptToBind : bound partnership P1: id=0xbc41794, guid="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}", hostname="orpheus", name="TreoPro", sync_items=[ Calendar, Contacts ] - running config
2010-02-23 16:10:10,572 INFO engine.partnerships.Partnership : synchronization of time to host is disabled
2010-02-23 16:10:10,572 INFO engine.partnerships.Partnership : DTPT multihoming is disabled
2010-02-23 16:10:10,572 DEBUG engine.xmlutil : _config_query: CeProcessConfig request is 
<wap-provisioningdoc>
  <characteristic type="Sync">
    <characteristic type="Settings">
      <parm name="AllowDTPTMultihoming" value="0"/>
    </characteristic>
  </characteristic>
</wap-provisioningdoc>
2010-02-23 16:10:11,234 DEBUG engine.xmlutil : _config_query: CeProcessConfig response is 
<?xml version="1.0" encoding="utf-8"?>
<wap-provisioningdoc>
  <characteristic type="Sync">
    <characteristic type="Settings">
      <parm name="AllowDTPTMultihoming" value="0"/>
    </characteristic>
  </characteristic>
</wap-provisioningdoc>

2010-02-23 16:10:11,234 DEBUG engine.partnerships.Partnerships : AttemptToBind: Valid host binding found for partnership in slot 1
2010-02-23 16:10:11,547 DEBUG engine.syncengine.kernel : StartSessions: DTPT starting
2010-02-23 16:10:11,548 DEBUG engine.syncengine.kernel : StartSessions: starting AirSync handler
2010-02-23 16:10:11,549 DEBUG engine.airsync.AirsyncThread : run: listening for Airsync requests
2010-02-23 16:10:11,549 DEBUG engine.syncengine.kernel : StartSessions: calling RAPI start_replication
2010-02-23 16:10:11,576 DEBUG engine.syncengine.kernel : StartSessions: calling RAPI sync_resume
2010-02-23 16:10:11,689 DEBUG engine.syncengine.kernel : StartSessions: starting RRA session
2010-02-23 16:10:11,689 INFO RRAThread : new RRA handler thread created
2010-02-23 16:10:11,689 INFO RRASyncManager : connecting to RRA
2010-02-23 16:10:12,546 INFO RRASyncManager : connected
2010-02-23 16:10:12,546 DEBUG RRAThread : have 5 object types
2010-02-23 16:10:12,546 DEBUG RRASyncManager : No RRA type subscriptions - ignoring RRA sync items
2010-02-23 16:10:12,547 DEBUG RRAThread : run: starting RRA event loop
[rra_syncmgr_start_events:664] No valid subscriptions
2010-02-23 16:10:12,547 DEBUG syncengine : installing signal handlers
2010-02-23 16:10:16,333 INFO engine.syncengine.dtptserver : starting NSP session
2010-02-23 16:10:16,333 INFO engine.syncengine.dtptserver : dispatching 1 9 2713981935897530272 272 160
2010-02-23 16:10:16,340 INFO engine.syncengine.dtptserver : dispatching 1 11 1433520789 0 1008
2010-02-23 16:10:21,536 INFO engine.syncengine.dtptserver : dispatching 1 13 1433520789 0 0
2010-02-23 16:10:21,536 INFO engine.syncengine.dtptserver : removing thread
2010-02-23 16:10:21,560 INFO engine.syncengine.dtptserver : starting connection session
2010-02-23 16:10:23,043 INFO engine.syncengine.dtptserver : ConnectionSession - zero bytes received - exitting
2010-02-23 16:10:23,043 INFO engine.syncengine.dtptserver : removing thread
2010-02-23 16:10:48,208 INFO engine.syncengine.kernel : Synchronize: manual sync triggered
2010-02-23 16:10:48,209 INFO engine.syncengine.kernel : Synchronize: starting manual sync with partnership P1: id=0xbc41794, guid="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}", hostname="orpheus", name="TreoPro", sync_items=[ Calendar, Contacts ]
2010-02-23 16:10:48,209 INFO engine.partnerships.Partnership : loading itemDB for item 0
2010-02-23 16:10:48,210 INFO engine.partnerships.Partnership : loading itemDB for item 1
2010-02-23 16:10:48,211 INFO engine.syncengine.kernel : Synchronize: itemDB loaded
2010-02-23 16:10:48,212 INFO engine.syncengine.kernel : Synchronize: leaving method
2010-02-23 16:10:48,227 DEBUG engine.synchandler.SyncHandler : run: sending request to device 
<sync xmlns="http://schemas.microsoft.com/as/2004/core"; type="Interactive">
  <partner id="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}"/>
</sync>
2010-02-23 16:10:48,361 DEBUG engine.synchandler.SyncHandler : run: performing synchronization
2010-02-23 16:10:48,455 INFO engine.airsync.AirsyncServer : do_POST: received Status command
2010-02-23 16:10:48,455 DEBUG engine.airsync.AirsyncServer : _ProcessStatus: request document is 
<?xml version="1.0" encoding="utf-8"?>
<SyncStatus>
  <SyncBegin Partner="" Datatype=""/>
</SyncStatus>

2010-02-23 16:10:48,455 INFO engine.syncengine.kernel : Status: Emitting StatusSyncStart signal
2010-02-23 16:10:48,455 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Emitting response 200 code to client
2010-02-23 16:10:48,455 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2010-02-23 16:10:48,455 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Finished emitting response 200 code to client
2010-02-23 16:10:48,771 INFO engine.airsync.AirsyncServer : do_POST: received Status command
2010-02-23 16:10:48,771 DEBUG engine.airsync.AirsyncServer : _ProcessStatus: request document is 
<?xml version="1.0" encoding="utf-8"?>
<SyncStatus>
  <SyncBegin Partner="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}" Datatype=""/>
</SyncStatus>

2010-02-23 16:10:48,771 INFO engine.syncengine.kernel : Status: Emitting StatusSyncStartPartner signal
2010-02-23 16:10:48,771 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Emitting response 200 code to client
2010-02-23 16:10:48,772 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2010-02-23 16:10:48,772 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Finished emitting response 200 code to client
2010-02-23 16:10:49,455 INFO engine.airsync.AirsyncServer : do_POST: received Status command
2010-02-23 16:10:49,456 DEBUG engine.airsync.AirsyncServer : _ProcessStatus: request document is 
<?xml version="1.0" encoding="utf-8"?>
<SyncStatus>
  <Status Partner="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}">
    <Progress value="0"/>
  </Status>
  <Status Partner="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}">
    <Total value="100"/>
  </Status>
</SyncStatus>

2010-02-23 16:10:49,456 INFO engine.syncengine.kernel : Status: Emitting StatusSetProgressValue signal
2010-02-23 16:10:49,456 INFO engine.syncengine.kernel : Status: Emitting StatusSetMaxProgressValue signal
2010-02-23 16:10:49,456 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Emitting response 200 code to client
2010-02-23 16:10:49,457 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2010-02-23 16:10:49,457 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Finished emitting response 200 code to client
2010-02-23 16:10:49,706 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Emitting response 200 code to client
2010-02-23 16:10:49,707 DEBUG engine.airsync.AirsyncServer : HTTP Request: "OPTIONS /Microsoft-Server-ActiveSync?User=DEFAUL&DeviceId=D1C978843E562C712DDA6BFEA717EB01&DeviceType=PocketPC HTTP/1.1" 200 -
2010-02-23 16:10:49,707 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Finished emitting response 200 code to client
2010-02-23 16:10:50,316 INFO engine.airsync.AirsyncServer : do_POST: received GetItemEstimate command
2010-02-23 16:10:50,316 DEBUG engine.airsync.AirsyncServer : _ReadXMLRequest: converting request from wbxml
2010-02-23 16:10:50,318 DEBUG engine.airsync.AirsyncServer : _ProcessGetItemEstimate: request document is 
<?xml version="1.0" encoding="utf-8"?>
<GetItemEstimate xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>
  <Collections xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>
    <Collection xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>
      <Class xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>Contacts</Class>
      <CollectionId xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>{01508F9F-6A26-1E5B-7B8E-CF5B8A3A75E4}</CollectionId>
      <FilterType xmlns="http://synce.org/formats/airsync_wm5/airsync";>0</FilterType>
      <SyncKey xmlns="http://synce.org/formats/airsync_wm5/airsync";>{01508F9F-6A26-1E5B-7B8E-CF5B8A3A75E4}12</SyncKey>
    </Collection>
    <Collection xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>
      <Class xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>Calendar</Class>
      <CollectionId xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>{AD0D7151-8224-B7AB-8DB3-3E99FB3A3534}</CollectionId>
      <FilterType xmlns="http://synce.org/formats/airsync_wm5/airsync";>4</FilterType>
      <SyncKey xmlns="http://synce.org/formats/airsync_wm5/airsync";>{AD0D7151-8224-B7AB-8DB3-3E99FB3A3534}13</SyncKey>
    </Collection>
  </Collections>
</GetItemEstimate>

2010-02-23 16:10:50,319 DEBUG engine.airsync.AirsyncServer : _ProcessGetItemEstimate: response document is 
<?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" "http://www.microsoft.com/";>
<GetItemEstimate xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>
  <Response>
    <Status>1</Status>
    <Collection>
      <Class>Contacts</Class>
      <CollectionId>{01508F9F-6A26-1E5B-7B8E-CF5B8A3A75E4}</CollectionId>
      <Estimate>0</Estimate>
    </Collection>
  </Response>
  <Response>
    <Status>1</Status>
    <Collection>
      <Class>Calendar</Class>
      <CollectionId>{AD0D7151-8224-B7AB-8DB3-3E99FB3A3534}</CollectionId>
      <Estimate>0</Estimate>
    </Collection>
  </Response>
</GetItemEstimate>

2010-02-23 16:10:50,319 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: Emitting response 200 code to client
2010-02-23 16:10:50,319 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync?User=DEFAUL&DeviceId=D1C978843E562C712DDA6BFEA717EB01&DeviceType=PocketPC&Cmd=GetItemEstimate HTTP/1.1" 200 -
2010-02-23 16:10:50,319 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: Finished emitting response 200 code to client
2010-02-23 16:10:50,319 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: starting document conversion
2010-02-23 16:10:50,320 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: Emitting wbxml (length = 144)
2010-02-23 16:10:50,321 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: Finished emitting wbxml
2010-02-23 16:10:50,366 INFO engine.airsync.AirsyncServer : do_POST: received Status command
2010-02-23 16:10:50,366 DEBUG engine.airsync.AirsyncServer : _ProcessStatus: request document is 
<?xml version="1.0" encoding="utf-8"?>
<SyncStatus>
  <SyncBegin Partner="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}" Datatype="{4A5D9FE0-F139-4A63-A5A4-4F31CEEA02AD}"/>
</SyncStatus>

2010-02-23 16:10:50,366 INFO engine.syncengine.kernel : Status: Emitting StatusSyncStartDatatype signal
2010-02-23 16:10:50,367 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Emitting response 200 code to client
2010-02-23 16:10:50,367 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2010-02-23 16:10:50,367 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Finished emitting response 200 code to client
2010-02-23 16:10:50,533 INFO engine.airsync.AirsyncServer : do_POST: received Status command
2010-02-23 16:10:50,534 DEBUG engine.airsync.AirsyncServer : _ProcessStatus: request document is 
<?xml version="1.0" encoding="utf-8"?>
<SyncStatus>
  <Status Partner="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}">
    <StatusString type="Status" value="0/2"/>
  </Status>
</SyncStatus>

2010-02-23 16:10:50,534 INFO engine.syncengine.kernel : Status: Emitting StatusSetStatusString signal
2010-02-23 16:10:50,534 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Emitting response 200 code to client
2010-02-23 16:10:50,534 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2010-02-23 16:10:50,534 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Finished emitting response 200 code to client
2010-02-23 16:10:51,045 INFO engine.airsync.AirsyncServer : do_POST: received Sync command
2010-02-23 16:10:51,075 DEBUG engine.airsync.AirsyncServer : _ReadXMLRequest: converting request from wbxml
2010-02-23 16:10:51,081 DEBUG engine.airsync.AirsyncServer : _ProcessSync: request document is 
<?xml version="1.0" encoding="utf-8"?>
<Sync xmlns="http://synce.org/formats/airsync_wm5/airsync";>
  <Collections xmlns="http://synce.org/formats/airsync_wm5/airsync";>
    <Collection xmlns="http://synce.org/formats/airsync_wm5/airsync";>
      <Class xmlns="http://synce.org/formats/airsync_wm5/airsync";>Calendar</Class>
      <SyncKey xmlns="http://synce.org/formats/airsync_wm5/airsync";>{AD0D7151-8224-B7AB-8DB3-3E99FB3A3534}13</SyncKey>
      <CollectionId xmlns="http://synce.org/formats/airsync_wm5/airsync";>{AD0D7151-8224-B7AB-8DB3-3E99FB3A3534}</CollectionId>
      <DeletesAsMoves xmlns="http://synce.org/formats/airsync_wm5/airsync"/>
      <GetChanges xmlns="http://synce.org/formats/airsync_wm5/airsync"/>
      <WindowSize xmlns="http://synce.org/formats/airsync_wm5/airsync";>100</WindowSize>
      <Options xmlns="http://synce.org/formats/airsync_wm5/airsync";>
        <FilterType xmlns="http://synce.org/formats/airsync_wm5/airsync";>4</FilterType>
        <Truncation xmlns="http://synce.org/formats/airsync_wm5/airsync";>4</Truncation>
        <RtfTruncation xmlns="http://synce.org/formats/airsync_wm5/airsync";>4</RtfTruncation>
        <Conflict xmlns="http://synce.org/formats/airsync_wm5/airsync";>1</Conflict>
      </Options>
      <Commands xmlns="http://synce.org/formats/airsync_wm5/airsync";>
        <Add xmlns="http://synce.org/formats/airsync_wm5/airsync";>
          <ClientId xmlns="http://synce.org/formats/airsync_wm5/airsync";>1073741915</ClientId>
          <ApplicationData xmlns="http://synce.org/formats/airsync_wm5/airsync";>
            <Timezone xmlns="http://synce.org/formats/airsync_wm5/calendar";>xv3//wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA==</Timezone>
            <AllDayEvent xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</AllDayEvent>
            <BusyStatus xmlns="http://synce.org/formats/airsync_wm5/calendar";>2</BusyStatus>
            <DtStamp xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100223T064049Z</DtStamp>
            <EndTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100226T103000Z</EndTime>
            <Location xmlns="http://synce.org/formats/airsync_wm5/calendar";>Beach</Location>
            <MeetingStatus xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</MeetingStatus>
            <Reminder xmlns="http://synce.org/formats/airsync_wm5/calendar";>15</Reminder>
            <Sensitivity xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</Sensitivity>
            <Subject xmlns="http://synce.org/formats/airsync_wm5/calendar";>Dinner Isaac &amp; Vanessa </Subject>
            <StartTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100226T083000Z</StartTime>
            <UID xmlns="http://synce.org/formats/airsync_wm5/calendar";>040000008200E00074C5B7101A82E0080000000055BC58923D11DDA0EA9DB9AC1E54FD01100000003B63CC0DC1BFC9FEEE2C236228FA8279</UID>
          </ApplicationData>
        </Add>
        <Add xmlns="http://synce.org/formats/airsync_wm5/airsync";>
          <ClientId xmlns="http://synce.org/formats/airsync_wm5/airsync";>1073741916</ClientId>
          <ApplicationData xmlns="http://synce.org/formats/airsync_wm5/airsync";>
            <Timezone xmlns="http://synce.org/formats/airsync_wm5/calendar";>xv3//wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA==</Timezone>
            <AllDayEvent xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</AllDayEvent>
            <BusyStatus xmlns="http://synce.org/formats/airsync_wm5/calendar";>2</BusyStatus>
            <DtStamp xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100223T064049Z</DtStamp>
            <EndTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100306T023000Z</EndTime>
            <MeetingStatus xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</MeetingStatus>
            <Reminder xmlns="http://synce.org/formats/airsync_wm5/calendar";>15</Reminder>
            <Sensitivity xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</Sensitivity>
            <Subject xmlns="http://synce.org/formats/airsync_wm5/calendar";>Alicia's swimming lesson</Subject>
            <StartTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100306T020000Z</StartTime>
            <UID xmlns="http://synce.org/formats/airsync_wm5/calendar";>040000008200E00074C5B7101A82E0080000000055BC58923D11DDA0EA9DB9AC1E54FD01100000007932567B353CCEFF198448957E8A24E1</UID>
          </ApplicationData>
        </Add>
      </Commands>
    </Collection>
  </Collections>
</Sync>

2010-02-23 16:10:51,081 DEBUG engine.airsync.AirsyncServer : _ProcessSync: converting item from airsync, source is 
<ApplicationData xmlns="http://synce.org/formats/airsync_wm5/airsync";>
  <Timezone xmlns="http://synce.org/formats/airsync_wm5/calendar";>xv3//wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA==</Timezone>
  <AllDayEvent xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</AllDayEvent>
  <BusyStatus xmlns="http://synce.org/formats/airsync_wm5/calendar";>2</BusyStatus>
  <DtStamp xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100223T064049Z</DtStamp>
  <EndTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100226T103000Z</EndTime>
  <Location xmlns="http://synce.org/formats/airsync_wm5/calendar";>Beach</Location>
  <MeetingStatus xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</MeetingStatus>
  <Reminder xmlns="http://synce.org/formats/airsync_wm5/calendar";>15</Reminder>
  <Sensitivity xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</Sensitivity>
  <Subject xmlns="http://synce.org/formats/airsync_wm5/calendar";>Dinner Isaac &amp; Vanessa </Subject>
  <StartTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100226T083000Z</StartTime>
  <UID xmlns="http://synce.org/formats/airsync_wm5/calendar";>040000008200E00074C5B7101A82E0080000000055BC58923D11DDA0EA9DB9AC1E54FD01100000003B63CC0DC1BFC9FEEE2C236228FA8279</UID>
</ApplicationData>
2010-02-23 16:10:51,082 DEBUG engine.airsync.AirsyncServer : _ProcessSync: converting item from airsync, result is 
<?xml version="1.0" encoding="utf-8"?>
<vcal>
  <Event>
    <Alarm>
      <AlarmTrigger>
        <Content>-PT15M</Content>
        <Value>DURATION</Value>
        <Related>START</Related>
      </AlarmTrigger>
      <AlarmAction>DISPLAY</AlarmAction>
      <AlarmDescription/>
    </Alarm>
    <Transparency>
      <Content>OPAQUE</Content>
    </Transparency>
    <LastModified>
      <Content>20100223T064049Z</Content>
    </LastModified>
    <DateStarted>
      <Content>20100226T083000Z</Content>
    </DateStarted>
    <DateEnd>
      <Content>20100226T103000Z</Content>
    </DateEnd>
    <Location>
      <Content>Beach</Content>
    </Location>
    <Summary>
      <Content>Dinner Isaac &amp; Vanessa </Content>
    </Summary>
    <Class>
      <Content>PUBLIC</Content>
    </Class>
    <Categories/>
  </Event>
</vcal>

2010-02-23 16:10:51,083 DEBUG engine.airsync.AirsyncServer : _ProcessSync: converting item from airsync, source is 
<ApplicationData xmlns="http://synce.org/formats/airsync_wm5/airsync";>
  <Timezone xmlns="http://synce.org/formats/airsync_wm5/calendar";>xv3//wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA==</Timezone>
  <AllDayEvent xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</AllDayEvent>
  <BusyStatus xmlns="http://synce.org/formats/airsync_wm5/calendar";>2</BusyStatus>
  <DtStamp xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100223T064049Z</DtStamp>
  <EndTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100306T023000Z</EndTime>
  <MeetingStatus xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</MeetingStatus>
  <Reminder xmlns="http://synce.org/formats/airsync_wm5/calendar";>15</Reminder>
  <Sensitivity xmlns="http://synce.org/formats/airsync_wm5/calendar";>0</Sensitivity>
  <Subject xmlns="http://synce.org/formats/airsync_wm5/calendar";>Alicia's swimming lesson</Subject>
  <StartTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>20100306T020000Z</StartTime>
  <UID xmlns="http://synce.org/formats/airsync_wm5/calendar";>040000008200E00074C5B7101A82E0080000000055BC58923D11DDA0EA9DB9AC1E54FD01100000007932567B353CCEFF198448957E8A24E1</UID>
</ApplicationData>
2010-02-23 16:10:51,083 DEBUG engine.airsync.AirsyncServer : _ProcessSync: converting item from airsync, result is 
<?xml version="1.0" encoding="utf-8"?>
<vcal>
  <Event>
    <Alarm>
      <AlarmTrigger>
        <Content>-PT15M</Content>
        <Value>DURATION</Value>
        <Related>START</Related>
      </AlarmTrigger>
      <AlarmAction>DISPLAY</AlarmAction>
      <AlarmDescription/>
    </Alarm>
    <Transparency>
      <Content>OPAQUE</Content>
    </Transparency>
    <LastModified>
      <Content>20100223T064049Z</Content>
    </LastModified>
    <DateStarted>
      <Content>20100306T020000Z</Content>
    </DateStarted>
    <DateEnd>
      <Content>20100306T023000Z</Content>
    </DateEnd>
    <Location>
      <Content/>
    </Location>
    <Summary>
      <Content>Alicia's swimming lesson</Content>
    </Summary>
    <Class>
      <Content>PUBLIC</Content>
    </Class>
    <Categories/>
  </Event>
</vcal>

2010-02-23 16:10:51,083 DEBUG engine.airsync.AirsyncServer : _ProcessSync: response document is 
<?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" "http://www.microsoft.com/";>
<Sync xmlns="http://synce.org/formats/airsync_wm5/airsync";>
  <Collections>
    <Collection>
      <Class>Calendar</Class>
      <SyncKey>{AD0D7151-8224-B7AB-8DB3-3E99FB3A3534}14</SyncKey>
      <CollectionId>{AD0D7151-8224-B7AB-8DB3-3E99FB3A3534}</CollectionId>
      <Status>1</Status>
      <Responses>
        <Add>
          <ClientId>1073741915</ClientId>
          <ServerId>{1101491C-F4B0-AB2B-B585-5D4FC56ECA70}</ServerId>
          <Status>1</Status>
        </Add>
        <Add>
          <ClientId>1073741916</ClientId>
          <ServerId>{06F6C1C8-FBF1-BAD8-899F-7886F33A8337}</ServerId>
          <Status>1</Status>
        </Add>
      </Responses>
    </Collection>
  </Collections>
  <Responses>
    <Add>
      <ClientId>1073741915</ClientId>
      <ServerId>{1101491C-F4B0-AB2B-B585-5D4FC56ECA70}</ServerId>
      <Status>1</Status>
    </Add>
    <Add>
      <ClientId>1073741916</ClientId>
      <ServerId>{06F6C1C8-FBF1-BAD8-899F-7886F33A8337}</ServerId>
      <Status>1</Status>
    </Add>
  </Responses>
</Sync>

2010-02-23 16:10:51,084 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: Emitting response 200 code to client
2010-02-23 16:10:51,084 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync?User=DEFAUL&DeviceId=D1C978843E562C712DDA6BFEA717EB01&DeviceType=PocketPC&Cmd=Sync HTTP/1.1" 200 -
2010-02-23 16:10:51,084 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: Finished emitting response 200 code to client
2010-02-23 16:10:51,084 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: starting document conversion
SynCE sync-engine starting up
get encoder
write header
enter processNode
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'GetItemEstimate')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Response')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Status')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Collection')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Class')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'CollectionId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Estimate')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Response')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Status')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Collection')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Class')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'CollectionId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/getitemestimate', 'Estimate')
processNode
text node
get encoder
write header
enter processNode
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Sync')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Collections')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Collection')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Class')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'SyncKey')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'CollectionId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Status')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Responses')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Add')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'ClientId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'ServerId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Status')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: go2010-02-23 16:10:51,086 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: Emitting wbxml (length = 369)
2010-02-23 16:10:51,087 DEBUG engine.airsync.AirsyncServer : _SendWBXMLResponse: Finished emitting wbxml
2010-02-23 16:10:51,240 INFO engine.airsync.AirsyncServer : do_POST: received Status command
2010-02-23 16:10:51,241 DEBUG engine.airsync.AirsyncServer : _ProcessStatus: request document is 
<?xml version="1.0" encoding="utf-8"?>
<SyncStatus>
  <SyncEnd Partner="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}" Datatype="{4A5D9FE0-F139-4A63-A5A4-4F31CEEA02AD}"/>
</SyncStatus>

2010-02-23 16:10:51,241 INFO engine.syncengine.kernel : Status: Emitting StatusSyncEndDatatype signal
2010-02-23 16:10:51,241 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Emitting response 200 code to client
2010-02-23 16:10:51,241 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2010-02-23 16:10:51,241 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Finished emitting response 200 code to client
2010-02-23 16:10:52,174 INFO engine.airsync.AirsyncServer : do_POST: received Status command
2010-02-23 16:10:52,174 DEBUG engine.airsync.AirsyncServer : _ProcessStatus: request document is 
<?xml version="1.0" encoding="utf-8"?>
<SyncStatus>
  <SyncEnd Partner="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}" Datatype=""/>
</SyncStatus>

2010-02-23 16:10:52,174 INFO engine.syncengine.kernel : Status: Emitting StatusSyncEndPartner signal
2010-02-23 16:10:52,175 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Emitting response 200 code to client
2010-02-23 16:10:52,175 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2010-02-23 16:10:52,175 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Finished emitting response 200 code to client
2010-02-23 16:10:52,433 INFO engine.airsync.AirsyncServer : do_POST: received Status command
2010-02-23 16:10:52,433 DEBUG engine.airsync.AirsyncServer : _ProcessStatus: request document is 
<?xml version="1.0" encoding="utf-8"?>
<SyncStatus>
  <SyncEnd Partner="" Datatype=""/>
</SyncStatus>

2010-02-23 16:10:52,434 INFO engine.synchandler.SyncHandler : _sync_end_cb: Called
2010-02-23 16:10:52,434 INFO engine.syncengine.kernel : Status: Emitting StatusSyncEnd signal
2010-02-23 16:10:52,434 DEBUG engine.synchandler.SyncHandler : run: calling RAPI sync_pause and sync_resume
2010-02-23 16:10:52,516 DEBUG engine.synchandler.SyncHandler : run: saving itemDB
2010-02-23 16:10:52,516 INFO ItemDB : itemDB(0) is dirty, saving to file
2010-02-23 16:10:52,516 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Emitting response 200 code to client
2010-02-23 16:10:52,518 INFO ItemDB : itemDB(1) is clean, no save required
2010-02-23 16:10:52,518 DEBUG engine.airsync.AirsyncServer : HTTP Request: "POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2010-02-23 16:10:52,518 INFO engine.synchandler.SyncHandler : run: finished synchronization
2010-02-23 16:10:52,518 INFO engine.syncengine.kernel : Synchronized: Emitting Synchronized signal
2010-02-23 16:10:52,518 DEBUG engine.airsync.AirsyncServer : _SendEmptyResponse: Finished emitting response 200 code to client
2010-02-23 16:10:52,520 DEBUG engine.syncengine.kernel : GetRemoteChanges: pship P1: id=0xbc41794, guid="{FE585A55-CE5A-7163-4F4A-34E7810E5F69}", hostname="orpheus", name="TreoPro", sync_items=[ Calendar, Contacts ]
2010-02-23 16:10:52,520 DEBUG engine.syncengine.kernel : GetRemoteChanges: getting changes for items of type 0
2010-02-23 16:10:52,520 DEBUG engine.syncengine.kernel : GetRemoteChanges: got change GUID = pas-id-3E51D457B071A54C, ChangeType = 1, Data = <?xml version="1.0" encoding="utf-8"?>
<vcal><Event><Alarm><AlarmTrigger><Content>-PT15M</Content><Value>DURATION</Value><Related>START</Related></AlarmTrigger><AlarmAction>DISPLAY</AlarmAction><AlarmDescription/></Alarm><Transparency><Content>OPAQUE</Content></Transparency><LastModified><Content>20100223T064049Z</Content></LastModified><DateStarted><Content>20100226T083000Z</Content></DateStarted><DateEnd><Content>20100226T103000Z</Content></DateEnd><Location><Content>Beach</Content></Location><Summary><Content>Dinner Isaac &amp; Vanessa </Content></Summary><Class><Content>PUBLIC</Content></Class><Categories/></Event></vcal>

2010-02-23 16:10:52,520 DEBUG engine.syncengine.kernel : GetRemoteChanges: got change GUID = pas-id-952C5350302AA0C9, ChangeType = 1, Data = <?xml version="1.0" encoding="utf-8"?>
<vcal><Event><Alarm><AlarmTrigger><Content>-PT15M</Content><Value>DURATION</Value><Related>START</Related></AlarmTrigger><AlarmAction>DISPLAY</AlarmAction><AlarmDescription/></Alarm><Transparency><Content>OPAQUE</Content></Transparency><LastModified><Content>20100223T064049Z</Content></LastModified><DateStarted><Content>20100306T020000Z</Content></DateStarted><DateEnd><Content>20100306T023000Z</Content></DateEnd><Location><Content/></Location><Summary><Content>Alicia's swimming lesson</Content></Summary><Class><Content>PUBLIC</Content></Class><Categories/></Event></vcal>

2010-02-23 16:10:52,520 DEBUG engine.syncengine.kernel : GetRemoteChanges: getting changes for items of type 1
2010-02-23 16:10:52,520 DEBUG engine.syncengine.kernel : return
2010-02-23 16:11:28,306 INFO syncengine : Received termination signal. Exiting
2010-02-23 16:11:28,309 DEBUG engine.syncengine.kernel : StopSessions: stopping RRA server
2010-02-23 16:11:28,309 DEBUG RRAThread : stop: stopping RRA server
2010-02-23 16:11:28,771 DEBUG engine.syncengine.kernel : StopSessions: stopping DTPT server
2010-02-23 16:11:28,771 INFO engine.syncengine.dtptserver : DTPT server shutdown request posted
2010-02-23 16:11:28,771 DEBUG engine.syncengine.kernel : StopSessions: stopping sync handler thread
2010-02-23 16:11:28,772 DEBUG engine.syncengine.kernel : StopSessions: stopping Airsync server
2010-02-23 16:11:28,772 DEBUG engine.airsync.AirsyncThread : stop: stopping Airsync server
2010-02-23 16:11:28,772 DEBUG engine.airsync.AirsyncServer : StopServer: stopping Airsync server
2010-02-23 16:11:28,772 INFO engine.syncengine.dtptserver : DTPT server shutdown request actioned
2010-02-23 16:11:28,772 INFO engine.syncengine.dtptserver : shutting down DTPT threads
2010-02-23 16:11:28,772 INFO engine.syncengine.dtptserver : waiting for final shutdown
2010-02-23 16:11:28,773 DEBUG engine.airsync.AirsyncServer : do_QUIT: setting server 'stopped' flag
2010-02-23 16:11:28,773 DEBUG engine.airsync.AirsyncServer : HTTP Request: "QUIT / HTTP/1.1" 200 -
2010-02-23 16:11:28,774 DEBUG syncengine : waiting for engine to clean up
2010-02-23 16:11:28,774 DEBUG engine.syncengine.kernel : WaitForStoppingSessions: waiting for DTPT server thread
2010-02-23 16:11:28,774 DEBUG engine.syncengine.kernel : WaitForStoppingSessions: waiting for sync handler thread
2010-02-23 16:11:28,774 DEBUG engine.syncengine.kernel : WaitForStoppingSessions: waiting for Airsync server thread
2010-02-23 16:11:28,774 DEBUG engine.syncengine.kernel : sessions_wait_for_stop: shutting down RRA server
t namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Add')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'ClientId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'ServerId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Status')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Responses')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Add')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'ClientId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'ServerId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Status')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Add')
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'ClientId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'ServerId')
processNode
text node
next node -  element
processNode
content flag:
pn: get namespace
pn: got namespace
TAG  ('http://synce.org/formats/airsync_wm5/airsync', 'Status')
processNode
text node
------------------------------------------------------------------------------
Download Intel&#174; Parallel Studio Eval
Try the new software tools for yourself. Speed compiling, find bugs
proactively, and fine-tune applications for parallel performance.
See why Intel Parallel Studio got high marks during beta.
http://p.sf.net/sfu/intel-sw-dev
_______________________________________________
SynCE-Devel mailing list
SynCE-Devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/synce-devel

Reply via email to