Hi John,
> I couldn't find a dump of your _sync-engine_ console output (not the
> msynctool output) in the attachments. Could you send me a copy of the
> messages emitted by sync-engine during the sync run? I may be able to tell
> more from this than from the msynctool output alone.
Sure, find the output attached as txt-file. Please note that I had to re-run
the sync twice, because at first time, there was some notification from
korganizer still running.
Regards,
Dennis
--
Der GMX SmartSurfer hilft bis zu 70% Ihrer Onlinekosten zu sparen!
Ideal für Modem und ISDN: http://www.gmx.net/de/go/smartsurfer
2007-09-25 08:34:44,426 DEBUG syncengine : creating SyncEngine object
2007-09-25 08:34:44,437 INFO engine.syncengine.SyncEngine : __init__: connected
device found
2007-09-25 08:34:44,457 INFO engine.config.Config : UpdateConfig - unable to
open config file - using defaults
2007-09-25 08:34:44,458 DEBUG engine.syncengine.SyncEngine : OnConnect: setting
up RAPI session
2007-09-25 08:34:44,512 DEBUG engine.syncengine.SyncEngine : OnConnect:
initializing partnerships
2007-09-25 08:34:44,513 DEBUG engine.partnerships.Partnerships : _read_device:
reading partnerships from device registry
2007-09-25 08:34:44,541 DEBUG engine.partnerships.Partnerships : _read_device:
read partnership ID = 219416416, Hostname = ward
2007-09-25 08:34:44,542 DEBUG engine.partnerships.Partnerships : _read_device:
Adding entry
2007-09-25 08:34:44,723 WARNING engine.partnerships.Partnerships :
_read_device: Error getting partnership key 2 from device registry: 2
2007-09-25 08:34:44,735 DEBUG engine.partnerships.Partnerships : _read_device:
querying synchronization source information from device
2007-09-25 08:34:44,737 DEBUG engine.xmlutil : _config_query: CeProcessConfig
request is
<wap-provisioningdoc>
<characteristic type="Sync">
<characteristic-query recursive="false" type="Sources"/>
</characteristic>
</wap-provisioningdoc>
2007-09-25 08:34:45,747 DEBUG engine.xmlutil : _config_query: CeProcessConfig
response is
<wap-provisioningdoc>
<characteristic type="Sync">
<characteristic recursive="false" type="Sources">
<characteristic
type="{C088E3C2-20D8-712B-A096-7989F26DFF76}"/>
</characteristic>
</characteristic>
</wap-provisioningdoc>
2007-09-25 08:34:45,748 DEBUG engine.xmlutil : _config_query: CeProcessConfig
request is
<wap-provisioningdoc>
<characteristic type="Sync">
<characteristic type="Sources">
<characteristic-query
type="{C088E3C2-20D8-712B-A096-7989F26DFF76}"/>
</characteristic>
</characteristic>
</wap-provisioningdoc>
2007-09-25 08:34:46,905 DEBUG engine.xmlutil : _config_query: CeProcessConfig
response is
<wap-provisioningdoc>
<characteristic type="Sync">
<characteristic type="Sources">
<characteristic
type="{C088E3C2-20D8-712B-A096-7989F26DFF76}">
<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="{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="{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="Linux Desktop"/>
<parm name="Server" value="ward"/>
<parm name="StoreType" value="2"/>
</characteristic>
</characteristic>
</characteristic>
</wap-provisioningdoc>
2007-09-25 08:34:46,907 DEBUG engine.partnerships.Partnerships : _read_device:
read source GUID = {C088E3C2-20D8-712B-A096-7989F26DFF76}, Hostname = ward,
Description = Linux Desktop
2007-09-25 08:34:46,908 DEBUG engine.partnerships.Partnerships : _read_device:
source matches partnerhip from registry. Initializing partnership
2007-09-25 08:34:46,968 INFO engine.partnerships.Partnership : load_state:
loaded state with 2 items
2007-09-25 08:34:46,968 DEBUG engine.partnerships.Partnerships : _read_device:
querying partnerhip synchronization items (providers)
2007-09-25 08:34:46,968 DEBUG engine.partnerships.Partnerships : _read_device:
found provider Files
2007-09-25 08:34:46,969 DEBUG engine.partnerships.Partnerships : _read_device:
found provider Calendar
2007-09-25 08:34:46,969 DEBUG engine.partnerships.Partnerships : _read_device:
provider is enabled
2007-09-25 08:34:46,969 DEBUG engine.partnerships.Partnerships : _read_device:
provider ID is 0
2007-09-25 08:34:46,970 DEBUG engine.partnerships.Partnerships : _read_device:
found provider Media
2007-09-25 08:34:46,970 DEBUG engine.partnerships.Partnerships : _read_device:
found provider Tasks
2007-09-25 08:34:46,970 DEBUG engine.partnerships.Partnerships : _read_device:
found provider Notes
2007-09-25 08:34:46,971 DEBUG engine.partnerships.Partnerships : _read_device:
found provider E-mail
2007-09-25 08:34:46,971 DEBUG engine.partnerships.Partnerships : _read_device:
found provider Contacts
2007-09-25 08:34:46,971 DEBUG engine.partnerships.Partnerships : _read_device:
provider is enabled
2007-09-25 08:34:46,972 DEBUG engine.partnerships.Partnerships : _read_device:
provider ID is 1
2007-09-25 08:34:46,972 DEBUG engine.partnerships.Partnerships : _read_device:
found provider Favorites
2007-09-25 08:34:46,972 INFO engine.partnerships.Partnerships : Attempting to
load last used partnership
2007-09-25 08:34:46,987 INFO engine.config.Config : Loading current partnership
2007-09-25 08:34:46,997 INFO engine.partnerships.Partnerships : Last
partnership: id=0xd140760, guid="{C088E3C2-20D8-712B-A096-7989F26DFF76}",
hostname="ward", name="Linux Desktop"
2007-09-25 08:34:46,998 DEBUG engine.partnerships.Partnerships : Checking
against: id=0xd140760, guid="{C088E3C2-20D8-712B-A096-7989F26DFF76}",
hostname="ward", name="Linux Desktop"
2007-09-25 08:34:46,998 INFO engine.partnerships.Partnerships : Match with last
used partnership found - slot
2007-09-25 08:34:47,005 DEBUG engine.partnerships.Partnerships : set_current:
partnership found in slot 1
2007-09-25 08:34:47,041 INFO engine.partnerships.Partnerships : Saving current
partnership info
2007-09-25 08:34:47,042 INFO engine.config.Config : saving partnership file
2007-09-25 08:34:47,043 DEBUG engine.syncengine.SyncEngine : sessions_start:
starting AirSync handler
2007-09-25 08:34:47,045 DEBUG engine.syncengine.SyncEngine : sessions_start:
calling RAPI start_replication
2007-09-25 08:34:47,053 DEBUG engine.syncengine.SyncEngine : sessions_start:
calling RAPI sync_resume
2007-09-25 08:34:47,053 DEBUG engine.airsync.AirsyncThread : run: listening for
Airsync requests
2007-09-25 08:34:47,246 DEBUG engine.syncengine.SyncEngine : sessions_start:
starting RRA session
2007-09-25 08:34:47,246 INFO RRAThread : new RRA handler thread created
2007-09-25 08:34:47,247 INFO RRASyncManager : connecting to RRA
2007-09-25 08:34:48,135 INFO RRASyncManager : connected
2007-09-25 08:34:48,136 DEBUG RRAThread : have 4 object types
object id 10000 type Ink
object id 10001 type Favorite
object id 10002 type Media
object id 10003 type File
File-sync config:
local path
disable? 1
LocalUpdateFreq 10
ExtraDeleteDelay 0
2007-09-25 08:34:48,136 DEBUG RRASyncManager : No RRA type subscriptions: not
starting RRA thread
2007-09-25 08:34:48,137 DEBUG syncengine : installing signal handlers
2007-09-25 08:34:48,137 DEBUG syncengine : running main loop
2007-09-25 08:35:19,188 INFO engine.syncengine.SyncEngine : found selected
partnership
2007-09-25 08:35:52,413 INFO engine.syncengine.SyncEngine : Synchronize: manual
sync triggered
2007-09-25 08:35:52,414 INFO engine.syncengine.SyncEngine : Synchronize:
starting manual sync with partnership P1: id=0xd140760,
guid="{C088E3C2-20D8-712B-A096-7989F26DFF76}", hostname="ward", name="Linux
Desktop", sync_items=[ Calendar, Contacts ]
2007-09-25 08:35:52,414 INFO engine.partnerships.Partnership : loading itemDB
for item 0
load_state: loaded state with %d items2007-09-25 08:35:52,438 INFO
engine.partnerships.Partnership : loading itemDB for item 1
load_state: loaded state with %d items2007-09-25 08:35:52,447 INFO
engine.syncengine.SyncEngine : Synchronize: itemDB loaded
2007-09-25 08:35:52,455 DEBUG engine.synchandler.SyncHandler : run: sending
request to device
<sync type="Interactive" xmlns="http://schemas.microsoft.com/as/2004/core";>
<partner id="{C088E3C2-20D8-712B-A096-7989F26DFF76}"/>
</sync>
2007-09-25 08:35:52,668 DEBUG engine.synchandler.SyncHandler : run: performing
synchronization
2007-09-25 08:35:52,775 INFO engine.airsync.AirsyncServer : do_POST: received
Status command
2007-09-25 08:35:52,776 DEBUG engine.airsync.AirsyncServer : _handle_status:
request document is
<?xml version="1.0" ?>
<SyncStatus>
<SyncBegin Datatype="" Partner=""/>
</SyncStatus>
2007-09-25 08:35:52,777 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Emitting response 200 code to client
2007-09-25 08:35:52,777 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2007-09-25 08:35:52,778 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Finished emitting response 200 code to client
2007-09-25 08:35:53,033 INFO engine.airsync.AirsyncServer : do_POST: received
Status command
2007-09-25 08:35:53,036 DEBUG engine.airsync.AirsyncServer : _handle_status:
request document is
<?xml version="1.0" ?>
<SyncStatus>
<SyncBegin Datatype=""
Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}"/>
</SyncStatus>
2007-09-25 08:35:53,037 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Emitting response 200 code to client
2007-09-25 08:35:53,037 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2007-09-25 08:35:53,037 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Finished emitting response 200 code to client
2007-09-25 08:35:53,307 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Emitting response 200 code to client
2007-09-25 08:35:53,308 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"OPTIONS
/Microsoft-Server-ActiveSync?User=DEFAULT&DeviceId=42DBE8CCB26C0BE6910A9CB83CA8EDB1&DeviceType=PocketPC
HTTP/1.1" 200 -
2007-09-25 08:35:53,308 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Finished emitting response 200 code to client
2007-09-25 08:35:53,998 INFO engine.airsync.AirsyncServer : do_POST: received
Status command
2007-09-25 08:35:54,003 DEBUG engine.airsync.AirsyncServer : _handle_status:
request document is
<?xml version="1.0" ?>
<SyncStatus>
<Status Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}">
<Progress value="0"/>
</Status>
<Status Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}">
<Total value="100"/>
</Status>
<Status Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}">
<StatusString type="Status" value="Nach Ãnderungen suchen"/>
</Status>
</SyncStatus>
2007-09-25 08:35:54,004 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Emitting response 200 code to client
2007-09-25 08:35:54,004 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2007-09-25 08:35:54,005 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Finished emitting response 200 code to client
2007-09-25 08:35:54,457 INFO engine.airsync.AirsyncServer : do_POST: received
GetItemEstimate command
2007-09-25 08:35:54,458 DEBUG engine.airsync.AirsyncServer : _read_xml_request:
converting request from wbxml
2007-09-25 08:35:54,461 DEBUG engine.airsync.AirsyncServer :
_handle_get_item_estimate: request document is
<?xml version="1.0" ?>
<!DOCTYPE AirSync
PUBLIC '-//AIRSYNC//DTD AirSync//EN'
'http://www.microsoft.com/'>
<GetItemEstimate xmlns="http://synce.org/formats/airsync_wm5/getitemestimate";>
<Collections>
<Collection>
<Class>
Contacts
</Class>
<CollectionId>
{35EB5AEC-97C1-654C-D429-7BF82EDBEA3E}
</CollectionId>
<FilterType
xmlns="http://synce.org/formats/airsync_wm5/airsync";>
0
</FilterType>
<SyncKey
xmlns="http://synce.org/formats/airsync_wm5/airsync";>
{35EB5AEC-97C1-654C-D429-7BF82EDBEA3E}3
</SyncKey>
</Collection>
<Collection>
<Class>
Calendar
</Class>
<CollectionId>
{4785A962-C849-E6A7-0426-91EC6353812A}
</CollectionId>
<FilterType
xmlns="http://synce.org/formats/airsync_wm5/airsync";>
4
</FilterType>
<SyncKey
xmlns="http://synce.org/formats/airsync_wm5/airsync";>
{4785A962-C849-E6A7-0426-91EC6353812A}3
</SyncKey>
</Collection>
</Collections>
</GetItemEstimate>
2007-09-25 08:35:54,565 DEBUG engine.airsync.AirsyncServer :
_handle_get_item_estimate: response document is
<?xml version="1.0" ?>
<!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>
{35EB5AEC-97C1-654C-D429-7BF82EDBEA3E}
</CollectionId>
<Estimate>
0
</Estimate>
</Collection>
</Response>
<Response>
<Status>
1
</Status>
<Collection>
<Class>
Calendar
</Class>
<CollectionId>
{4785A962-C849-E6A7-0426-91EC6353812A}
</CollectionId>
<Estimate>
0
</Estimate>
</Collection>
</Response>
</GetItemEstimate>
2007-09-25 08:35:54,567 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Emitting response 200 code to client
2007-09-25 08:35:54,568 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST
/Microsoft-Server-ActiveSync?User=DEFAULT&DeviceId=42DBE8CCB26C0BE6910A9CB83CA8EDB1&DeviceType=PocketPC&Cmd=GetItemEstimate
HTTP/1.1" 200 -
2007-09-25 08:35:54,568 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Finished emitting response 200 code to client
2007-09-25 08:35:54,569 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Emitting wbxml (length = 144)
2007-09-25 08:35:54,570 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Finished emitting wbxml
2007-09-25 08:35:54,631 INFO engine.airsync.AirsyncServer : do_POST: received
Status command
2007-09-25 08:35:54,632 DEBUG engine.airsync.AirsyncServer : _handle_status:
request document is
<?xml version="1.0" ?>
<SyncStatus>
<SyncBegin Datatype="{4A5D9FE0-F139-4A63-A5A4-4F31CEEA02AD}"
Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}"/>
</SyncStatus>
2007-09-25 08:35:54,633 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Emitting response 200 code to client
2007-09-25 08:35:54,633 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2007-09-25 08:35:54,633 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Finished emitting response 200 code to client
2007-09-25 08:35:54,963 INFO engine.airsync.AirsyncServer : do_POST: received
Sync command
2007-09-25 08:35:54,963 DEBUG engine.airsync.AirsyncServer : _read_xml_request:
converting request from wbxml
2007-09-25 08:35:54,971 DEBUG engine.airsync.AirsyncServer : _handle_sync:
request document is
<?xml version="1.0" ?>
<!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>
{4785A962-C849-E6A7-0426-91EC6353812A}3
</SyncKey>
<CollectionId>
{4785A962-C849-E6A7-0426-91EC6353812A}
</CollectionId>
<DeletesAsMoves/>
<GetChanges/>
<WindowSize>
100
</WindowSize>
<Options>
<FilterType>
4
</FilterType>
<Truncation>
4
</Truncation>
<RtfTruncation>
4
</RtfTruncation>
<Conflict>
1
</Conflict>
</Options>
<Commands>
<Delete>
<ServerId>
{C2BE4C6C-FA17-3740-2D19-E86895252E66}
</ServerId>
</Delete>
</Commands>
</Collection>
</Collections>
</Sync>
2007-09-25 08:35:54,973 DEBUG engine.airsync.AirsyncServer : arrived at
rsp_responses_node
2007-09-25 08:35:54,975 DEBUG engine.airsync.AirsyncServer : Commands -
chg_type is NOT CHANGE_ADDED
2007-09-25 08:35:54,976 DEBUG engine.airsync.AirsyncServer : _handle_sync:
response document is
<?xml version="1.0" ?>
<!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>
{4785A962-C849-E6A7-0426-91EC6353812A}4
</SyncKey>
<CollectionId>
{4785A962-C849-E6A7-0426-91EC6353812A}
</CollectionId>
<Status>
1
</Status>
</Collection>
</Collections>
</Sync>
2007-09-25 08:35:54,977 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Emitting response 200 code to client
2007-09-25 08:35:54,977 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST
/Microsoft-Server-ActiveSync?User=DEFAULT&DeviceId=42DBE8CCB26C0BE6910A9CB83CA8EDB1&DeviceType=PocketPC&Cmd=Sync
HTTP/1.1" 200 -
2007-09-25 08:35:54,977 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Finished emitting response 200 code to client
2007-09-25 08:35:54,978 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Emitting wbxml (length = 112)
2007-09-25 08:35:54,978 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Finished emitting wbxml
2007-09-25 08:35:55,076 INFO engine.airsync.AirsyncServer : do_POST: received
Status command
2007-09-25 08:35:55,078 DEBUG engine.airsync.AirsyncServer : _handle_status:
request document is
<?xml version="1.0" ?>
<SyncStatus>
<Status Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}">
<Progress value="1"/>
</Status>
<Status Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}">
<Total value="2"/>
</Status>
<Status Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}">
<StatusString type="Status" value="1/2"/>
</Status>
</SyncStatus>
2007-09-25 08:35:55,079 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Emitting response 200 code to client
2007-09-25 08:35:55,079 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2007-09-25 08:35:55,080 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Finished emitting response 200 code to client
2007-09-25 08:35:55,363 INFO engine.airsync.AirsyncServer : do_POST: received
Sync command
2007-09-25 08:35:55,366 DEBUG engine.airsync.AirsyncServer : _read_xml_request:
converting request from wbxml
2007-09-25 08:35:55,374 DEBUG engine.airsync.AirsyncServer : _handle_sync:
request document is
<?xml version="1.0" ?>
<!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>
{4785A962-C849-E6A7-0426-91EC6353812A}4
</SyncKey>
<CollectionId>
{4785A962-C849-E6A7-0426-91EC6353812A}
</CollectionId>
<DeletesAsMoves/>
<GetChanges/>
<WindowSize>
100
</WindowSize>
<Options>
<FilterType>
4
</FilterType>
<Truncation>
4
</Truncation>
<RtfTruncation>
4
</RtfTruncation>
<Conflict>
1
</Conflict>
</Options>
<Commands>
<Add>
<ClientId>
1073741844
</ClientId>
<ApplicationData>
<Timezone
xmlns="http://synce.org/formats/airsync_wm5/calendar";>
xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAIAAAAAAAAAxP///w==
</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";>
20070925T063550Z
</DtStamp>
<EndTime
xmlns="http://synce.org/formats/airsync_wm5/calendar";>
20071017T190000Z
</EndTime>
<Location
xmlns="http://synce.org/formats/airsync_wm5/calendar";>
Naturfreundeheim
</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";>
VVS Hallertux
</Subject>
<StartTime
xmlns="http://synce.org/formats/airsync_wm5/calendar";>
20071017T180000Z
</StartTime>
<UID
xmlns="http://synce.org/formats/airsync_wm5/calendar";>
040000008200E00074C5B7101A82E00800000000A882094518EAFF96F2C9A69162534681100000001E62B73C77F4CB214CD6C5AD5C354FA4
</UID>
</ApplicationData>
</Add>
</Commands>
</Collection>
</Collections>
</Sync>
2007-09-25 08:35:55,376 DEBUG engine.airsync.AirsyncServer : arrived at
rsp_responses_node
2007-09-25 08:35:55,377 DEBUG engine.airsync.AirsyncServer : Commands -
chg_type is CHANGE_ADDED
2007-09-25 08:35:55,380 DEBUG engine.airsync.AirsyncServer : _handle_sync:
converting item from airsync, source is
<ApplicationData>
<Timezone xmlns="http://synce.org/formats/airsync_wm5/calendar";>
xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAIAAAAAAAAAxP///w==
</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";>
20070925T063550Z
</DtStamp>
<EndTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>
20071017T190000Z
</EndTime>
<Location xmlns="http://synce.org/formats/airsync_wm5/calendar";>
Naturfreundeheim
</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";>
VVS Hallertux
</Subject>
<StartTime xmlns="http://synce.org/formats/airsync_wm5/calendar";>
20071017T180000Z
</StartTime>
<UID xmlns="http://synce.org/formats/airsync_wm5/calendar";>
040000008200E00074C5B7101A82E00800000000A882094518EAFF96F2C9A69162534681100000001E62B73C77F4CB214CD6C5AD5C354FA4
</UID>
</ApplicationData>
bias -60
std_name STD
std_year 0
std_month 10
std_dow 6
std_occurrence 5
std_start_hour 3
std_minute 0
std_second 0
std_millisecs 0
std_bias 0
dst_name DST
dst_month 3
dst_dow 6
dst_occurrence 5
dst_start_hour 2
dst_minute 0
dst_second 0
dst_millisecs 0
dst_bias -60
START_TIME: 20071017T180000Z
CONFIG - DST OFFSET 1:00:00
2007-09-25 08:35:55,430 DEBUG engine.airsync.AirsyncServer : _handle_sync:
converting item from airsync, result is
<?xml version="1.0" ?>
<vcal>
<Timezone>
<TimezoneID>
/synce.org/DST-030605T020000-STD-100605T030000
</TimezoneID>
<Location>
Unknown/Unknown
</Location>
<DaylightSavings>
<TZOffsetFrom>
+0100
</TZOffsetFrom>
<TZOffsetTo>
+0200
</TZOffsetTo>
<TimezoneName>
DST
</TimezoneName>
<DateStarted>
20070325T020000
</DateStarted>
<RecurrenceRule>
<Rule>
FREQ=YEARLY
</Rule>
<Rule>
INTERVAL=1
</Rule>
<Rule>
BYMONTH=3
</Rule>
<Rule>
BYDAY=-1SU
</Rule>
</RecurrenceRule>
</DaylightSavings>
<Standard>
<TZOffsetFrom>
+0200
</TZOffsetFrom>
<TZOffsetTo>
+0100
</TZOffsetTo>
<TimezoneName>
STD
</TimezoneName>
<DateStarted>
20071028T030000
</DateStarted>
<RecurrenceRule>
<Rule>
FREQ=YEARLY
</Rule>
<Rule>
INTERVAL=1
</Rule>
<Rule>
BYMONTH=10
</Rule>
<Rule>
BYDAY=-1SU
</Rule>
</RecurrenceRule>
</Standard>
</Timezone>
<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>
20070925T063550Z
</Content>
</LastModified>
<DateStarted>
<TimezoneID>
/synce.org/DST-030605T020000-STD-100605T030000
</TimezoneID>
<Content>
20071017T200000
</Content>
</DateStarted>
<DateEnd>
<TimezoneID>
/synce.org/DST-030605T020000-STD-100605T030000
</TimezoneID>
<Content>
20071017T210000
</Content>
</DateEnd>
<Location>
<Content>
Naturfreundeheim
</Content>
</Location>
<Summary>
<Content>
VVS Hallertux
</Content>
</Summary>
<Categories/>
</Event>
</vcal>
2007-09-25 08:35:55,438 DEBUG engine.airsync.AirsyncServer : _handle_sync:
response document is
<?xml version="1.0" ?>
<!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>
{4785A962-C849-E6A7-0426-91EC6353812A}5
</SyncKey>
<CollectionId>
{4785A962-C849-E6A7-0426-91EC6353812A}
</CollectionId>
<Status>
1
</Status>
<Responses>
<Add>
<ClientId>
1073741844
</ClientId>
<ServerId>
{177FF051-1493-B908-921B-273B4AF7ABD7}
</ServerId>
<Status>
1
</Status>
</Add>
</Responses>
</Collection>
</Collections>
</Sync>
2007-09-25 08:35:55,441 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Emitting response 200 code to client
2007-09-25 08:35:55,441 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST
/Microsoft-Server-ActiveSync?User=DEFAULT&DeviceId=42DBE8CCB26C0BE6910A9CB83CA8EDB1&DeviceType=PocketPC&Cmd=Sync
HTTP/1.1" 200 -
2007-09-25 08:35:55,442 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Finished emitting response 200 code to client
2007-09-25 08:35:55,442 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Emitting wbxml (length = 177)
2007-09-25 08:35:55,443 DEBUG engine.airsync.AirsyncServer :
_send_wbxml_response: Finished emitting wbxml
2007-09-25 08:35:55,698 INFO engine.airsync.AirsyncServer : do_POST: received
Status command
2007-09-25 08:35:55,699 DEBUG engine.airsync.AirsyncServer : _handle_status:
request document is
<?xml version="1.0" ?>
<SyncStatus>
<SyncEnd Datatype="{4A5D9FE0-F139-4A63-A5A4-4F31CEEA02AD}"
Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}"/>
</SyncStatus>
2007-09-25 08:35:55,700 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Emitting response 200 code to client
2007-09-25 08:35:55,700 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2007-09-25 08:35:55,701 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Finished emitting response 200 code to client
2007-09-25 08:35:56,158 INFO engine.airsync.AirsyncServer : do_POST: received
Status command
2007-09-25 08:35:56,159 DEBUG engine.airsync.AirsyncServer : _handle_status:
request document is
<?xml version="1.0" ?>
<SyncStatus>
<SyncEnd Datatype="" Partner="{C088E3C2-20D8-712B-A096-7989F26DFF76}"/>
</SyncStatus>
2007-09-25 08:35:56,160 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Emitting response 200 code to client
2007-09-25 08:35:56,160 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2007-09-25 08:35:56,161 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Finished emitting response 200 code to client
2007-09-25 08:35:56,340 INFO engine.airsync.AirsyncServer : do_POST: received
Status command
2007-09-25 08:35:56,341 DEBUG engine.airsync.AirsyncServer : _handle_status:
request document is
<?xml version="1.0" ?>
<SyncStatus>
<SyncEnd Datatype="" Partner=""/>
</SyncStatus>
2007-09-25 08:35:56,342 INFO engine.synchandler.SyncHandler : _sync_end_cb:
Called
2007-09-25 08:35:56,342 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Emitting response 200 code to client
2007-09-25 08:35:56,342 DEBUG engine.airsync.AirsyncServer : HTTP Request:
"POST /Microsoft-Server-ActiveSync/SyncStat.dll HTTP/1.1" 200 -
2007-09-25 08:35:56,343 DEBUG engine.airsync.AirsyncServer :
_send_empty_response: Finished emitting response 200 code to client
2007-09-25 08:35:56,666 DEBUG engine.synchandler.SyncHandler : run: calling
RAPI sync_pause and sync_resume
2007-09-25 08:35:57,131 DEBUG engine.synchandler.SyncHandler : run: saving
partnership state
2007-09-25 08:35:57,185 DEBUG engine.synchandler.SyncHandler : run: saving
itemDB
2007-09-25 08:35:57,186 INFO engine.partnerships.Partnership : saving itemDB
for item 0
2007-09-25 08:35:57,187 INFO engine.partnerships.Partnership : saving itemDB
for item 1
2007-09-25 08:35:57,189 INFO engine.synchandler.SyncHandler : run: finished
synchronization
2007-09-25 08:35:57,189 INFO engine.syncengine.SyncEngine : Synchronized:
Emitting Synchronized signal
-------------------------------------------------------------------------
This SF.net email is sponsored by: Microsoft
Defy all challenges. Microsoft(R) Visual Studio 2005.
http://clk.atdmt.com/MRT/go/vse0120000070mrt/direct/01/
_______________________________________________
SynCE-Devel mailing list
SynCE-Devel@lists.sourceforge.net
https://lists.sourceforge.net/lists/listinfo/synce-devel
