On Sat, Jul 26, 2014 at 1:32 PM, Patrick Ohly <patrick.ohly@intel.com> wrote:
On Sat, 2014-07-26 at 08:14 +0800, Emfox Zhou wrote:

> On Sat, Jul 26, 2014 at 1:46 AM, Ohly, Patrick
> <patrick.ohly@intel.com> wrote:
>         Hello,
>
>         I've no idea what could be causing this. It looks like an
>         error message from KDE or akonadi; it's definitely not
>         something from SyncEvolution.
>
>         Which binaries did you run before? Did they have
>         platformkde.so and syncakonadi.so with real code inside?
>
>         In your 1.4.99.3 installation, find these
>         under /use/lib/syncevolution/ backends and delete them. This
>         should restart syncevo-dbus-server automatically if it was
>         running.
>
> Yes, It is the case, after I deleted platformkde.so, the error no
> longer occurred.

Looks like a broken KDE config file. If you want to know more about
this, reinstall platformkde.so and do the debugging steps that I
mentioned.



>         Try simple ones, like "SYNCEVOLUTION_DEBUG=1 syncevolution
>         --daemon=no --print-databases".
>
>         If that triggers it and it is not clear which file it is
>         talking about, then run under strace.
>
>         Bye, Patrick
>
> Now I received 500 internal error, and my phone received 13 contacts
> (not 16 as the log said):

[...]

 > see /home/emfox/.cache/syncevolution/c102-2014-07-25-23-49/syncevolution-log.html for details.

What does this log file say about the internal error?

OK, very long log ( about 90MB), some of the log including error.
My google account has 979 contacts, which I noticed that the nokia phone supports
no more than 1000 contacts. Is it maybe because of the capacity of the phone?
I've purged the phone contact list before syncing.

–[2014-07-25 23:49:51.813] 'processStatus' - Processing incoming Status [--][++] [->end] [->enclosing]
[2014-07-25 23:49:51.813] Started processing Command 'Status' (incoming MsgID=3, CmdID=2)
[2014-07-25 23:49:51.813] RECEIVED STATUS 200 for for command 'Sync' (outgoing MsgID=2, CmdID=4)
[2014-07-25 23:49:51.813] - TargetRef (remoteID) = '/telecom/pb.vcf'
[2014-07-25 23:49:51.813] - SourceRef (localID) = 'addressbook'
[2014-07-25 23:49:51.813] Found matching command 'Sync' for Status
[2014-07-25 23:49:51.813] Status: 200: successful --> accept as ok
[2014-07-25 23:49:51.813] Status: processed, removed command 'Sync' from status wait queue
[2014-07-25 23:49:51.813] Status: command 'Sync' has handled status, but not finished() -> NOT deleted
[2014-07-25 23:49:51.813] Deleted command 'Status' (incoming MsgID=3, CmdID=2)
–[2014-07-25 23:49:51.813] End of 'processStatus' [->top] [->enclosing]
[2014-07-25 23:49:51.813] Calling smlProcessData(NEXT_COMMAND)
[2014-07-25 23:49:51.813] Created command 'Status' (incoming)
–[2014-07-25 23:49:51.813] 'processStatus' - Processing incoming Status [--][++] [->end] [->enclosing]
[2014-07-25 23:49:51.813] Started processing Command 'Status' (incoming MsgID=3, CmdID=3)
[2014-07-25 23:49:51.813] RECEIVED STATUS 201 for for command 'Add' (outgoing MsgID=2, CmdID=5)
[2014-07-25 23:49:51.813] - SourceRef (localID) = '#1'
[2014-07-25 23:49:51.813] Found matching command 'Add' for Status
[2014-07-25 23:49:51.813] translated tempLocalID='#1' back to real localID='101d0e85883cb6db'
[2014-07-25 23:49:51.813] dsConfirmItemOp - INTERNAL ERROR: no map entry exists for item
[2014-07-25 23:49:51.813] dsConfirmItemOp completed, syncop=add, localID='101d0e85883cb6db', remoteID='', SUCCESS, errorstatus=0
[2014-07-25 23:49:51.813] Status: 201: Item added (original op was wants-add)
[2014-07-25 23:49:51.813] Status: processed, removed command 'Add' from status wait queue
[2014-07-25 23:49:51.813] Status: command 'Add' has handled status and allows to be deleted
[2014-07-25 23:49:51.813] Deleted command 'Add' (outgoing MsgID=2, CmdID=5)
[2014-07-25 23:49:51.813] Deleted command 'Status' (incoming MsgID=3, CmdID=3)
–[2014-07-25 23:49:51.813] End of 'processStatus' [->top] [->enclosing]
[2014-07-25 23:49:51.814] Calling smlProcessData(NEXT_COMMAND)
[2014-07-25 23:49:51.814] Created command 'Status' (incoming)
–[2014-07-25 23:49:51.814] 'processStatus' - Processing incoming Status [--][++] [->end] [->enclosing]
[2014-07-25 23:49:51.814] Started processing Command 'Status' (incoming MsgID=3, CmdID=4)
[2014-07-25 23:49:51.814] WARNING: RECEIVED NON-OK STATUS 500 for command 'Add' (outgoing MsgID=2, CmdID=6)
[2014-07-25 23:49:51.814] - SourceRef (localID) = '#2'
[2014-07-25 23:49:51.814] Found matching command 'Add' for Status
[2014-07-25 23:49:51.814] translated tempLocalID='#2' back to real localID='10497db509ecc635'
[2014-07-25 23:49:51.814] dsConfirmItemOp - INTERNAL ERROR: no map entry exists for item
[2014-07-25 23:49:51.814] dsConfirmItemOp completed, syncop=add, localID='10497db509ecc635', remoteID='', FAILURE, errorstatus=500
[2014-07-25 23:49:51.814] Status: General error 500 (original op was wants-add) -> aborting sync with this datastore
–[2014-07-25 23:49:51.814] 'DSAbort' - Aborting datastore sync, abortStatusCode=500, localProblem=no, resumable=yes [--][++] [->end] [->enclosing]
–[2014-07-25 23:49:51.814] 'SessionAbort' - Aborting Session, Status=500, ProblemSource=REMOTE [--][++] [->end] [->enclosing]
[2014-07-25 23:49:51.814] WARNING: Aborting Session with Reason Status 500 (REMOTE problem) ***
[2014-07-25 23:49:51.814] --------------- Ignoring all commands in this message (after 0 sec. request processing, 31 sec. total) with Status 514 (0=none) from here on

--
Emfox Zhou

GnuPG Public Key: 0xF7142EC2