[SyncEvolution] Problem syncing some accounts

Sun Nov 3 10:16:53 UTC 2019

Hi Patrik, all,
I am testing BT sync with Sailfish OS (successor to N9/meego)

There is some strange issue with some Accounts/Contacts.

My problem is that I can not edit/modify the contact on the phone, but
locally it looks fine

What does following mean exactly?

When I modify contact locally and sync

[2019-11-03 11:13:43.425] Created command 'Status' (incoming)
–
[2019-11-03 11:13:43.425] 'processStatus' - Processing incoming Status [--
[++] [->end] [->enclosing]

    [2019-11-03 11:13:43.425] Started processing Command 'Status' (incoming
MsgID=3, CmdID=3)
    [2019-11-03 11:13:43.425] WARNING: RECEIVED NON-OK STATUS 500 for
command 'Replace' (outgoing MsgID=2, CmdID=5)
    [2019-11-03 11:13:43.425] - TargetRef (remoteID) = '140'
    [2019-11-03 11:13:43.425] Found matching command 'Replace' for Status
    [2019-11-03 11:13:43.425] dsConfirmItemOp completed, syncop=replace,
localID='', remoteID='140', FAILURE, errorstatus=500
    [2019-11-03 11:13:43.425] Status: General error 500 (original op was
wants-replace) -> aborting sync with this datastore
    –
    [2019-11-03 11:13:43.425] 'DSAbort' - Aborting datastore sync,
abortStatusCode=500, localProblem=no, resumable=yes [--][++] [->end]
[->enclosing]
        [2019-11-03 11:13:43.425] addressbook: testState=TRUE - expected
state>='sync_set_ready', found state=='sync_gen_done'
        [2019-11-03 11:13:43.425] SaveSuspendState not possible (SyncML<1.2
or not supported by DB)
        [2019-11-03 11:13:43.425] *************** Warning: Datastore flagged
aborted (after 0 sec. request processing, 4 sec. total) with REMOTE Status
500
    –[2019-11-03 11:13:43.425] End of 'DSAbort' [->top] [->enclosing]
    [2019-11-03 11:13:43.425] Status: processed, removed command 'Replace'
from status wait queue
    [2019-11-03 11:13:43.425] Status: command 'Replace' has handled status
and allows to be deleted
    [2019-11-03 11:13:43.425] Deleted command 'Replace' (outgoing MsgID=2,
CmdID=5)
    [2019-11-03 11:13:43.425] Deleted command 'Status' (incoming MsgID=3,
CmdID=3)

–[2019-11-03 11:13:43.425] End of 'processStatus' [->top] [->enclosing]
[2019-11-03 11:13:43.425] after SessionStep: STEPCMD_OK
[2019-11-03 11:13:43.425] before SessionStep: STEPCMD_STEP
[2019-11-03 11:13:43.425] after SessionStep: STEPCMD_PROGRESS
[2019-11-03 11:13:43.425] addressbook: normal sync done unsuccessfully
[2019-11-03 11:13:43.425] addressbook: fatal error (remote, status 500)
[2019-11-03 11:13:43.425] before SessionStep: STEPCMD_STEP
[2019-11-03 11:13:43.425] after SessionStep: STEPCMD_OK
[2019-11-03 11:13:43.425] before SessionStep: STEPCMD_STEP
[2019-11-03 11:13:43.425] Calling smlProcessData(NEXT_COMMAND)
[2019-11-03 11:13:43.425] Created command 'Status' (incoming)

After this sync is a slow sync - there I find

    [2019-11-03 10:52:27.999] Compared [LOC=bUzWoqkqlB,REM=] with
[LOC=,REM=140] (eqMode=3), cmpres=0
    [2019-11-03 10:52:27.999] TStdLogicDS::getMatchingItem, found
remoteID='140' is equal in content with localID='bUzWoqkqlB'
    [2019-11-03 10:52:27.999] Slow Sync Match detected -
localID='bUzWoqkqlB' matches incoming item
    [2019-11-03 10:52:27.999] Compared [LOC=,REM=140] with
[LOC=bUzWoqkqlB,REM=] (eqMode=5), cmpres=-1
    [2019-11-03 10:52:27.999] Newer item determined: Server item is newer
and wins
    [2019-11-03 10:52:27.999] Trying to merge some data from loosing client
item into winning server item
    +
    [2019-11-03 10:52:27.999] 'ScriptExecute' - Start executing Script,
name=mergescript [--][++] [->end] [->enclosing]
    [2019-11-03 10:52:28.007] mergeWith() final status: thisitem: changed,
otheritem: changed (relevant; eqm_none field changes are not indicated)
    [2019-11-03 10:52:28.007] addressbook: testState=TRUE - expected
state>='sync_mode_stable', found state=='sync_set_ready'
    [2019-11-03 10:52:28.007] ModifyMap called: aEntryType=normal,
aLocalID='bUzWoqkqlB, aRemoteid='140', aMapflags=0x0, aDelete=0
    [2019-11-03 10:52:28.007] - found entry by
entrytype/localID='bUzWoqkqlB' - remoteid='140', mapflags=0x0, changed=0,
deleted=1, added=0, markforresume=0, savedmark=0
    [2019-11-03 10:52:28.007] - matching entry found - re-activating deleted
and/or updating contents if needed
    [2019-11-03 10:52:28.007] Map entry updated: LocalID='bUzWoqkqlB',
RemoteID='140'
    [2019-11-03 10:52:28.007] Server data was updated by record sent by
client, but server updates during non-firsttime slowsyncs are disabled
    [2019-11-03 10:52:28.007] Record sent by client was updated, but client
updates during non-firsttime slowsyncs are disabled
    [2019-11-03 10:52:28.007] Preventing localID='bUzWoqkqlB' to be sent to
client
    [2019-11-03 10:52:28.007] Item with localID='bUzWoqkqlB' will NOT be
sent to client (slowsync match / duplicate prevention)

–[2019-11-03 10:52:28.007] End of 'Process_Item' [->top] [->enclosing]
–
[2019-11-03 10:52:28.007] 'issue' - issuing command, Cmd=Status [--][++]
[->end] [->enclosing]

    [2019-11-03 10:52:28.007] Command 'Status': is 2-th counted cmd,
cmdsize(+tags needed to end msg)=40, available=16126 (maxfree=262015,
freeaftersend=261975, notUsableBufferBytes()=245889)
    [2019-11-03 10:52:28.007] Status Code 201 issued for Cmd=Add, (incoming
MsgID=3, CmdID=4)
    [2019-11-03 10:52:28.007] - SourceRef (remoteID) = '140'
    [2019-11-03 10:52:28.007] Status: issued as (outgoing MsgID=3, CmdID=4),
not waiting for status
    [2019-11-03 10:52:28.007] Status: issue finished and not waiting for
status -> deleting command
    [2019-11-03 10:52:28.007] Deleted command 'Status' (outgoing MsgID=3,
CmdID=4)
    [2019-11-03 10:52:28.007] Outgoing Message size is now 296 bytes

Thank you in advance

regards
_______________________________________________
SyncEvolution mailing list -- syncevolution at syncevolution.org
To unsubscribe send an email to syncevolution-leave at syncevolution.org
%(web_page_url)slistinfo%(cgiext)s/%(_internal_name)s