Hi,
I am trying a local sync with syncevo-http-server to an Android 4.1.2
mobile phone to Evolution (Debian Wheezy).
Setup was done according to
https://syncevolution.org/wiki/synchronizing-evolution-http-howto .
Synchronization is started from the mobile phone. I am using the
pre-installed SyncML settings.
This is what syncevo-http-server says (entire protocoll):
...$ syncevo-http-server
http://localhost:9000/syncevolution
[INFO] syncevo-http: new SyncML session for xxx
[INFO] sync: /org/syncevolution/Server: ready to run
[INFO] sync: /org/syncevolution/Server: matched deviceID IMEI:xxx
against config
xxx
[INFO] sync: /org/syncevolution/Session/4318144571366535025: memo:
inactive
[INFO] sync: /org/syncevolution/Session/4318144571366535025: todo:
inactive
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: starting first time sync, two-way (peer is client)
[INFO] sync: /org/syncevolution/Session/4318144571366535025: creating
complete data backup of source addressbook before sync (enabled with
dumpData and needed for printChanges)
[INFO] sync: /org/syncevolution/Session/4318144571366535025: Local
data changes to be applied during synchronization:
[INFO] sync: /org/syncevolution/Session/4318144571366535025: ***
addressbook ***
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
Comparison was impossible.
> [INFO] sync: /org/syncevolution/Session/4318144571366535025:
>
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: started
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 1/83
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 2/82
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 3/81
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 4/80
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 5/79
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 6/78
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 7/77
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 8/76
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 9/75
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 10/74
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: sent 11/73
[ERROR] sync: /org/syncevolution/Session/4318144571366535025:
transport problem: send() on connection which is not ready
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
addressbook: first time sync done unsuccessfully
[ERROR] sync: /org/syncevolution/Session/4318144571366535025: aborted
on behalf of user (local, status 20017)
[INFO] sync: /org/syncevolution/Session/4318144571366535025: creating
complete data backup after sync (enabled with dumpData and needed for
printChanges)
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
Synchronization failed, see
xxx/.cache/syncevolution/touchy-2013-04-21-11-03/syncevolution-log.html
for details.
> [INFO] sync: /org/syncevolution/Session/4318144571366535025:
> Changes applied during synchronization:
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
+---------------|-----------------------|-----------------------|-CON-+
| | LOCAL | REMOTE | FLI
|
| Source | NEW | MOD | DEL | ERR | NEW | MOD | DEL | ERR | CTS
|
+---------------+-----+-----+-----+-----+-----+-----+-----+-----+-----+
| addressbook | 0 | 0 | 0 | 0 | 0 | 0 | 0 | 0 | 0
|
| slow, 0 KB sent by client, 0 KB received
|
| item(s) in database backup: 84 before sync, 84 after it
|
| aborted on behalf of user (local, status 20017)
|
+---------------+-----+-----+-----+-----+-----+-----+-----+-----+-----+
| calendar | 0 | 0 | 0 | 0 | 0 | 0 | 0 | 0 | 0
|
+---------------+-----+-----+-----+-----+-----+-----+-----+-----+-----+
| start Sun Apr 21 11:03:45 2013, duration 5:04min
|
| external transport failure (local, status 20043)
|
+---------------+-----+-----+-----+-----+-----+-----+-----+-----+-----+
First ERROR encountered: transport problem: send() on connection
which
is not ready
>
> [INFO] sync: /org/syncevolution/Session/4318144571366535025:
> Data modified locally during synchronization:
[INFO] sync: /org/syncevolution/Session/4318144571366535025: ***
addressbook ***
[INFO] sync: /org/syncevolution/Session/4318144571366535025: no
changes
[INFO] sync: /org/syncevolution/Session/4318144571366535025:
[ERROR] sync: /org/syncevolution/Session/4318144571366535025: error
code from
SyncEvolution external transport failure (local, status
20043): sync failed
The relevant part in the log file is:
[2013-04-21 11:03:48.371] ========= Finished request (session in
progress), processing time=2233 msec, incoming bytes=474, outgoing
bytes=4872
[2013-04-21 11:03:48.372] D-Bus transport: outgoing message 4872
bytes, application/vnd.syncml+wbxml,
[2013-04-21 11:03:48.378] D-Bus transport: wait - old state: WAITING,
Here is a 5 minutes wait, which corresponds to the timeout of
syncevolution. About at the beginning of this wait the mobile phone
interrups with "Sychnronisationsproblems".
[2013-04-21 11:08:48.573] D-Bus transport: got error 'timed out after
300s', current error is '', state WAITING
[2013-04-21 11:08:48.574] D-Bus transport: wait - new state: FAILED,
timed out after 300s
[2013-04-21 11:08:48.594] TransportException thrown at
src/dbus/server/dbus-transport-agent.cpp:169
[2013-04-21 11:08:48.594] transport problem: send() on connection
which is not ready
[2013-04-21 11:08:48.595] aborting after catching fatal error
–[2013-04-21 11:08:48.595] 'SessionAbort' - Aborting Session,
Status=20017, ProblemSource=LOCAL [--][++] [->end]
* [2013-04-21 11:08:48.595] WARNING: Aborting Session with
Reason Status 20017 (LOCAL problem) ***
* [2013-04-21 11:08:48.595] --------------- Ignoring all
commands in this message (after 302 sec. request processing,
302 sec. total) with Status 514 (0=none) from here on
–
[2013-04-21 11:08:48.595] 'DSAbort' - Aborting datastore sync,
abortStatusCode=20017, localProblem=yes,
resumable=yes [--][++] [->end] [->enclosing]
* [2013-04-21 11:08:48.595] addressbook: testState=TRUE
- expected state>='sync_set_ready', found
state=='server_sync_gen_started'
–
[2013-04-21 11:08:48.595] 'SaveSuspendState' - Saving
state for suspend/resume,
datastore=addressbook [--][++] [->end] [->enclosing]
So for some reasons the mobile phone interrupts the communication.
Can someone please help me to figure out why?
The same occurs with the calendar.
Thanks
Dietmar