Navigation

    Kopano
    • Register
    • Login
    • Search
    • Categories
    • Get Official Kopano Support
    • Recent
    Statement regarding the closure of the Kopano community forum and the end of the community edition

    Completing recurrent tasks breaks sync

    Z-Push when using Kopano
    2
    6
    566
    Loading More Posts
    • Oldest to Newest
    • Newest to Oldest
    • Most Votes
    Reply
    • Reply as topic
    Log in to reply
    This topic has been deleted. Only users with topic management privileges can see it.
    • Darian
      Darian last edited by

      My mobile client allows me to create a recurrent task that will be recreated after completion. Once I check off such task as completed, I can see errors in z-push-error.log. No further synchronization takes place unless I delete the recurring task from my phone. It looks like a resyc would be performed discarding any subsequent changes on my task list.
      I am not sure if kopano supports recurrent tasks at all since the web interface offers no settings for recurrence.

      z-push.log:

      16/10/2018 11:24:46 [ 2248] [ERROR] [darian] [nine621b3e876d5d] WBXMLDecoder->getElementEndTag(): could not read end tag in '/usr/share/z-push/lib/request/sync.php:533'. Please enable the LOGLEVEL_WBXML and send the log to the Z-Push dev team.
16/10/2018 11:24:46 [ 2248] [FATAL] [darian] [nine621b3e876d5d] WBXMLException: Unknown error in Sync->Handle() - code: 0 - file: /usr/share/z-push/lib/request/requestprocessor.php:117
16/10/2018 11:24:46 [ 2248] [FATAL] [darian] [nine621b3e876d5d] WBXML 10K debug data: AwFqAEVcT0sDe2E4ZGEwNTViLWQwZWQtNDZjNC05ZjUzLTEzYjU1N2Q4NDIzYn0xMgABUgNVZmRhZWEAAV4DMQABUwMxAAFVAzUAAVdYAzAAAVsDMQABABFFRgMxAAFIAzAAAQEBAABWR0wDMjY5MAABXQARSkYDMQABSwMgAAEBAAlgA1JlY3VycmVudCB3ZWVrbHkgdGFzawABTgMxAAFNAzIwMTgtMTAtMTVUMjI6MDA6MDAuMDAwWgABTAMyMDE4LTEwLTE2VDAwOjAwOjAwLjAwMFoAAU9ZAzAAAVoDMQABUAMxAAFRAzIwMTgtMTAtMTZUMDA6MDA6MDAuMDAwWgABVAMxAAFWAzQAAWYDMAABAUoDMQABSwMyMDE4LTEwLTE2VDAwOjAwOjAwLjAwMFoAAV0DMAABWwMwAAEBAQAAR0wDMjY5MQABXQARSkYDMQABSwMgAAEBAAlgA1JlY3VycmVudCB3ZWVrbHkgdGFzawABTgMxAAFNAzIwMTgtMTAtMjJUMjI6MDA6MDAuMDAwWgABTAMyMDE4LTEwLTIzVDAwOjAwOjAwLjAwMFoAAU9ZAzAAAVoDMAABUAMxAAFRAzIwMTgtMTAtMTZUMDA6MDA6MDAuMDAwWgABVAMxAAFWAzQAAWYDMAABAUoDMAABXQMwAAFbAzAAAQEBAABJTQNVZmRhZWE6NGRmOTBkOTA4MzZhNGNmOWFmYWI0ODRlNTVhYzJkMzU4ZjEyMDcwMDAwMDAAAQEBAQEB
16/10/2018 11:24:46 [ 2248] [FATAL] [darian] [nine621b3e876d5d] Exception: (WBXMLException) - Unknown error in Sync->Handle()
16/10/2018 11:24:46 [ 2248] [FATAL] [darian] [nine621b3e876d5d] Request could not be processed correctly due to a WBXMLException. Please report this including the 'WBXML debug data' logged. Be aware that the debug data could contain confidential information.

      Detailed debug log:

      16/10/2018 11:24:46 [ 2248] [DEBUG] -------- Start
16/10/2018 11:24:46 [ 2248] [DEBUG] cmd='Sync' devType='Android' devId='nine621b3e876d5d' getUser='darian' from='172.1.29.42' version='2.4.4+0' method='POST'
16/10/2018 11:24:46 [ 2248] [DEBUG] Used timezone 'Europe/Amsterdam'
16/10/2018 11:24:46 [ 2248] [DEBUG] ZPush::GetBackend(): trying autoload backend 'BackendKopano'
16/10/2018 11:24:46 [ 2248] [DEBUG] BackendKopano using PHP-MAPI version: 8.6.81.24 - PHP version: 5.6.25
16/10/2018 11:24:46 [ 2248] [DEBUG] SqlStateMachine(): init
16/10/2018 11:24:46 [ 2248] [DEBUG] SqlStateMachine->checkDbAndTables(): Database and tables exist.
16/10/2018 11:24:46 [ 2248] [DEBUG] SqlStateMachine->GetStateVersion(): supporting version '2'
16/10/2018 11:24:46 [ 2248] [DEBUG] Request::ProcessHeaders() ASVersion: 14.1
16/10/2018 11:24:46 [ 2248] [DEBUG] Using custom header 'X-Forwarded-For' to determine remote IP: 81.21.209.23 - connect is coming from IP: 172.1.29.42
16/10/2018 11:24:46 [ 2248] [DEBUG] ZPush::CommandNeedsProvisioning(0): true
16/10/2018 11:24:46 [ 2248] [DEBUG] SqlStateMachine->GetState(): devid:'nine621b3e876d5d' type:'devicedata' key:'null' counter:'false'
16/10/2018 11:24:46 [ 2248] [DEBUG] ASDevice data loaded for user: 'darian'
16/10/2018 11:24:46 [ 2248] [DEBUG] TopCollector(): Initialized mutexid Resource id #8 and memid Resource id #9.
16/10/2018 11:24:46 [ 2248] [DEBUG] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
16/10/2018 11:24:46 [ 2248] [DEBUG] LoopDetection(): Initialized mutexid Resource id #10 and memid Resource id #11.
16/10/2018 11:24:46 [ 2248] [DEBUG] LoopDetection initialised with IPC provider 'IpcSharedMemoryProvider' with type '1337'
16/10/2018 11:24:46 [ 2248] [DEBUG] ZPush::HierarchyCommand(0): false
16/10/2018 11:24:46 [ 2248] [DEBUG] DeviceManager->ProvisioningRequired('799412378') saved device key '799412378': false
16/10/2018 11:24:46 [ 2248] [DEBUG] DeviceManager->getPolicyName(): determined policy name: 'default'
16/10/2018 11:24:46 [ 2248] [DEBUG] DeviceManager->getProvisioningPolicies(): loaded 'default' policy.
16/10/2018 11:24:46 [ 2248] [DEBUG] ZPush::CommandNeedsAuthentication(0): true
16/10/2018 11:24:46 [ 2248] [DEBUG] KopanoBackend->Logon(): Trying to authenticate user 'darian'..
16/10/2018 11:24:46 [ 2248] [DEBUG] KopanoBackend->openMessageStore('darian'): Found 'DEFAULT' store: 'Resource id #14'
16/10/2018 11:24:46 [ 2248] [DEBUG] KopanoBackend->Logon(): User 'darian' is authenticated
16/10/2018 11:24:46 [ 2248] [DEBUG] Store supports properties containing Unicode characters.
16/10/2018 11:24:46 [ 2248] [DEBUG] ZPush::CommandNeedsPlainInput(0): false
16/10/2018 11:24:46 [ 2248] [WBXML] I  <Synchronize>
16/10/2018 11:24:46 [ 2248] [WBXML] I   <Folders>
16/10/2018 11:24:46 [ 2248] [WBXML] I    <Folder>
16/10/2018 11:24:46 [ 2248] [WBXML] I     <SyncKey>
16/10/2018 11:24:46 [ 2248] [WBXML] I      {a8da055b-d0ed-46c4-9f53-13b557d8423b}12
16/10/2018 11:24:46 [ 2248] [WBXML] I     </SyncKey>
16/10/2018 11:24:46 [ 2248] [WBXML] I     <FolderId>
16/10/2018 11:24:46 [ 2248] [WBXML] I      Ufdaea
16/10/2018 11:24:46 [ 2248] [WBXML] I     </FolderId>
16/10/2018 11:24:46 [ 2248] [DEBUG] SqlStateMachine->GetState(): devid:'nine621b3e876d5d' type:'fd' key:'a8da055b-d0ed-46c4-9f53-13b557d8423b' counter:'false'
16/10/2018 11:24:46 [ 2248] [DEBUG] SyncParameters->UseCPO('DEFAULT')
16/10/2018 11:24:46 [ 2248] [DEBUG] DeviceManager->GetBackendIdForFolderId(): folderid Ufdaea => 4df90d90836a4cf9afab484e55ac2d35655200000000
16/10/2018 11:24:46 [ 2248] [DEBUG] SyncCollections->AddCollection(): Folder id 'Ufdaea' : ref. PolicyKey '799412378', ref. Lifetime '480', last sync at '1539681842'
16/10/2018 11:24:46 [ 2248] [DEBUG] SyncCollections->AddCollection(): Updated reference PolicyKey '799412378', reference Lifetime '480', Last sync at '1539681842'
16/10/2018 11:24:46 [ 2248] [WBXML] I     <DeletesAsMoves>
16/10/2018 11:24:46 [ 2248] [WBXML] I      1
16/10/2018 11:24:46 [ 2248] [WBXML] I     </DeletesAsMoves>
16/10/2018 11:24:46 [ 2248] [WBXML] I     <GetChanges>
16/10/2018 11:24:46 [ 2248] [WBXML] I      1
16/10/2018 11:24:46 [ 2248] [WBXML] I     </GetChanges>
16/10/2018 11:24:46 [ 2248] [WBXML] I     <WindowSize>
16/10/2018 11:24:46 [ 2248] [WBXML] I      5
16/10/2018 11:24:46 [ 2248] [WBXML] I     </WindowSize>
16/10/2018 11:24:46 [ 2248] [WBXML] I     <Options>
16/10/2018 11:24:46 [ 2248] [WBXML] I      <FilterType>
16/10/2018 11:24:46 [ 2248] [DEBUG] SyncParameters->UseCPO('DEFAULT')
16/10/2018 11:24:46 [ 2248] [WBXML] I       0
16/10/2018 11:24:46 [ 2248] [WBXML] I      </FilterType>
16/10/2018 11:24:46 [ 2248] [WBXML] I      <Conflict>
16/10/2018 11:24:46 [ 2248] [WBXML] I       1
16/10/2018 11:24:46 [ 2248] [WBXML] I      </Conflict>
16/10/2018 11:24:46 [ 2248] [WBXML] I      <AirSyncBase:BodyPreference>
16/10/2018 11:24:46 [ 2248] [WBXML] I       <AirSyncBase:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I        1
16/10/2018 11:24:46 [ 2248] [WBXML] I       </AirSyncBase:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I       <AirSyncBase:AllOrNone>
16/10/2018 11:24:46 [ 2248] [WBXML] I        0
16/10/2018 11:24:46 [ 2248] [WBXML] I       </AirSyncBase:AllOrNone>
16/10/2018 11:24:46 [ 2248] [WBXML] I      </AirSyncBase:BodyPreference>
16/10/2018 11:24:46 [ 2248] [WBXML] I     </Options>
16/10/2018 11:24:46 [ 2248] [WBXML] I     <Perform>
16/10/2018 11:24:46 [ 2248] [WBXML] I      <Add>
16/10/2018 11:24:46 [ 2248] [WBXML] I       <ClientEntryId>
16/10/2018 11:24:46 [ 2248] [WBXML] I        2690
16/10/2018 11:24:46 [ 2248] [WBXML] I       </ClientEntryId>
16/10/2018 11:24:46 [ 2248] [WBXML] I       <Data>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <AirSyncBase:Body>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <AirSyncBase:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I          1
16/10/2018 11:24:46 [ 2248] [WBXML] I         </AirSyncBase:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <AirSyncBase:Data>
16/10/2018 11:24:46 [ 2248] [WBXML] I           
16/10/2018 11:24:46 [ 2248] [DEBUG] StringStreamWrapper::stream_open(): initialized stream length: 1 - HTML-safe-truncate: false
16/10/2018 11:24:46 [ 2248] [WBXML] I         </AirSyncBase:Data>
16/10/2018 11:24:46 [ 2248] [WBXML] I        </AirSyncBase:Body>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Subject>
16/10/2018 11:24:46 [ 2248] [WBXML] I         Recurrent weekly task
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Subject>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Importance>
16/10/2018 11:24:46 [ 2248] [WBXML] I         1
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Importance>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:UtcDueDate>
16/10/2018 11:24:46 [ 2248] [WBXML] I         2018-10-15T22:00:00.000Z
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:UtcDueDate>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:DueDate>
16/10/2018 11:24:46 [ 2248] [WBXML] I         2018-10-16T00:00:00.000Z
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:DueDate>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Recurrence>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:Regenerate>
16/10/2018 11:24:46 [ 2248] [WBXML] I          0
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:Regenerate>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:DeadOccur>
16/10/2018 11:24:46 [ 2248] [WBXML] I          1
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:DeadOccur>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I          1
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:Start>
16/10/2018 11:24:46 [ 2248] [WBXML] I          2018-10-16T00:00:00.000Z
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:Start>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:Interval>
16/10/2018 11:24:46 [ 2248] [WBXML] I          1
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:Interval>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:DayOfWeek>
16/10/2018 11:24:46 [ 2248] [WBXML] I          4
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:DayOfWeek>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:FirstDayOfWeek>
16/10/2018 11:24:46 [ 2248] [ INFO] SyncTask->emptySupported(): no supported list available, emptying all not set parameters
16/10/2018 11:24:46 [ 2248] [DEBUG] Supported variables to be unset: complete,datecompleted,recurrence,regenerate,deadoccur,reminderset,remindertime,sensitivity,startdate,utcstartdate,rtf,categories
16/10/2018 11:24:46 [ 2248] [WBXML] I          0
16/10/2018 11:24:46 [ 2248] [ERROR] WBXMLDecoder->getElementEndTag(): could not read end tag in '/usr/share/z-push/lib/request/sync.php:533'. Please enable the LOGLEVEL_WBXML and send the log to the Z-Push dev team.
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:FirstDayOfWeek>
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Recurrence>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Complete>
16/10/2018 11:24:46 [ 2248] [WBXML] I         1
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Complete>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:DateCompleted>
16/10/2018 11:24:46 [ 2248] [WBXML] I         2018-10-16T00:00:00.000Z
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:DateCompleted>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Sensitivity>
16/10/2018 11:24:46 [ 2248] [WBXML] I         0
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Sensitivity>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:ReminderSet>
16/10/2018 11:24:46 [ 2248] [WBXML] I         0
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:ReminderSet>
16/10/2018 11:24:46 [ 2248] [WBXML] I       </Data>
16/10/2018 11:24:46 [ 2248] [WBXML] I      </Add>
16/10/2018 11:24:46 [ 2248] [WBXML] I      <Add>
16/10/2018 11:24:46 [ 2248] [WBXML] I       <ClientEntryId>
16/10/2018 11:24:46 [ 2248] [WBXML] I        2691
16/10/2018 11:24:46 [ 2248] [WBXML] I       </ClientEntryId>
16/10/2018 11:24:46 [ 2248] [WBXML] I       <Data>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <AirSyncBase:Body>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <AirSyncBase:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I          1
16/10/2018 11:24:46 [ 2248] [WBXML] I         </AirSyncBase:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <AirSyncBase:Data>
16/10/2018 11:24:46 [ 2248] [WBXML] I           
16/10/2018 11:24:46 [ 2248] [WBXML] I         </AirSyncBase:Data>
16/10/2018 11:24:46 [ 2248] [WBXML] I        </AirSyncBase:Body>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Subject>
16/10/2018 11:24:46 [ 2248] [WBXML] I         Recurrent weekly task
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Subject>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Importance>
16/10/2018 11:24:46 [ 2248] [WBXML] I         1
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Importance>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:UtcDueDate>
16/10/2018 11:24:46 [ 2248] [WBXML] I         2018-10-22T22:00:00.000Z
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:UtcDueDate>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:DueDate>
16/10/2018 11:24:46 [ 2248] [WBXML] I         2018-10-23T00:00:00.000Z
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:DueDate>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Recurrence>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:Regenerate>
16/10/2018 11:24:46 [ 2248] [WBXML] I          0
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:Regenerate>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:DeadOccur>
16/10/2018 11:24:46 [ 2248] [WBXML] I          0
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:DeadOccur>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I          1
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:Type>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:Start>
16/10/2018 11:24:46 [ 2248] [WBXML] I          2018-10-16T00:00:00.000Z
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:Start>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:Interval>
16/10/2018 11:24:46 [ 2248] [WBXML] I          1
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:Interval>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:DayOfWeek>
16/10/2018 11:24:46 [ 2248] [WBXML] I          4
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:DayOfWeek>
16/10/2018 11:24:46 [ 2248] [WBXML] I         <POOMTASKS:FirstDayOfWeek>
16/10/2018 11:24:46 [ 2248] [WBXML] I          0
16/10/2018 11:24:46 [ 2248] [WBXML] I         </POOMTASKS:FirstDayOfWeek>
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Recurrence>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Complete>
16/10/2018 11:24:46 [ 2248] [WBXML] I         0
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Complete>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:Sensitivity>
16/10/2018 11:24:46 [ 2248] [WBXML] I         0
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:Sensitivity>
16/10/2018 11:24:46 [ 2248] [WBXML] I        <POOMTASKS:ReminderSet>
16/10/2018 11:24:46 [ 2248] [WBXML] I         0
16/10/2018 11:24:46 [ 2248] [WBXML] I        </POOMTASKS:ReminderSet>
16/10/2018 11:24:46 [ 2248] [WBXML] I       </Data>
16/10/2018 11:24:46 [ 2248] [WBXML] I      </Add>
16/10/2018 11:24:46 [ 2248] [WBXML] I      <Remove>
16/10/2018 11:24:46 [ 2248] [WBXML] I       <ServerEntryId>
16/10/2018 11:24:46 [ 2248] [WBXML] I        Ufdaea:4df90d90836a4cf9afab484e55ac2d358f1207000000
16/10/2018 11:24:46 [ 2248] [WBXML] I       </ServerEntryId>
16/10/2018 11:24:46 [ 2248] [WBXML] I      </Remove>
16/10/2018 11:24:46 [ 2248] [WBXML] I     </Perform>
16/10/2018 11:24:46 [ 2248] [WBXML] I    </Folder>
16/10/2018 11:24:46 [ 2248] [WBXML] I   </Folders>
16/10/2018 11:24:46 [ 2248] [WBXML] I  </Synchronize>
16/10/2018 11:24:46 [ 2248] [FATAL] WBXMLException: Unknown error in Sync->Handle() - code: 0 - file: /usr/share/z-push/lib/request/requestprocessor.php:117
16/10/2018 11:24:46 [ 2248] [FATAL] WBXML 10K debug data: AwFqAEVcT0sDe2E4ZGEwNTViLWQwZWQtNDZjNC05ZjUzLTEzYjU1N2Q4NDIzYn0xMgABUgNVZmRhZWEAAV4DMQABUwMxAAFVAzUAAVdYAzAAAVsDMQABABFFRgMxAAFIAzAAAQEBAABWR0wDMjY5MAABXQARSkYDMQABSwMgAAEBAAlgA1JlY3VycmVudCB3ZWVrbHkgdGFzawABTgMxAAFNAzIwMTgtMTAtMTVUMjI6MDA6MDAuMDAwWgABTAMyMDE4LTEwLTE2VDAwOjAwOjAwLjAwMFoAAU9ZAzAAAVoDMQABUAMxAAFRAzIwMTgtMTAtMTZUMDA6MDA6MDAuMDAwWgABVAMxAAFWAzQAAWYDMAABAUoDMQABSwMyMDE4LTEwLTE2VDAwOjAwOjAwLjAwMFoAAV0DMAABWwMwAAEBAQAAR0wDMjY5MQABXQARSkYDMQABSwMgAAEBAAlgA1JlY3VycmVudCB3ZWVrbHkgdGFzawABTgMxAAFNAzIwMTgtMTAtMjJUMjI6MDA6MDAuMDAwWgABTAMyMDE4LTEwLTIzVDAwOjAwOjAwLjAwMFoAAU9ZAzAAAVoDMAABUAMxAAFRAzIwMTgtMTAtMTZUMDA6MDA6MDAuMDAwWgABVAMxAAFWAzQAAWYDMAABAUoDMAABXQMwAAFbAzAAAQEBAABJTQNVZmRhZWE6NGRmOTBkOTA4MzZhNGNmOWFmYWI0ODRlNTVhYzJkMzU4ZjEyMDcwMDAwMDAAAQEBAQEB
16/10/2018 11:24:46 [ 2248] [ INFO] User-agent: 'Nine-walleye/OPM1.171019.019'
16/10/2018 11:24:46 [ 2248] [FATAL] Exception: (WBXMLException) - Unknown error in Sync->Handle()
16/10/2018 11:24:46 [ 2248] [FATAL] Request could not be processed correctly due to a WBXMLException. Please report this including the 'WBXML debug data' logged. Be aware that the debug data could contain confidential information.
16/10/2018 11:24:46 [ 2248] [DEBUG] LoopDetection->ProcessLoopDetectionTerminate()
16/10/2018 11:24:46 [ 2248] [ INFO] cmd='Sync' memory='2.33 MiB/2.75 MiB' time='0.04s' devType='Android' devId='nine621b3e876d5d' getUser='darian' from='81.21.209.23' idle='0s' version='2.4.4+0' method='POST' httpcode='500'
16/10/2018 11:24:46 [ 2248] [DEBUG] -------- End

      I am running the following packages on centos 7.5.184:

      [root@kopano5 z-push]# rpm -qa "z-pu*"
z-push-backend-kopano-2.4.4+0-112.1.noarch
z-push-config-apache-2.4.4+0-112.1.noarch
z-push-common-2.4.4+0-112.1.noarch
z-push-ipc-sharedmemory-2.4.4+0-112.1.noarch
z-push-state-sql-2.4.4+0-112.1.noarch
z-push-kopano-2.4.4+0-112.1.noarch
[root@kopano5 z-push]# rpm -qa "kopano-*"
kopano-webapp-plugin-spell-nl-2.0.0.1-21.3.noarch
kopano-webapp-plugin-spell-it-1.0.0-32.3.noarch
kopano-webapp-plugin-spell-es-es-2.0.0.1-19.3.noarch
kopano-webapp-plugin-mattermost-0.1-17.1.noarch
kopano-webapp-plugin-intranet-0.1-32.10.noarch
kopano-monitor-8.6.81.24-4.1.x86_64
kopano-server-packages-8.6.81.24-4.1.x86_64
kopano-webapp-lang-3.4.21.1704-968.1.noarch
kopano-webapp-plugin-spell-2.0.0.17-34.1.noarch
kopano-webapp-plugin-spell-fr-fr-2.0.0.1-20.3.noarch
kopano-webapp-plugin-spell-en-us-2.0.0.1-20.3.noarch
kopano-webapp-plugin-spell-pl-pl-2.0.0.0-25.3.noarch
kopano-webapp-plugin-spell-de-ch-2.0.0.5-19.4.noarch
kopano-webapp-plugin-spell-de-de-2.0.0.3-20.4.noarch
kopano-webapp-plugin-gmaps-3.4.21.1704-968.1.noarch
kopano-webapp-plugin-zdeveloper-3.4.21.1704-968.1.noarch
kopano-webapp-plugin-quickitems-3.4.21.1704-968.1.noarch
kopano-webapp-plugin-folderwidgets-3.4.21.1704-968.1.noarch
kopano-webapp-plugin-titlecounter-3.4.21.1704-968.1.noarch
kopano-webapp-plugin-desktopnotifications-2.0.1.5-16.1.noarch
kopano-webapp-plugin-contactfax-3.4.21.1704-968.1.noarch
kopano-client-8.6.81.24-4.1.x86_64
kopano-utils-8.6.81.24-4.1.x86_64
kopano-server-8.6.81.24-4.1.x86_64
kopano-spooler-8.6.81.24-4.1.x86_64
kopano-contacts-8.6.81.24-4.1.x86_64
kopano-dagent-8.6.81.24-4.1.x86_64
kopano-ical-8.6.81.24-4.1.x86_64
kopano-backup-8.6.81.24-4.1.x86_64
kopano-search-8.6.81.24-4.1.x86_64
kopano-migration-pst-8.6.81.24-4.1.x86_64
kopano-spamd-8.6.81.24-4.1.x86_64
kopano-bash-completion-8.6.81.24-4.1.noarch
kopano-webapp-3.4.21.1704-968.1.noarch
kopano-webapp-plugin-spell-de-at-2.0.0.4-20.4.noarch
kopano-webapp-plugin-spell-en-gb-2.0.0.1-19.3.noarch
kopano-webapp-plugin-pimfolder-3.4.21.1704-968.1.noarch
kopano-webapp-plugin-filepreviewer-2.0.0.15-10.10.noarch
kopano-webapp-plugin-webappmanual-3.4.21.1704-968.1.noarch
kopano-common-8.6.81.24-4.1.x86_64
kopano-lang-8.6.81.24-4.1.x86_64
kopano-gateway-8.6.81.24-4.1.x86_64
kopano-python-utils-8.6.81.24-4.1.x86_64
kopano-presence-8.6.81.24-4.1.x86_64
kopano-devel-8.6.81.24-4.1.x86_64
kopano-debuginfo-8.6.81.24-4.1.x86_64
      1 Reply Last reply Reply Quote 0
      • Manfred
        Manfred Kopano last edited by

        Hi Darian,

        it looks like one WBXML tag is not defined for recurring tasks. I’ve created a new JIRA issue to fix it: https://jira.z-hub.io/browse/ZP-1457. While this fix itself should be pretty easy, there’s no guarantee that managing recurring tasks on the mobile will work as expected as there aren’t a lot of mobile devices which support it and we haven’t touched that part of code for quite some time (and as you noticed the webapp doesn’t support recurring tasks which makes it even more complicated to test/debug).

        Manfred

        1 Reply Last reply Reply Quote 0
        • Darian
          Darian last edited by

          Hi Manfred,

          I tested the changes in commit 950b414dc3846b2c956a21cce6deac915cee6ab8. It works better now, the sync does not break anymore. The only remaining thing I see is that once I complete a task on the smartphone an additional task with new due date is created in kopano instead of updating the existing one. Deleting the obsolete ones in Kopano will delete the task on the phone.

          Thanks,
          Darian

          Manfred 1 Reply Last reply Reply Quote 0
          • Manfred
            Manfred Kopano @Darian last edited by

            Hi Darian,

            @darian said in Completing recurrent tasks breaks sync:

            The only remaining thing I see is that once I complete a task on the smartphone an additional task with new due date is created in kopano instead of updating the existing one. Deleting the obsolete ones in Kopano will delete the task on the phone.

            Could you provide the WBXML log when such a completed task is being synced from the mobile to Kopano and maybe a couple of following requests?

            Manfred

            1 Reply Last reply Reply Quote 0
            • Darian
              Darian last edited by

              I created a task “RecurrentTask” with due date 28.10.2018 and a weekly recurrence. I completed the task and got 2 tasks in Kopano, the initial one and a recreated duplicate with new due date next week. Then I renamed the task on my phone to “RecurrentTask-renamed”. This renamed the initial task in Kopano only. Finally I deleted the task on my phone which deleted the initial task in Kopano but left the recreated task untouched.

              The WBXML log was actually too large to be pasted here so I uploaded it to
              https://c.gmx.net/@638455154206573293/V3FoMM8CRFayJZgq49MHug

              Thanks,
              Darian

              Manfred 1 Reply Last reply Reply Quote 0
              • Manfred
                Manfred Kopano @Darian last edited by

                Hi Darian,

                there aren’t any errors in the log and the behaviour is what I would expect from Z-Push.

                @darian said in Completing recurrent tasks breaks sync:

                I created a task “RecurrentTask” with due date 28.10.2018 and a weekly recurrence.

                In the log it’s starting on the line 92. The client sends a request to create a new recurring task “RecurrentTask” with the id 2762 (line 95, I’m using the client ids here and below as they’re numerical and easier to follow). Kopano creates a new recurring task with the id Ufdaea:4df90d90836a4cf9afab484e55ac2d35231907000000 which the client use from now on to identify the task.

                @darian said in Completing recurrent tasks breaks sync:

                I completed the task and got 2 tasks in Kopano, the initial one and a recreated duplicate with new due date next week.

                The client creates two new tasks with the same subject “RecurrentTask” with the ids 2763 (line 570) and 2764 (line 647) and removes the task 2762 (line 712) you’ve created in the first step. Tasks 2763 represents the completed one (Kopano id Ufdaea:4df90d90836a4cf9afab484e55ac2d35251907000000). Task 2764 is the new recurring tasks with the due date one week later (Kopano id Ufdaea:4df90d90836a4cf9afab484e55ac2d35261907000000).

                @darian said in Completing recurrent tasks breaks sync:

                Then I renamed the task on my phone to “RecurrentTask-renamed”. This renamed the initial task in Kopano only.

                The client actually renamed the new recurring task (2764) only (line 1557). The completed task 2763 remained untouched.

                @darian said in Completing recurrent tasks breaks sync:

                Finally I deleted the task on my phone which deleted the initial task in Kopano but left the recreated task untouched.

                In the log it looks like the remove request was issued on the mobile client, but nevertheless it was like in the previous step for the task 2764 only (line 2324).

                I hope this explains what’s going on and that the Z-Push behaviour is actually as it should.

                Manfred

                1 Reply Last reply Reply Quote 0
                • First post
                  Last post