[sync] thunderbird lightning deleting an event leads to HttpSendRequest error 12152 in funambol
LALOT Dominique
dom.lalot at gmail.com
Tue Jan 27 16:49:11 UTC 2009
Horde version 3.3.2 stable
I did a try on various versions of funambol thunderbird plugin and
various version of lightning.
First copying from a fresh recover : works well
Then deleting an existent event
synchronize
funambol v0.8 or v0.7said Request timed out
Then looking at its logs :
]]></Data>
</Item>
</Replace>
<Delete><CmdID>8</CmdID>
<Meta><Type xmlns="syncml:metinf">text/calendar</Type>
</Meta>
<Item><Source><LocURI>f1595f1c-0504-4885-a081-966c0164d0d1</LocURI>
</Source>
</Item>
</Delete>
</Sync>
<Final/></SyncBody>
</SyncML>
17:21:06 GMT +1:00 [DEBUG] - Connecting to hordetest.univmed.fr:443
17:21:06 GMT +1:00 [DEBUG] - Requesting resource /horde/rpc.php
17:21:07 GMT +1:00 [DEBUG] - HttpSendRequest error 12152: Le serveur a
renvoyÃ(c) une rÃ(c)ponse non valide ou non reconnue
17:21:07 GMT +1:00 [INFO] - Network error writing data from client:
retry 1 time...
17:21:07 GMT +1:00 [DEBUG] - HttpSendRequest error 12019: Le handle
n'est pas dans l'Ã(c)tat correct pour l'opÃ(c)ration demandÃ(c)e
17:21:07 GMT +1:00 [DEBUG] - Network error: the request has timed out -> exit.
17:21:07 GMT +1:00 [ERROR] - Error in syncing: Network error: the
request has timed out -> exit.
17:21:07 GMT +1:00 [DEBUG] -
===========================================================
================ SYNCHRONIZATION REPORT ===============
===========================================================
Last error code = 2007
Last error msg = Network error: the request has timed out -> exit.
On the server side:
Jan 27 17:19:29 HORDE [debug] [horde] Replaced entry
20050331095128.7g5vgebau22o at webmel.univ-mrs.fr due to client request
[pid 2476 on line 312 of
"/var/www/perso/horde-webmail-1.2.1/lib/SyncML/Sync.php"]
Jan 27 17:19:29 HORDE [debug] [horde] Handling <Delete> sent from
client [pid 2476 on line 211 of
"/var/www/perso/horde-webmail-1.2.1/lib/SyncML/Sync.php"]
Jan 27 17:19:29 HORDE [debug] [horde] Using default device class [pid
2476 on line 41 of
"/var/www/perso/horde-webmail-1.2.1/lib/SyncML/Device.php"]
Jan 27 17:19:29 HORDE [debug] [horde] SQL Query by
SyncML_Backend_Horde::_getSuid(): SELECT syncml_suid FROM
horde_syncml_map WHERE syncml_syncpartner = ? AND syncml_db = ? AND
syncml_uid = ? AND syncml_cuid = ?, values:
fmz-ZqLHfQakX5AAZpKHqcPxDg==, calendar, lalot,
f1595f1c-0504-4885-a081-966c0164d0d1 [pid 2476 on line 813 of
"/var/www/perso/horde-webmail-1.2.1/lib/SyncML/Backend/Horde.php"]
log.txt
DEBUG: Backend of class SyncML_Backend_Horde created
DEBUG: Started at 2009-01-27 17:19:29. Packet logged in /tmp/sync/client_10.xml
DEBUG: New session created: 105ad17fb472360714c4bdfbe331bf63
DEBUG: Checking authentication for user lalot
DEBUG: Authenticated: yes; version: 1.2; message ID: 1; source URI:
fmz-ZqLHfQakX5AAZpKHqcPxDg==; target URI:
https://hordetest.univmed.fr/horde/rpc.php; user: lalot; charset:
UTF-8; wbxml: no
DEBUG: SQL Query by SyncML_Backend_Horde::readSyncAnchors(): SELECT
syncml_clientanchor, syncml_serveranchor FROM horde_syncml_anchors
WHERE syncml_syncpartner = ? AND syncml_db = ? AND syncml_uid = ?,
values: fmz-ZqLHfQakX5AAZpKHqcPxDg==, calendar, lalot
DEBUG: Previous sync found for database event; client timestamp: 1233054476
DEBUG: Anchor timestamps match, TwoWaySync possible. Syncing data
since 2009-01-27 12:06:18
DEBUG: Creating SyncML_Sync object for database event; sync type 200
DEBUG: Received <Final> from client.
DEBUG: Handle <Final> for state Init
DEBUG: Sending <Final> to client
DEBUG: Return message completed
DEBUG: Finished at 2009-01-27 17:19:29. Packet logged in
/tmp/sync/server_10.xml
cat devinf.txt
SyncML_DeviceInfo::__set_state(array(
'VerDTD' => '1.2',
'Man' => NULL,
'Mod' => NULL,
'OEM' => NULL,
'FwV' => NULL,
'SwV' => '0.8',
'HwV' => NULL,
'DevID' => 'fmz-ZqLHfQakX5AAZpKHqcPxDg==',
'DevTyp' => 'workstation',
'DataStores' =>
array (
0 =>
SyncML_DataStore::__set_state(array(
'SourceRef' => 'calendar',
'DisplayName' => NULL,
'MaxGUIDSize' => NULL,
'Rx_Pref' =>
array (
'text/calendar' => '2.0',
),
'Rx' =>
array (
),
'Tx_Pref' =>
array (
'text/calendar' => '2.0',
),
'Tx' =>
array (
),
'DSMem' => NULL,
'SyncCap' =>
array (
2 => true,
1 => true,
6 => true,
4 => true,
),
)),
1 =>
SyncML_DataStore::__set_state(array(
'SourceRef' => 'contact',
'DisplayName' => NULL,
'MaxGUIDSize' => NULL,
'Rx_Pref' =>
array (
'text/x-vcard' => '2.1',
),
'Rx' =>
array (
),
'Tx_Pref' =>
array (
'text/x-vcard' => '2.1',
),
'Tx' =>
array (
),
'DSMem' => NULL,
'SyncCap' =>
array (
2 => true,
1 => true,
6 => true,
4 => true,
),
)),
2 =>
SyncML_DataStore::__set_state(array(
'SourceRef' => 'event',
'DisplayName' => NULL,
'MaxGUIDSize' => NULL,
'Rx_Pref' =>
array (
'text/calendar' => '2.0',
),
'Rx' =>
array (
),
'Tx_Pref' =>
array (
'text/calendar' => '2.0',
),
'Tx' =>
array (
),
'DSMem' => NULL,
'SyncCap' =>
array (
2 => true,
1 => true,
6 => true,
4 => true,
),
)),
3 =>
SyncML_DataStore::__set_state(array(
'SourceRef' => 'task',
'DisplayName' => NULL,
'MaxGUIDSize' => NULL,
'Rx_Pref' =>
array (
'text/calendar' => '2.0',
),
'Rx' =>
array (
),
'Tx_Pref' =>
array (
'text/calendar' => '2.0',
),
'Tx' =>
array (
),
'DSMem' => NULL,
'SyncCap' =>
array (
2 => true,
1 => true,
6 => true,
4 => true,
),
)),
),
'CTCaps' => NULL,
'Exts' => NULL,
'UTC' => true,
'SupportLargeObjs' => NULL,
'SupportNumberOfChanges' => NULL,
))
server_10.xml
<?xml version="1.0" encoding="UTF-8"?><SyncML
xmlns="syncml:syncml1.2"><SyncHdr><VerDTD>1.2</VerDTD><VerProto>SyncML/1.2</VerProto><SessionID>1233073266</SessionID><MsgID>1</MsgID><Target><LocURI>fmz-ZqLHfQakX5AAZpKHqcPxDg==</LocURI><LocName>lalot</LocName></Target><Source><LocURI>https://hordetest.univmed.fr/horde/rpc.php</LocURI></Source><RespURI>https://hordetest.univmed.fr/horde/rpc.php</RespURI><Meta><MaxMsgSize
xmlns="syncml:metinf">1000000000</MaxMsgSize><MaxObjSize
xmlns="syncml:metinf">1000000000</MaxObjSize></Meta></SyncHdr><SyncBody><Status><CmdID>1</CmdID><MsgRef>1</MsgRef><CmdRef>0</CmdRef><Cmd>SyncHdr</Cmd><TargetRef>https://hordetest.univmed.fr/horde/rpc.php</TargetRef><SourceRef>fmz-ZqLHfQakX5AAZpKHqcPxDg==</SourceRef><Data>212</Data></Status><Status><CmdID>2</CmdID><MsgRef>1</MsgRef><CmdRef>1</CmdRef><Cmd>Alert</Cmd><TargetRef>event</TargetRef><SourceRef>event</SourceRef><Data>200</Data><Item><Data><Anchor
xmlns="syncml:metinf"><Last>1233054476</Last><Next>1233073266</Next></Anchor></Data></Item></Status><Alert><CmdID>3</CmdID><Data>200</Data><Item><Target><LocURI>event</LocURI></Target><Source><LocURI>event</LocURI></Source><Meta><Anchor
xmlns="syncml:metinf"><Last>1233054378</Last><Next>1233073169</Next></Anchor><MaxObjSize
xmlns="syncml:metinf">1000000000</MaxObjSize></Meta></Item></Alert><Get><CmdID>4</CmdID><Meta><Type
xmlns="syncml:metinf">application/vnd.syncml-devinf+xml</Type></Meta><Item><Target><LocURI>./devinf12</LocURI></Target></Item></Get><Final></Final></SyncBody></SyncML>
data.txt
Input received from client (text/calendar):
BEGIN:VCALENDAR^M
VERSION:2.0^M
BEGIN:VEVENT^M
CREATED:20050331T075129Z^M
LAST-MODIFIED:20090127T144026Z^M
DTSTAMP:20090127T110619Z^M
UID:c548a4a3-c61f-4e64-9446-b7fc0031df72^M
SUMMARY:test encore^M
STATUS:CONFIRMED^M
CLASS:PUBLIC^M
ORGANIZER;RSVP=FALSE;CN=Dominique LALOT:mailto:dominique.lalot at univmed.fr^M
CATEGORIES:personnel^M
X-MOZ-LASTACK:20090127T144026Z^M
DTSTART:20050331T084500Z^M
DTEND:20050331T094500Z^M
DESCRIPTION:ceci est mon test^M
TRANSP:OPAQUE^M
X-MOZ-GENERATION:3^M
BEGIN:VALARM^M
TRIGGER;VALUE=DURATION:-PT5M^M
DESCRIPTION:Mozilla Alarm: test encore^M
ACTION:DISPLAY^M
END:VALARM^M
END:VEVENT^M
END:VCALENDAR
Any ideas? I just see using default device class, but trying to force
a device leads to nothing.
Help please!
Dom
--
Dominique LALOT
Ingénieur Systèmes et Réseaux
http://annuaire.univmed.fr/showuser?uid=lalot
More information about the sync
mailing list