ZPush Issue after zarafa to Kopana migration



  • Hello,
    After the migration from Zarafa, to Kopano, I’ve some strange issues.
    First off all here a overview of the current install.

    0_1490028952126_upload-6c466df3-86bb-45d8-88be-2ae1c92e1192

    Different users have issues with the Mail app on android device, to receive new mail’s,
    We run already a resync to the device.
    But same issue.
    So I wipe the device, install all apps on it and sync them again.
    With the first sync, they receive all their mail, but later on the don’t receive new mails.
    And when the Sync the device, they didn’t receive their personal Address book on their device.

    While everything is correct available in the webApp.
    And I found the following in the Z-push-error.log

    20/03/2017 17:33:33 [20731] [FATAL] [user1] Fatal error: Unknown:0 - Module 'mapi' already loaded (32)
    20/03/2017 17:33:33 [20731] [FATAL] [user1] Fatal error: Unknown:0 - Module 'mapi' already loaded (32)
    20/03/2017 17:46:19 [21229] [FATAL] [user2] Fatal error: Unknown:0 - Module 'mapi' already loaded (32)
    20/03/2017 17:46:19 [21229] [FATAL] [user2] Fatal error: Unknown:0 - Module 'mapi' already loaded (32)
    20/03/2017 17:51:57 [21310] [FATAL] [user2] Fatal error: Unknown:0 - Module 'mapi' already loaded (32)
    20/03/2017 17:51:57 [21310] [FATAL] [user2] Fatal error: Unknown:0 - Module 'mapi' already loaded (32)
    20/03/2017 17:53:22 [21303] [FATAL] [user3] Fatal error: Unknown:0 - Module 'mapi' already loaded (32)
    20/03/2017 17:53:22 [21303] [FATAL] [user3] Fatal error: Unknown:0 - Module 'mapi' already loaded (32)
    

  • Kopano

    Somewhere in your configuration you include the mapi.so twice.
    Check the files in /etc/php5/apache/ and the conf.d directory.

    If this doesn’t fix the issue, please create a wbxml log for one user with this problem.
    More information about that is available here:
    https://wiki.z-hub.io/display/ZP/Debugging

    Cheers,
    Sebastian



  • the strange issue is that I still find Zarafa items
    0_1490101167704_upload-5400ffd5-2d07-4ff3-a0aa-124cf6b94b6e

    And in the mods-available folder
    0_1490101223061_upload-5f6e6cc8-2f5d-4dbe-9247-a95c657a4c7d

    the extension=mapi.so is available, in the 20-kopano.ini , as wel in the Zarafa.ini
    when I add $specialLogUsers = array(‘user1@domain.com’,‘user1.’);
    restart the service with, service restart apache2
    resync the device, he didn’t create a new error log file.

    zarafa-admin -a -u user2 show me some message sync error’s
    Reason: Message was causing loop (2)
    While I’ve already submit the clear command.


  • Kopano

    If you keep the zarafa.ini in this folder (even with a prefix) it’s still going to be included. So you need to remove the file or comment (#) the extension=mapi.so line.

    For specialLogUsers you should add only your username. If you username is ‘user1’ have it like this:

    $specialLogUsers = array('user1');
    

    Your example has a “.” which then doesn’t match the username.

    Messages that are causing loops need to be re-queued so they get synchronized again. This is not that easy with emails, if you really need this email on the mobile, resync the folder it’s in.
    For appointments, contacts and tasks you can just open the item in WebApp, modify something and save to have the object re-queued.



  • Thanks a lot for all your support,
    I remeve the zarafa items, that solved the MAPI issue.
    Now I’ve still some devices, with a sync issue.
    The most off them are already solved.

    Broken object:  'SyncAppointment' ignored on '2017-03-21 21:45'
           Information:    Subject: 'XXXXXXX' - On: '2017-04-05 19:30'
           Reason:         Message was causing loop (2)
           Item/Parent id: Udd5bb:c8b30938bf774f6897130e721f8d3ed62a3501000000/Udd5bb
    

    Can you tell me how I can solve this issue?



  • Sorry, I’ve still some issues with z-push
    As you can read above, there where old zarafa items active, which one I remove, but I receive still a lot off errors in the error log.
    Can you tell me what is the right config file While I found the following
    0_1490174411105_upload-e516b95b-db5f-43eb-807a-e83f1731e541
    0_1490174463552_upload-53cfaec4-7b0b-4f1c-984c-db283f694b93 and on on the /use/share/z-push
    0_1490174505034_upload-e982d585-51c6-4863-9147-cc5e0075e3f1

    While I foung the following in the apache.conf file.

    0_1490174747667_upload-6125651e-c7c6-4945-aa88-b6674f6749ee

    Or is it better, to remove all z-push from the server, and reinstall them?


  • Kopano

    your screenshots do not really look like you have the correct z-push installed, may it be that you installed it manually in the past?

    On a fresh z-push installation you should only have the following fils in /etc/z-push:

    -rw-r--r--   1 root root  2727 Mär  3 21:12 gabsync.conf.php
    -rw-r--r--   1 root root  3735 Mär  3 21:12 kopano.conf.php
    -rw-r--r--   1 root root  7855 Mär  3 21:12 policies.ini
    -rw-r--r--   1 root root 19104 Mär  3 21:12 z-push.conf.php
    

    Also there should be more lines in the apache vhost.

    As for the errors: instead of writing you get a lot of errors, it would be more helpful if you copy & paste the actual error messages. as for the loopdetection messages there should be more information in the default logfiles. if not then you need to enable wbxml, as Sebastian already explained.



  • @fbartels
    So far I can remember, I didn’t install them manual.

    2/03/2017 11:08:15  [ERROR] [user2] trace: 1:/usr/share/z-push/lib/core/zlog.php:154 - Log->SetSpecialLogUsers()
    22/03/2017 11:08:15  [ERROR] [user2] trace: 1:/usr/share/z-push/lib/core/zlog.php:154 - Log->SetSpecialLogUsers()
    22/03/2017 11:08:15  [ERROR] [user2] trace: 2:/usr/share/z-push/lib/core/zlog.php:49 - ZLog::getLogger()
    22/03/2017 11:08:15  [ERROR] [user2] trace: 2:/usr/share/z-push/lib/core/zlog.php:49 - ZLog::getLogger()
    22/03/2017 11:08:15  [ERROR] [user2] trace: 3:/usr/share/z-push/index.php:47 - ZLog::Initialize()
    22/03/2017 11:08:15  [ERROR] [user2] trace: 3:/usr/share/z-push/index.php:47 - ZLog::Initialize()
    22/03/2017 11:08:15 [21110] [FATAL] [user2] FatalMisconfigurationException: The WBXML log users is not an array. - code: 0 - file: /usr/share/z-push/lib/core/zpush.php:300
    22/03/2017 11:08:15 [21110] [FATAL] [user2] FatalMisconfigurationException: The WBXML log users is not an array. - code: 0 - file: /usr/share/z-push/lib/core/zpush.php:300
    22/03/2017 11:08:15 [21110] [FATAL] [user2] Exception: (FatalMisconfigurationException) - The WBXML log users is not an array.
    22/03/2017 11:08:15 [21110] [FATAL] [user2] Exception: (FatalMisconfigurationException) - The WBXML log users is not an array.
    22/03/2017 11:08:15  [ERROR] [user1] trace error: /usr/share/z-push/lib/log/log.php:231 Argument 1 passed to Log::SetSpecialLogUsers() must be of the type array, null given, called in /usr/share/z-push/lib/core/zlog.php on line 154 and defined (4096) - backtrace: 3 steps
    22/03/2017 11:08:15  [ERROR] [user1] trace error: /usr/share/z-push/lib/log/log.php:231 Argument 1 passed to Log::SetSpecialLogUsers() must be of the type array, null given, called in /usr/share/z-push/lib/core/zlog.php on line 154 and defined (4096) - backtrace: 3 steps
    22/03/2017 11:08:15  [ERROR] [user1] trace: 1:/usr/share/z-push/lib/core/zlog.php:154 - Log->SetSpecialLogUsers()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 1:/usr/share/z-push/lib/core/zlog.php:154 - Log->SetSpecialLogUsers()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 2:/usr/share/z-push/lib/core/zlog.php:49 - ZLog::getLogger()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 2:/usr/share/z-push/lib/core/zlog.php:49 - ZLog::getLogger()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 3:/usr/share/z-push/index.php:47 - ZLog::Initialize()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 3:/usr/share/z-push/index.php:47 - ZLog::Initialize()
    22/03/2017 11:08:15 [21128] [FATAL] [user1] FatalMisconfigurationException: The WBXML log users is not an array. - code: 0 - file: /usr/share/z-push/lib/core/zpush.php:300
    22/03/2017 11:08:15 [21128] [FATAL] [user1] FatalMisconfigurationException: The WBXML log users is not an array. - code: 0 - file: /usr/share/z-push/lib/core/zpush.php:300
    22/03/2017 11:08:15 [21128] [FATAL] [user1] Exception: (FatalMisconfigurationException) - The WBXML log users is not an array.
    22/03/2017 11:08:15 [21128] [FATAL] [user1] Exception: (FatalMisconfigurationException) - The WBXML log users is not an array.
    22/03/2017 11:08:15  [ERROR] [user1] trace error: /usr/share/z-push/lib/log/log.php:231 Argument 1 passed to Log::SetSpecialLogUsers() must be of the type array, null given, called in /usr/share/z-push/lib/core/zlog.php on line 154 and defined (4096) - backtrace: 3 steps
    22/03/2017 11:08:15  [ERROR] [user1] trace error: /usr/share/z-push/lib/log/log.php:231 Argument 1 passed to Log::SetSpecialLogUsers() must be of the type array, null given, called in /usr/share/z-push/lib/core/zlog.php on line 154 and defined (4096) - backtrace: 3 steps
    22/03/2017 11:08:15  [ERROR] [user1] trace: 1:/usr/share/z-push/lib/core/zlog.php:154 - Log->SetSpecialLogUsers()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 1:/usr/share/z-push/lib/core/zlog.php:154 - Log->SetSpecialLogUsers()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 2:/usr/share/z-push/lib/core/zlog.php:49 - ZLog::getLogger()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 2:/usr/share/z-push/lib/core/zlog.php:49 - ZLog::getLogger()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 3:/usr/share/z-push/index.php:47 - ZLog::Initialize()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 3:/usr/share/z-push/index.php:47 - ZLog::Initialize()
    22/03/2017 11:08:15 [21130] [FATAL] [user1] FatalMisconfigurationException: The WBXML log users is not an array. - code: 0 - file: /usr/share/z-push/lib/core/zpush.php:300
    22/03/2017 11:08:15 [21130] [FATAL] [user1] FatalMisconfigurationException: The WBXML log users is not an array. - code: 0 - file: /usr/share/z-push/lib/core/zpush.php:300
    22/03/2017 11:08:15 [21130] [FATAL] [user1] Exception: (FatalMisconfigurationException) - The WBXML log users is not an array.
    22/03/2017 11:08:15 [21130] [FATAL] [user1] Exception: (FatalMisconfigurationException) - The WBXML log users is not an array.
    22/03/2017 11:08:15  [ERROR] [user1] trace error: /usr/share/z-push/lib/log/log.php:231 Argument 1 passed to Log::SetSpecialLogUsers() must be of the type array, null given, called in /usr/share/z-push/lib/core/zlog.php on line 154 and defined (4096) - backtrace: 3 steps
    22/03/2017 11:08:15  [ERROR] [user1] trace error: /usr/share/z-push/lib/log/log.php:231 Argument 1 passed to Log::SetSpecialLogUsers() must be of the type array, null given, called in /usr/share/z-push/lib/core/zlog.php on line 154 and defined (4096) - backtrace: 3 steps
    22/03/2017 11:08:15  [ERROR] [user1] trace: 1:/usr/share/z-push/lib/core/zlog.php:154 - Log->SetSpecialLogUsers()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 1:/usr/share/z-push/lib/core/zlog.php:154 - Log->SetSpecialLogUsers()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 2:/usr/share/z-push/lib/core/zlog.php:49 - ZLog::getLogger()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 2:/usr/share/z-push/lib/core/zlog.php:49 - ZLog::getLogger()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 3:/usr/share/z-push/index.php:47 - ZLog::Initialize()
    22/03/2017 11:08:15  [ERROR] [user1] trace: 3:/usr/share/z-push/index.php:47 - ZLog::Initialize()
    22/03/2017 11:08:15 [21129] [FATAL] [user1] FatalMisconfigurationException: The WBXML log users is not an array. - code: 0 - file: /usr/share/z-push/lib/core/zpush.php:300
    22/03/2017 11:08:15 [21129] [FATAL] [user1] FatalMisconfigurationException: The WBXML log users is not an array. - code: 0 - file: /usr/share/z-push/lib/core/zpush.php:300
    22/03/2017 11:08:15 [21129] [FATAL] [user1] Exception: (FatalMisconfigurationException) - The WBXML log users is not an array.
    22/03/2017 11:08:15 [21129] [FATAL] [user1] Exception: (FatalMisconfigurationException) - The WBXML log users is not an array.
    

    When I uninstall Z-Push from appcenter, and remove the etc/z-push, and usr/share/z-push folder, and reinstall them.
    Will this solve my issue, without that the users lost their data?


  • Kopano

    @goudduif regarding the error, could it be that you did not follow the advice in https://forum.kopano.io/topic/131/zpush-issue-after-zarafa-to-kopana-migration/4 ?

    When I uninstall Z-Push from appcenter, and remove the etc/z-push, and usr/share/z-push folder, and reinstall them.
    Will this solve my issue, without that the users lost their data?

    Thats hard to say with the information that you have provided. The worst “data loss” that you can have is that your mobile devices will resync once again, but if you have your mobile states in the default location and don’t delete them as well you should be fine.



  • @fbartels
    When I uninstall the z-push, I can also save remove the /usr/share/z-push folder?
    Before I reinstall it?


  • Kopano

    @goudduif that states are by default stored in /var/lib/z-push, if that was you question. /usr/share only contains replaceable program code.



  • fbartels
    I uninstall z-push, reboot the server, remove z-push folders, and reinstall z-push
    in the etc\z-push folder, I find the config.php. and the z-push.conf.php
    Which one is the right one, or are both files required?
    While when I review the log settings off the config.php,

    /**********************************************************************************
     *  Logging settings
     *  Possible LOGLEVEL and LOGUSERLEVEL values are:
     *  LOGLEVEL_OFF            - no logging
     *  LOGLEVEL_FATAL          - log only critical errors
     *  LOGLEVEL_ERROR          - logs events which might require corrective actions
     *  LOGLEVEL_WARN           - might lead to an error or require corrective actions in the future
     *  LOGLEVEL_INFO           - usually completed actions
     *  LOGLEVEL_DEBUG          - debugging information, typically only meaningful to developers
     *  LOGLEVEL_WBXML          - also prints the WBXML sent to/from the device
     *  LOGLEVEL_DEVICEID       - also prints the device id for every log entry
     *  LOGLEVEL_WBXMLSTACK     - also prints the contents of WBXML stack
     *
     *  The verbosity increases from top to bottom. More verbose levels include less verbose
     *  ones, e.g. setting to LOGLEVEL_DEBUG will also output LOGLEVEL_FATAL, LOGLEVEL_ERROR,
     *  LOGLEVEL_WARN and LOGLEVEL_INFO level entries.
     */
        define('LOGFILEDIR', '/var/log/z-push/');
        define('LOGFILE', LOGFILEDIR . 'z-push.log');
        define('LOGERRORFILE', LOGFILEDIR . 'z-push-error.log');
        define('LOGLEVEL', LOGLEVEL_INFO);
        define('LOGAUTHFAIL', false);
        //define('LOGLEVEL', LOGLEVEL_WBXML);
    
        // To save e.g. WBXML data only for selected users, add the usernames to the array
        // The data will be saved into a dedicated file per user in the LOGFILEDIR
        // Users have to be encapusulated in quotes, several users are comma separated, like:
         //  $specialLogUsers = array('info@domain.com', 'myusername');
        define('LOGUSERLEVEL', LOGLEVEL_DEVICEID);
       $specialLogUsers = array('user1', 'User2');
    

    I still didn’t find the user1, abd user2 log file in the log folder.


  • Kopano

    @goudduif when running ls -la /usr/share/z-push/config.php you see which config file is used by z-push.

    For me it is:

    # ls -la /usr/share/z-push/config.php                                                                                                                                               
    lrwxrwxrwx 1 root root 27 Mär  3 15:11 /usr/share/z-push/config.php -> /etc/z-push/z-push.conf.php
    


  • While there where still some issues.
    I remove z-push totally with " univention-remove z-push*"
    But now when I reinstall Z-push from the appcenter, there’s nothing in the \etc\z-push folder
    0_1490351935071_upload-d45e6ac1-bc54-4bf3-8fde-4f7f82e9937b

    How can I solve this issue?


  • Kopano

    @goudduif your screenshot does not show the univention appcenter. you should remove/reinstall z-push through the appcenter and not the package management.



  • That’s exactly what I did, I reinstall them from appcenter.
    But there I didn’t find anything on etc/z-push, I review what’s happens on Package management.



  • I retore the config file from Backup, so Z-Push works, but there still some issue’s

    There are different users, with two different devices.
    One off thensync all mails without a issue, the other one, didn’t receive any data, until she reboot their one-plus-one phone.
    After the reboot, it sync the mail, and calendar. (no Contac’s) only one time.
    even when I enable the WBXML logging, it didn’t show anything regarding this device.
    The strange issue is, that everything works fine till we upgrade from Zarafa to Kopano.
    Below you find the WBXML logging from the device that sync only after a reboot.
    the WBXML file didn’t show any data off this device till the user reboot their device.

    If you like it I can send you the WBXML file.


  • Kopano

    If there is nothing in the z-push log and also nothing in the webserver access & error logs then the device most probably isn’t connecting to the server.
    Did you also change the ssl configuration? Could it be that the mobile isn’t recognizing your (new) certificate?



  • 28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] -------- Start
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] cmd='Sync' devType='Android' devId='boxerc543471768' getUser='user1' from='10.0.0.96' version='2.3.5+4' method='POST'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] Used timezone 'Europe/Amsterdam'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ZPush::GetBackend(): trying autoload backend 'BackendKopano'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] BackendKopano using PHP-MAPI version: 8.1.1-10 - PHP version: 5.4.45-0.235.201611171529
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] Request::ProcessHeaders() ASVersion: 14.0
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ZPush::CommandNeedsProvisioning(0): true
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] FileStateMachine->GetState() read '3431' bytes from file: '/var/lib/z-push/8/6/boxerc543471768-devicedata'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ASDevice data loaded for user: 'user1'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] TopCollector(): Initialized mutexid Resource id #57 and memid Resource id #58.
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] LoopDetection(): Initialized mutexid Resource id #62 and memid Resource id #63.
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] LoopDetection initialised with IPC provider 'IpcSharedMemoryProvider' with type '1337'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ZPush::HierarchyCommand(0): false
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] DeviceManager->ProvisioningRequired('603050742') saved device key '603050742': false
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] DeviceManager->getPolicyName(): determined policy name: 'default'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] DeviceManager->getProvisioningPolicies(): loaded 'default' policy.
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ZPush::CommandNeedsAuthentication(0): true
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] KopanoBackend->Logon(): Trying to authenticate user 'user1'..
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] KopanoBackend->openMessageStore('user1'): Found 'DEFAULT' store: 'Resource id #78'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] KopanoBackend->Logon(): User 'user1' is authenticated
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] Store supports properties containing Unicode characters.
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ZPush::CommandNeedsPlainInput(0): false
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I  <Synchronize>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I   <Folders>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I    <Folder>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     <SyncKey>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I      {1a66cdee-6888-49e0-a6f3-cf1dbdc512f5}8
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     </SyncKey>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     <FolderId>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I      Udd5bb
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     </FolderId>
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] FileStateMachine->GetState() read '945' bytes from file: '/var/lib/z-push/8/6/boxerc543471768-1a66cdee-6888-49e0-a6f3-cf1dbdc512f5-fd'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] SyncParameters->UseCPO('DEFAULT')
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] DeviceManager->GetBackendIdForFolderId(): folderid Udd5bb => c8b30938bf774f6897130e721f8d3ed6590000000000
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] SyncCollections->AddCollection(): Folder id 'Udd5bb' : ref. PolicyKey '603050742', ref. Lifetime '', last sync at '1490724488'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] SyncCollections->AddCollection(): Updated reference PolicyKey '603050742', reference Lifetime '', Last sync at '1490724488'
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     <DeletesAsMoves/>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     <GetChanges/>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     <WindowSize>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I      10
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     </WindowSize>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     <Options>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I      <FilterType>
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] SyncParameters->UseCPO('DEFAULT')
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I       4
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I      </FilterType>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I      <AirSyncBase:BodyPreference>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I       <AirSyncBase:Type>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I        1
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I       </AirSyncBase:Type>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I       <AirSyncBase:TruncationSize>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I        200000
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I       </AirSyncBase:TruncationSize>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I      </AirSyncBase:BodyPreference>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I     </Options>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I    </Folder>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I   </Folders>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] I  </Synchronize>
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] HandleSync(): Start Output
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ZPush::GetAdditionalSyncFolderStore('c8b30938bf774f6897130e721f8d3ed6590000000000'): 'false'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] KopanoBackend->GetFolderStat() fetched status information of 40 folders for store 'user1'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] SyncParameters->IsExporterRunRequired(): true - current: 1459353174/114/0/4 - saved: false - expiring: not set
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] Sync->loadStates(): loading states for folder 'Udd5bb'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] FileStateMachine->CleanStates(): Deleting file: '/var/lib/z-push/8/6/boxerc543471768-1a66cdee-6888-49e0-a6f3-cf1dbdc512f5-7'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] FileStateMachine->GetState() read '231' bytes from file: '/var/lib/z-push/8/6/boxerc543471768-1a66cdee-6888-49e0-a6f3-cf1dbdc512f5-8'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ZPush::GetAdditionalSyncFolderStore('c8b30938bf774f6897130e721f8d3ed6590000000000'): 'false'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ZPush::GetAdditionalSyncFolderStore('c8b30938bf774f6897130e721f8d3ed6590000000000'): 'false'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ExportChangesICS->Config(): synching inital data
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ExportChangesICS->Config() initialized with state: 0x943500000000000007000000fc4c030016000000c8b30938bf774f6897130e721f8d3ed6023801000000d350030016000000c8b30938bf774f6897130e721f8d3ed6cd3901000000d450030016000000c8b30938bf774f6897130e721f8d3ed6ce39010000001f66030016000000c8b30938bf774f6897130e721f8d3ed69c3d010000002066030016000000c8b30938bf774f6897130e721f8d3ed69d3d010000007f6a030016000000c8b30938bf774f6897130e721f8d3ed6514001000000806a030016000000c8b30938bf774f6897130e721f8d3ed6524001000000
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ExportChangesICS->InitializeExporter() successfully. 2 changes ready to sync for 'c8b30938bf774f6897130e721f8d3ed6590000000000'.
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] LoopDetection->ProcessLoopDetectionAddStatus: 'Udd5bb' with status 1
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] Folder type: Calendar
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O  <Synchronize>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O   <Folders>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O    <Folder>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     <SyncKey>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     {1a66cdee-6888-49e0-a6f3-cf1dbdc512f5}9
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     </SyncKey>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     <FolderId>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     Udd5bb
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     </FolderId>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     <Status>
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     1
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     </Status>
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] LoopDetection->Detect(): folderid:'Udd5bb' uuid:'1a66cdee-6888-49e0-a6f3-cf1dbdc512f5' counter:'8' max:'10' queued:'2'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] LoopDetection->Detect(): case 1.2 detected
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] LoopDetection->Detect(): case 1.2.1 detected
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] LoopDetection->Detect(): loop data: loopcount(1), maxCount(10), queued(2), ignored(false)
    28/03/2017 20:08:08 [21368] [WARN] [user1] [boxerc543471768] Mobile loop detected! Messages sent to the mobile will be restricted to 1 items in order to identify the conflict
    28/03/2017 20:08:08 [21368] [WBXML] [user1] [boxerc543471768] O     <MoreAvailable/>
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] PHPWrapper->ImportMessageChange(): Getting message from MAPIProvider, sourcekey: 'c8b30938bf774f6897130e721f8d3ed6363501000000', parentsourcekey: 'c8b30938bf774f6897130e721f8d3ed6590000000000', entryid: '000000005a5734edde3d428fb3a1251b1f41c7120100000005000000b6cd09a7a3d9402e92ae6bebd203c5a700000000'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] ZPush::GetAdditionalSyncFolderStore('c8b30938bf774f6897130e721f8d3ed6590000000000'): 'false'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] BodyPreference types: 1
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] GetBodyPreferenceBestMatch: 1
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] bpo: truncation size:'200000', allornone:'0', preview:'0'
    28/03/2017 20:08:08 [21368] [DEBUG] [user1] [boxerc543471768] MAPIStreamWrapper::stream_open(): initialized mapistream:  streamlength: 0
    28/03/2017 20:08:09 [21368] [DEBUG] [user1] [boxerc543471768] TimezoneUtil::FillTZNames() filling up bias -60
    28/03/2017 20:08:09 [21368] [DEBUG] [user1] [boxerc543471768] MAPIProvider->GetStoreProps(): Getting store properties.
    28/03/2017 20:08:09 [21368] [DEBUG] [user1] [boxerc543471768] LoopDetection->IgnoreNextMessage(): Loop mode, potential broken message id 'Udd5bb:c8b30938bf774f6897130e721f8d3ed6363501000000'
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O     <Perform>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O      <Add>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O       <ServerEntryId>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O       Udd5bb:c8b30938bf774f6897130e721f8d3ed6363501000000
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O       </ServerEntryId>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O       <Data>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:Timezone>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        xP///ygARwBNAFQAKwAwADEAOgAwADAAKQAgAEIAZQBsAGcAcgBhAGQAZQAsACAAQgByAGEAdABpAHMAbABhAHYAYQAAAAEAAAABAAMAAAAAAAAAAAAAACgARwBNAFQAKwAwADEAOgAwADAAKQAgAEIAZQBsAGcAcgBhAGQAZQAsACAAQgByAGEAdABpAHMAbABhAHYAYQAAAAAAAAAAAAAAAAAAAAAAAAAAAA==
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:Timezone>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:DtStamp>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        20170228T200033Z
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:DtStamp>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:StartTime>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        20170509T173000Z
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:StartTime>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:Subject>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        shopping
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:Subject>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:UID>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        76E3FD9EED9446BAB899C975763E450A0
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:UID>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:OrganizerName>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        user2 morris
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:OrganizerName>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:OrganizerEmail>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        user2@domain.org
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:OrganizerEmail>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:EndTime>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        20170509T183000Z
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:EndTime>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:Sensitivity>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        0
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:Sensitivity>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:BusyStatus>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        1
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:BusyStatus>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:AllDayEvent>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        0
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:AllDayEvent>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:MeetingStatus>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        3
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:MeetingStatus>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:Attendees>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         <POOMCAL:Attendee>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Email>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          user7dune@business.org
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Email>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Name>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          user7dune@business.org
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Name>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Attendee_Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          1
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Attendee_Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         </POOMCAL:Attendee>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         <POOMCAL:Attendee>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Email>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          user5@domain.org
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Email>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Name>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          user5 morris
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Name>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Attendee_Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          1
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Attendee_Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         </POOMCAL:Attendee>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         <POOMCAL:Attendee>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Email>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          user1@domain.org
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Email>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Name>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          user1 morris
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Name>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Attendee_Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          1
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Attendee_Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         </POOMCAL:Attendee>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         <POOMCAL:Attendee>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Email>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          user4@domain.org
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Email>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Name>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          user4 morris
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Name>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          <POOMCAL:Attendee_Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          1
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O          </POOMCAL:Attendee_Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         </POOMCAL:Attendee>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:Attendees>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <AirSyncBase:Body>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         <AirSyncBase:Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         1
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         </AirSyncBase:Type>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         <AirSyncBase:EstimatedDataSize>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         0
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         </AirSyncBase:EstimatedDataSize>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         <AirSyncBase:Data>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         <<< written 0 of 0 bytes of plain data >>>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O         </AirSyncBase:Data>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </AirSyncBase:Body>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <AirSyncBase:NativeBodyType>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        1
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </AirSyncBase:NativeBodyType>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        <POOMCAL:ResponseType>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        5
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O        </POOMCAL:ResponseType>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O       </Data>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O      </Add>
    28/03/2017 20:08:09 [21368] [DEBUG] [user1] [boxerc543471768] PHPWrapper->ImportMessageChange(): change for: 'Udd5bb:c8b30938bf774f6897130e721f8d3ed6363501000000'
    28/03/2017 20:08:09 [21368] [DEBUG] [user1] [boxerc543471768] HandleSync(): Exported maxItems of messages: 1 / 2
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O     </Perform>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O    </Folder>
    
    
    28/03/2017 20:08:09 [21368] [DEBUG] [user1] [boxerc543471768] FileStateMachine->SetState() written 945 bytes on file: '/var/lib/z-push/8/6/boxerc543471768-1a66cdee-6888-49e0-a6f3-cf1dbdc512f5-fd'
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O   </Folders>
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] O  </Synchronize>
    28/03/2017 20:08:09 [21368] [DEBUG] [user1] [boxerc543471768] WBXMLEncoder->endTag() WBXML output completed
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] WBXML-OUT: AwFqAEVcT0sDezFhNjZjZGVlLTY4ODgtNDllMC1hNmYzLWNmMWRiZGM1MTJmNX05AAFSA1VkZDViYgABTgMxAAEUVkdNA1VkZDViYjpjOGIzMDkzOGJmNzc0ZjY4OTcxMzBlNzIxZjhkM2VkNjM2MzUwMTAwMDAwMAABXQAERQN4UC8vL3lnQVJ3Qk5BRlFBS3dBd0FERUFPZ0F3QURBQUtRQWdBRUlBWlFCc0FHY0FjZ0JoQUdRQVpRQXNBQ0FBUWdCeUFHRUFkQUJwQUhNQWJBQmhBSFlBWVFBQUFBRUFBQUFCQUFNQUFBQUFBQUFBQUFBQUFDZ0FSd0JOQUZRQUt3QXdBREVBT2dBd0FEQUFLUUFnQUVJQVpRQnNBR2NBY2dCaEFHUUFaUUFzQUNBQVFnQnlBR0VBZEFCcEFITUFiQUJoQUhZQVlRQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQUFBQT09AAFRAzIwMTcwMjI4VDIwMDAzM1oAAWcDMjAxNzA1MDlUMTczMDAwWgABZgNLbmlwcGVuAAFoAzc2RTNGRDlFRUQ5NDQ2QkFCODk5Qzk3NTc2M0U0NTBBMAABWgNXaW0gR3VpanQAAVkDd2ltQHdncGMubmwAAVIDMjAxNzA1MDlUMTgzMDAwWgABZQMwAAFNAzEAAUYDMAABWAMzAAFHSEkDbGVvbmlldmFuZHVpam5AbGl2ZS5ubAABSgNsZW9uaWV2YW5kdWlqbkBsaXZlLm5sAAFqAzEAAQFISQNjb3JuZUB3Z3BjLm5sAAFKA0Nvcm5lIEd1aWp0AAFqAzEAAQFISQNsZXVudGplQHdncGMubmwAAUoDTGV1bnRqZSBHdWlqdAABagMxAAEBSEkDYXJpZUB3Z3BjLm5sAAFKA0FyaWUgR3VpanQAAWoDMQABAQEAEUpGAzEAAUwDMAABSwMAAQFWAzEAAQAEdgM1AAEBAQEBAQE=
    28/03/2017 20:08:09 [21368] [WBXML] [user1] [boxerc543471768] WBXML-IN : AwFqAEVcT0sDezFhNjZjZGVlLTY4ODgtNDllMC1hNmYzLWNmMWRiZGM1MTJmNX04AAFSA1VkZDViYgABHhNVAzEwAAFXWAM0AAEAEUVGAzEAAUcDMjAwMDAwAAEBAQEBAQ==
    28/03/2017 20:08:09 [21368] [DEBUG] [user1] [boxerc543471768] LoopDetection->ProcessLoopDetectionTerminate()
    28/03/2017 20:08:09 [21368] [ INFO] [user1] [boxerc543471768] cmd='Sync' memory='6.90 MiB/7.25 MiB' time='0.75s' devType='Android' devId='boxerc543471768' getUser='user1' from='10.0.0.96' version='2.3.5+4' method='POST' httpcode='200'
    28/03/2017 20:08:09 [21368] [DEBUG] [user1] [boxerc543471768] -------- End
    

    How can I solve this issue?



  • The other device, of this user, show me also the following!

      Folder: Calendar             Sync: Synchronizing Status:  6% (7/114)
    Additional Folders:     none
    Status:                 OK
    WipeRequest on:         not set
    WipeRequest by:         not set
    Wiped on:               not set
    Policy name:            default
    Attention needed:       4 messages need attention because they could not be synchronized
            Broken object:  'SyncMail' ignored on '2017-03-28 05:14'
            Information:    Subject: 'Userday' - From: '"user2 Morris" <user2@domain.org>'
            Reason:         Message was causing loop (2)
            Item/Parent id: U16cff:c8b30938bf774f6897130e721f8d3ed6da3a01000000/U16cff
    
            Broken object:  'SyncMail' ignored on '2017-03-28 19:27'
            Information:    Subject: 'shopping' - From: '"user2 Morris" <user2@domain.org>'
            Reason:         Message was causing loop (2)
            Item/Parent id: U16cff:c8b30938bf774f6897130e721f8d3ed6373501000000/U16cff
    
            Broken object:  'SyncAppointment' ignored on '2017-03-28 20:46'
            Information:    Subject: 'shopping' - On: '2017-05-09 19:30'
            Reason:         Message was causing loop (2)
            Item/Parent id: Udd5bb:c8b30938bf774f6897130e721f8d3ed6363501000000/Udd5bb
    
            Broken object:  'SyncAppointment' ignored on '2017-03-28 20:46'
            Information:    Subject: 'shopping' - On: '2017-04-05 19:30'
            Reason:         Message was causing loop (2)
            Item/Parent id: Udd5bb:c8b30938bf774f6897130e721f8d3ed62a3501000000/Udd5bb
    

    I’ve already resync the users devices, run a clearloop, , and a fixstatus.
    I’m afraid that this is the reason why the contacts are not synced.Synchronization progress:


Log in to reply
 

Looks like your connection to Kopano Community Forum was lost, please wait while we try to reconnect.