11:39 a.m.
----------------message d'origine-----------------
De: "Patrick Ohly"
A: "benoit" benoit(a)z-elec.com
Copie à: syncevolution(a)syncevolution.org
Date: Mon, 05 Dec 2011 12:06:17 +0100
-------------------------------------------------
On Sun, 2011-12-04 at 22:10 +0100, benoit wrote:
> Hello,
> I want to synchronize my evolution with my egroupware server.
> My client is Ubuntu 11.10
The version of SyncEvolution would be more useful.
Sorry,
SyncEvolution 1.2.1
using libedataserver-1.2.so.15 - might not be compatible!
using libebook-1.2.so.12 - might not be compatible!
using libecal-1.2.so.10 - might not be compatible!
using libecal-1.2.so.10 - might not be compatible!
using libbluetooth.so.3
I didn't saw that before, but why "might not be compatible"?
> My server is debian 6 with egroupware 1.8.002
> The error message indicate a wrong login, but I'm sure that my login is correct
> and M session log
> indicates a success login.
[...]
> [2011-12-04 18:10:40.404] Found matching command 'SyncHdr' for Status
> [2011-12-04 18:10:40.404] Remote requests auth
> type='syncml:auth-basic'
> [2011-12-04 18:10:40.404] Next Cred will have type='basic' and
> format='base64' and use nonce=''
> [2011-12-04 18:10:40.404] Authentication failed (status=401) with
> remote server
> –[2011-12-04 18:10:40.404] End of 'processStatus' [->top]
> [->enclosing]
> [2011-12-04 18:10:40.404] =================> Retrying Client Session
> Start
> –[2011-12-04 18:10:40.404] End of 'SyncML_Incoming' [->top]
> [2011-12-04 18:10:40.404] Deleted command 'Status' (outgoing MsgID=0,
> CmdID=0)
> –
If that is the end of the log, then this "next cred" with basic
authentication was never sent.
You can try changing the SyncEvolution config:
syncevolution --configure \
--sync-property clientAuthType=basic \
egroupware
I assume here that "egroupware" is the name of your config.
This forces sending the credentials in "basic" format right away.
--
Best Regards, Patrick Ohly
The content of this message is my personal opinion only and although
I am an employee of Intel, the statements I make here in no way
represent Intel's position on the issue, nor am I authorized to speak
on behalf of Intel on this matter.
That's not the end of the log, but it's too big to be sent here The change
you indicates for config does not work.
Here the fist part of the log.
Thanks for help and sorry for the bad english (I'm french)
Start of log - Synthesis SyncML Engine 3.4.0.27
[-- collapse all --][++ expand all ++]
+
[2011-12-05 12:34:34.465] 'loadSystemZoneDefinitions' - Linux system time zones
[--][++] [->end]
[2011-12-05 12:34:34.510] SyncML server account: amandine
[2011-12-05 12:34:34.510] client: SyncEvolution 1.2.1 for workstation
[2011-12-05 12:34:34.510] device ID: syncevolution-5694a4ec-d7e7-47b2-92ce-36f5958be8d9
[2011-12-05 12:34:34.510] using libedataserver-1.2.so.15 - might not be compatible!
using libebook-1.2.so.12 - might not be compatible!
using libecal-1.2.so.10 - might not be compatible!
using libecal-1.2.so.10 - might not be compatible!
using libbluetooth.so.3
sdp_extract_pdu_safe not found
sdp_extract_seqtype_safe not found
[2011-12-05 12:34:34.511] Scanning backend libraries in /usr/lib/syncevolution/backends/
Loading backend library synckcalextended.so
Loading backend library syncakonadi.so
Loading backend library syncdav.so
Loading backend library syncsqlite.so
Loading backend library syncmaemocal.so
Loading backend library syncxmlrpc.so
Loading backend library syncaddressbook.so
Loading backend library syncebook.so
Loading backend library syncqtcontacts.so
Loading backend library syncfile.so
Loading backend library syncecal.so
[2011-12-05 12:34:34.513] memo: inactive
[2011-12-05 12:34:34.514] todo: inactive
[2011-12-05 12:34:34.656] CreateContext SyncEvolution//addressbook => 0
[2011-12-05 12:34:34.656] Module_Version = 01080000
[2011-12-05 12:34:34.656] Module_Capabilities:
PLATFORM:Linux
DLL:true
MINVERSION:V1.0.6.0
MANUFACTURER:SyncEvolution
DESCRIPTION:SyncEvolution Synthesis DB Plugin
plugin_datastore_str:no
plugin_datastore_key:yes
ITEM_AS_KEY:yes
plugin_datablob:no
[2011-12-05 12:34:34.658] Module_PluginParams
Engine=01080000
[2011-12-05 12:34:34.658] Module_Capabilities:
PLATFORM:Linux
DLL:true
MINVERSION:V1.0.6.0
MANUFACTURER:SyncEvolution
DESCRIPTION:SyncEvolution Synthesis DB Plugin
plugin_datastore_str:no
plugin_datastore_key:yes
ITEM_AS_KEY:yes
plugin_datablob:no
[2011-12-05 12:34:34.659] CreateContext SyncEvolution//calendar => 0
[2011-12-05 12:34:34.659] Module_Version = 01080000
[2011-12-05 12:34:34.659] Module_Capabilities:
PLATFORM:Linux
DLL:true
MINVERSION:V1.0.6.0
MANUFACTURER:SyncEvolution
DESCRIPTION:SyncEvolution Synthesis DB Plugin
plugin_datastore_str:no
plugin_datastore_key:yes
ITEM_AS_KEY:yes
plugin_datablob:no
[2011-12-05 12:34:34.661] Module_PluginParams
Engine=01080000
[2011-12-05 12:34:34.662] Module_Capabilities:
PLATFORM:Linux
DLL:true
MINVERSION:V1.0.6.0
MANUFACTURER:SyncEvolution
DESCRIPTION:SyncEvolution Synthesis DB Plugin
plugin_datastore_str:no
plugin_datastore_key:yes
ITEM_AS_KEY:yes
plugin_datablob:no
[2011-12-05 12:34:34.665] --------- START of embedded log for session ID
'212189888074665' ---------
[2011-12-05 12:34:34.665] Executing Script 'sessioninitscript'
[2011-12-05 12:34:34.665] ==== Client Session started with SyncML (Server+Client) Engine
Version 3.4.0.27
[2011-12-05 12:34:34.666] ---- Hardcoded Product name: SySync SyncML Library OpenSource
Linux
[2011-12-05 12:34:34.666] ---- Configured Model/Manufacturer: SyncEvolution / Patrick
Ohly
[2011-12-05 12:34:34.666] ---- Running on Linux, URI/deviceID='linux:rantanplan'
[2011-12-05 12:34:34.666] ---- Platform Hardware Name/Version = 'Linux PC',
Firmware/OS Version = 'unknown'
[2011-12-05 12:34:34.666] ---- Configured Hardware Version = 'unknown', Firmware
Version = '1.2.1'
[2011-12-05 12:34:34.666] ---- System local time : 2011-12-05 12:34:34.666 (time zone
'CET/CEST', offset 1:00 hours east of UTC)
[2011-12-05 12:34:34.666] ---- System time in UTC : 2011-12-05 11:34:34.666
[2011-12-05 12:34:34.666] ==== Config file='', Last Change=2011-12-05
11:34:34.000
[2011-12-05 12:34:34.666] ==== Config ID string='SyncEvolution client config'
[2011-12-05 12:34:34.667] Executing Script 'sessioninitscript'
–
[2011-12-05 12:34:34.667] 'DSStateChange' - Datastore changes state,
datastore=addressbook, oldstate=idle, newstate=client_initialized [--][++] [->end]
–[2011-12-05 12:34:34.667] End of 'DSStateChange' [->top]
–
[2011-12-05 12:34:34.667] 'DSStateChange' - Datastore changes state,
datastore=calendar, oldstate=idle, newstate=client_initialized [--][++] [->end]
–[2011-12-05 12:34:34.667] End of 'DSStateChange' [->top]
[2011-12-05 12:34:34.668]
[2011-12-05 12:34:34.668] =================> Starting new client session
–
[2011-12-05 12:34:34.668] 'SyncML_Outgoing' - start of new outgoing message
[--][++] [->end]
[2011-12-05 12:34:34.668] =================> Started new outgoing message
[2011-12-05 12:34:34.668] Created command 'SyncHdr' (outgoing)
[2011-12-05 12:34:34.668] Target (Remote URI) =
'https://192.168.5.173/egroupware/rpc.php'
–
[2011-12-05 12:34:34.668] 'SyncHdr' - SyncHdr generation, SyncMLVers=1.2,
OutgoingMsgID=1 [--][++] [->end] [->enclosing]
[2011-12-05 12:34:34.668] SyncHdr: issued in MsgID=1, now queueing for status
[2011-12-05 12:34:34.669] Outgoing Message size is now 242 bytes
–[2011-12-05 12:34:34.669] End of 'SyncHdr' [->top] [->enclosing]
+
[2011-12-05 12:34:34.669] 'MakeAdminReady' - Making Admin Data ready to check
sync anchors, localDB=addressbook, remoteDB=./contacts [--][++] [->end]
[->enclosing]
–
[2011-12-05 12:34:34.669] 'DSStateChange' - Datastore changes state,
datastore=addressbook, oldstate=client_initialized, newstate=admin_ready [--][++]
[->end] [->enclosing]
–[2011-12-05 12:34:34.669] End of 'DSStateChange' [->top] [->enclosing]
+
[2011-12-05 12:34:34.670] 'MakeAdminReady' - Making Admin Data ready to check
sync anchors, localDB=calendar, remoteDB=./calendar [--][++] [->end] [->enclosing]
–
[2011-12-05 12:34:34.670] 'DSStateChange' - Datastore changes state,
datastore=calendar, oldstate=client_initialized, newstate=admin_ready [--][++] [->end]
[->enclosing]
–[2011-12-05 12:34:34.670] End of 'DSStateChange' [->top] [->enclosing]
[2011-12-05 12:34:34.670] Created command 'Put' (outgoing)
–
[2011-12-05 12:34:34.672] 'issue' - issuing command, Cmd=Put [--][++] [->end]
[->enclosing]
[2011-12-05 12:34:34.673] Put: issued as (outgoing MsgID=1, CmdID=1), now queueing for
status
[2011-12-05 12:34:34.673] Outgoing Message size is now 6651 bytes
–[2011-12-05 12:34:34.673] End of 'issue' [->top] [->enclosing]
[2011-12-05 12:34:34.673] Nothing known about server, request DevInf using GET command
[2011-12-05 12:34:34.673] Created command 'Get' (outgoing)
–
[2011-12-05 12:34:34.673] 'issue' - issuing command, Cmd=Get [--][++] [->end]
[->enclosing]
[2011-12-05 12:34:34.674] Get: issued as (outgoing MsgID=1, CmdID=2), now queueing for
status
[2011-12-05 12:34:34.674] Outgoing Message size is now 6721 bytes
–[2011-12-05 12:34:34.674] End of 'issue' [->top] [->enclosing]
[2011-12-05 12:34:34.674] (Saved) Last Local Client Anchor='', (generated) Next
Local Client Anchor='20111205T113434Z' (sent to server as
<last>/<next> in <alert>)
[2011-12-05 12:34:34.674] Created command 'Alert' (outgoing)
[2011-12-05 12:34:34.674] addressbook: ALERTING server for slow first time Sync
–
[2011-12-05 12:34:34.674] 'DSStateChange' - Datastore changes state,
datastore=addressbook, oldstate=admin_ready, newstate=client_sent_alert [--][++]
[->end] [->enclosing]
–[2011-12-05 12:34:34.674] End of 'DSStateChange' [->top] [->enclosing]
–
[2011-12-05 12:34:34.674] 'issue' - issuing command, Cmd=Alert [--][++]
[->end] [->enclosing]
[2011-12-05 12:34:34.674] Alert Code 201 sent
[2011-12-05 12:34:34.674] - Alert Item: Source='./addressbook',
Target='./contacts'
[2011-12-05 12:34:34.674] Alert: issued as (outgoing MsgID=1, CmdID=3), now queueing for
status
[2011-12-05 12:34:34.674] Outgoing Message size is now 6809 bytes
–[2011-12-05 12:34:34.674] End of 'issue' [->top] [->enclosing]
[2011-12-05 12:34:34.674] (Saved) Last Local Client Anchor='', (generated) Next
Local Client Anchor='20111205T113434Z' (sent to server as
<last>/<next> in <alert>)
[2011-12-05 12:34:34.675] Created command 'Alert' (outgoing)
[2011-12-05 12:34:34.675] calendar: ALERTING server for slow first time Sync
–
[2011-12-05 12:34:34.675] 'DSStateChange' - Datastore changes state,
datastore=calendar, oldstate=admin_ready, newstate=client_sent_alert [--][++] [->end]
[->enclosing]
–[2011-12-05 12:34:34.675] End of 'DSStateChange' [->top] [->enclosing]
–
[2011-12-05 12:34:34.675] 'issue' - issuing command, Cmd=Alert [--][++]
[->end] [->enclosing]
[2011-12-05 12:34:34.675] Alert Code 201 sent
[2011-12-05 12:34:34.675] - Alert Item: Source='./calendar',
Target='./calendar'
[2011-12-05 12:34:34.675] Alert: issued as (outgoing MsgID=1, CmdID=4), now queueing for
status
[2011-12-05 12:34:34.675] Outgoing Message size is now 6896 bytes
–[2011-12-05 12:34:34.675] End of 'issue' [->top] [->enclosing]
[2011-12-05 12:34:34.675] Ending message with 0 next-message/0 next-package commands:
FINAL (final allowed by caller)
[2011-12-05 12:34:34.675] Entire message size is now 6901 Bytes
–[2011-12-05 12:34:34.675] End of 'SyncML_Outgoing' [->top]
–
[2011-12-05 12:34:34.842] 'SyncML_Incoming' - Starting to analyze incoming
message, RequestNo=0, SySyncVers=3.4.0.27 [--][++] [->end]
[2011-12-05 12:34:34.842] =================> Starting to analyze incoming message,
SySync V3.4.0.27, RequestNo=0
[2011-12-05 12:34:34.842] Created command 'SyncHdr' (incoming)
–
[2011-12-05 12:34:34.842] 'processHdr' - Processing incoming SyncHdr [--][++]
[->end] [->enclosing]
–
[2011-12-05 12:34:34.843] 'SyncHdr' - Processing incoming SyncHdr,
IncomingMsgID=1 [--][++] [->end] [->enclosing]
[2011-12-05 12:34:34.843] Started Processing of message #1 (SyncML/1.2)
[2011-12-05 12:34:34.843] MaxMsgSize for outgoing msgs set to 10000
[2011-12-05 12:34:34.843] Created command 'Status' (outgoing)
[2011-12-05 12:34:34.843] RespURI set to =
'https://192.168.5.173/egroupware/rpc.php?syncml_sessionid=syncml-a9e43f81728b07d0cabdeec0419418db'
–
[2011-12-05 12:34:34.843] 'issue' - issuing command, Cmd=Status [--][++]
[->end] [->enclosing]
–[2011-12-05 12:34:34.843] End of 'issue' [->top] [->enclosing]
[2011-12-05 12:34:34.843] Incoming SyncHdr processed, incomingMsgID=1, SyncMLVers=1.2
[2011-12-05 12:34:34.843] - Session ID='75'
[2011-12-05 12:34:34.843] - Source (Remote party):
URI='https://192.168.5.173/egroupware/rpc.php' DisplayName=''
[2011-12-05 12:34:34.844] - Response to be sent to
URI='https://192.168.5.173/egroupware/rpc.php?syncml_sessionid=syncml-a9e43f81728b07d0cabdeec0419418db'
[2011-12-05 12:34:34.844] - Target (Local party) :
URI='syncevolution-5694a4ec-d7e7-47b2-92ce-36f5958be8d9' DisplayName='Linux
PC'
[2011-12-05 12:34:34.844] Deleted command 'SyncHdr' (incoming MsgID=1, CmdID=0)
–[2011-12-05 12:34:34.844] End of 'SyncHdr' [->top] [->enclosing]
–[2011-12-05 12:34:34.844] End of 'processHdr' [->top] [->enclosing]
[2011-12-05 12:34:34.844] Created command 'Status' (incoming)
–
[2011-12-05 12:34:34.844] 'processStatus' - Processing incoming Status [--][++]
[->end] [->enclosing]
[2011-12-05 12:34:34.844] Started processing Command 'Status' (incoming MsgID=1,
CmdID=1)
[2011-12-05 12:34:34.844] WARNING: RECEIVED NON-OK STATUS 401 for command
'SyncHdr' (outgoing MsgID=1, CmdID=0)
[2011-12-05 12:34:34.844] - TargetRef (remoteID) =
'https://192.168.5.173/egroupware/rpc.php'
[2011-12-05 12:34:34.844] - SourceRef (localID) =
'syncevolution-5694a4ec-d7e7-47b2-92ce-36f5958be8d9'
[2011-12-05 12:34:34.844] Found matching command 'SyncHdr' for Status
[2011-12-05 12:34:34.844] Remote requests auth type='syncml:auth-basic'
[2011-12-05 12:34:34.845] Next Cred will have type='basic' and
format='base64' and use nonce=''
[2011-12-05 12:34:34.845] Authentication failed (status=401) with remote server
–[2011-12-05 12:34:34.845] End of 'processStatus' [->top] [->enclosing]
[2011-12-05 12:34:34.845] =================> Retrying Client Session Start
–[2011-12-05 12:34:34.845] End of 'SyncML_Incoming' [->top]
[2011-12-05 12:34:34.845] Deleted command 'Status' (outgoing MsgID=0, CmdID=0)
–
[2011-12-05 12:34:34.845] 'SyncML_Outgoing' - start of new outgoing message
[--][++] [->end]
[2011-12-05 12:34:34.845] =================> Started new outgoing message
[2011-12-05 12:34:34.845] Created command 'SyncHdr' (outgoing)
[2011-12-05 12:34:34.845] Target (Remote URI) =
'https://192.168.5.173/egroupware/rpc.php'
–
[2011-12-05 12:34:34.845] 'SyncHdr' - SyncHdr generation, SyncMLVers=1.2,
OutgoingMsgID=1 [--][++] [->end] [->enclosing]
[2011-12-05 12:34:34.845] SyncHdr: issued in MsgID=1, now queueing for status
[2011-12-05 12:34:34.845] Outgoing Message size is now 242 bytes
–[2011-12-05 12:34:34.845] End of 'SyncHdr' [->top] [->enclosing]
[2011-12-05 12:34:34.845] --------------- Ignoring all commands in this message (after 0
sec. request processing, 0 sec. total) with Status 0 (0=none) from here on
[2011-12-05 12:34:34.846] Deleted command 'SyncHdr' (outgoing MsgID=1, CmdID=0)
[2011-12-05 12:34:34.846] Deleted command 'Status' (incoming MsgID=1, CmdID=1)
–[2011-12-05 12:34:34.846] End of 'SyncML_Outgoing' - Block Nest Warning: closing
'processStatus', but expected 'SyncML_Outgoing' [->top]
[2011-12-05 12:34:34.846] Created command 'Status' (incoming)
--
Benoit SZCZYGIEL
Z.elec
Tél 03 20 64 72 15
Courriel benoit(a)z-elec.com
site www.z-elec.com
Fax 03 20 61 07 28
30 rue de l'abbé Bonpain
59273 FRETIN