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

    ZPush Issue after zarafa to Kopana migration

    Z-Push when using Kopano
    3
    21
    7006
    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.
    • goudduif
      goudduif @fbartels last edited by

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

      fbartels 1 Reply Last reply Reply Quote 0
      • fbartels
        fbartels Kopano @goudduif last edited by

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

        Regards Felix

        Resources:
        https://kopano.com/blog/how-to-get-kopano/
        https://documentation.kopano.io/
        https://kb.kopano.io/

        Support overview:
        https://kopano.com/support/

        1 Reply Last reply Reply Quote 0
        • goudduif
          goudduif last edited by fbartels

          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.

          fbartels 1 Reply Last reply Reply Quote 0
          • fbartels
            fbartels Kopano @goudduif last edited by

            @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
            

            Regards Felix

            Resources:
            https://kopano.com/blog/how-to-get-kopano/
            https://documentation.kopano.io/
            https://kb.kopano.io/

            Support overview:
            https://kopano.com/support/

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

              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?

              fbartels 1 Reply Last reply Reply Quote 0
              • fbartels
                fbartels Kopano @goudduif last edited by fbartels

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

                Regards Felix

                Resources:
                https://kopano.com/blog/how-to-get-kopano/
                https://documentation.kopano.io/
                https://kb.kopano.io/

                Support overview:
                https://kopano.com/support/

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

                  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.

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

                    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.

                    1 Reply Last reply Reply Quote 0
                    • Sebastian
                      Sebastian Kopano last edited by

                      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?

                      1 Reply Last reply Reply Quote 0
                      • goudduif
                        goudduif last edited by fbartels

                        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?

                        1 Reply Last reply Reply Quote 0
                        • goudduif
                          goudduif last edited by fbartels

                          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:

                          1 Reply Last reply Reply Quote 0
                          • Sebastian
                            Sebastian Kopano last edited by

                            The loop detection is somewhat normal, depending on the circumstances. It could be that some appointments or contacts are also broken. Detailed information about how it works is available here: https://wiki.z-hub.io/display/ZP/Loop+detection

                            You could run clearloop with z-push-admin but depending on the issues z-push finds it will just start loop detection again.

                            Can you run kopano-fsck on these stores?

                            Cheers,
                            Sebastian

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