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

    IOS Devices dont getting synced anymore since z-push/kopano Update

    Z-Push when using Kopano
    6
    31
    4581
    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.
    • Manfred
      Manfred Kopano last edited by

      Hi Stefan,

      Were you switching between sql states and file states?

      The Kopano version in the z-push.log is different from what you posted here. Are you using KC nightly builds?
      Are there any errors in server.log of kopano?

      As first action I suggest to start with a clean Z-Push installation and configuration, remove all the states, execute clearloops with z-push-admin, remove profile from the device and create a profile again.

      If the above doesn’t help, try downgrading KC to 8.5.5.0.

      Manfred

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

        Hello Manfred

        for testing purpose i switched to sql states one time. Without Success. Problem still exists.
        I reinstalled z-pusg acouple of Times new wihtout Success.
        I try it again to reinstall it and coming back here with my findings.

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

          Hello!

          I run into same problem after updating kopanocore to latest master from repository and z-push from 2.3.9 to 2.4.0.
          I am running a gentoo server and I’m compiling from source.

          First I tried downgrading z-push to 2.3.9 first but that didn’t help.
          After switiching kopanocore from master to 8.6.x branch it was working again.
          I switched to z-push 2.4.0 again afterwards - also without any issues.

          I haven’t checked which commit caused that problem, because I hadn’t time anymore…

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

            How can i downgrade ?
            Where can i find the 8.6.x Branch ?
            I am on Kopano 8.6.80.3 an having the Problem

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

              Hi Stefan,

              for the best practice for the downgrade you should ask Kopano Support. If you don’t have a Kopano subscription, try asking in the core subforum. There’s also a thread regarding Kopano rollback: https://forum.kopano.io/topic/327/kopano-core-rollback

              Manfred

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

                Cannot download kopano core-8.4.90 for ubuntu 16.04 x64 anymore. This was my last Working Version. :(

                1 Reply Last reply Reply Quote 0
                • onex.de
                  onex.de last edited by onex.de

                  It seems, I have the same problem on my Google Pixel 2 on latest Kopano for UCS (Univention)
                  WebApp: 3.4.9.1330+53.1
                  Kopano Core: 8.5.5
                  Z-Push: 2.4.0+0-0

                  I deleted the account on my mobil and deleted all related account data with z-push-admin, then I recreated the account on my mobile, it begun syncing and after several /usr/share/z-push/backend/kopano/mapiprovider.php:997 Undefined offset errors and some loop messages, z-push reportet the sync to be finished and my mobile still tries to sync all unsynced data without any new connection to the server.

                  Addendum: I did my fifth account recreation on my mobile and this time I didn’t activate downloading attachments via WLAN (wifi) and now it seemed to finally sync, but with a lot of the errors and warnings, mentioned above.

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

                    Hello

                    I Reinstalled z-Push 2.4 from The Repo (no tarball) fresh without success. Also the downgrade to kopano 8.5.5 didnt resvolve the issue.

                    Br Stefan

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

                      Hi Stefan,

                      is it still the same problem that the sync won’t complete? Can you post z-push-admin output for that device and user?

                      Manfred

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

                        Hello Manfred

                        here we go:

                        Synchronized devices of user: usera
                        -----------------------------------------------------
                        DeviceId:               xxxx
                        Device type:            iPhone
                        UserAgent:              Apple-iPhone9C4/1504.100
                        Device Model:           iPhone9C4
                        Device friendly name:   iPhone 7 Plus
                        Device OS:              iOS 11.2.6 15D100
                        Device OS Language:     de-DE
                        ActiveSync version:     14.1
                        First sync:             2018-03-23 07:21
                        Last sync:              2018-03-23 15:38
                        Sync Period:            unlimited (0)
                        Total folders:          26
                        Short folder Ids:       Yes
                        Synchronized folders:   6 (2 in progress)
                        Synchronized data:      Emails(2) Contacts Calendars Notes Tasks
                        Synchronization progress:
                                Folder: Inbox                Sync: Synchronizing Status:  1% (559/40955)
                                Folder: Sent Items           Sync: Synchronizing Status:  3% (59/2068)
                        Additional Folders:     none
                        Status:                 OK
                        WipeRequest on:         not set
                        WipeRequest by:         not set
                        Wiped on:               not set
                        Policy name:            default
                        Attention needed:       No errors known
                        

                        No Success. Stucks since Hours… (Status)

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

                          Hi Stefan,

                          there are 40k emails in your inbox. Have you tried synchronising a shorter period of time? Are there any errors in z-push.log or server.log of kopano? Do you have another device to try to sync?

                          Manfred

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

                            Hi!

                            I have the same problem with upgrade 8.6, I deleted all devices and sync again, the result:

                            z-push-error.log:

                            29/04/2018 12:12:02 [12054] [FATAL] [ablanco] Exception: (ProvisioningRequiredException) - Retry after sending a PROVISION command
                            29/04/2018 12:13:07 [21942] [FATAL] [ablanco] Exception: (ProvisioningRequiredException) - Retry after sending a PROVISION command
                            

                            z-push-admin:

                            Synchronized devices of user: USER
                            ---------------------------------------------------
                            DeviceId:               XXXXX
                            Device type:            iPad
                            UserAgent:              Apple-iPad4C2/1505.302
                            Device Model:           iPad4C2
                            Device friendly name:   iPad Air
                            Device OS:              iOS 11.3.1 15E302
                            Device OS Language:     es
                            ActiveSync version:     14.1
                            First sync:             2018-04-29 12:12
                            Last sync:              2018-04-29 12:12
                            Sync Period:            unlimited (0)
                            Total folders:          0
                            Short folder Ids:       No
                            Synchronized folders:   0
                            Synchronized data:      None available
                            Additional Folders:     none
                            Status:                 OK
                            WipeRequest on:         not set
                            WipeRequest by:         not set
                            Wiped on:               not set
                            Policy name:            default
                            Attention needed:       No errors known
                            -----------------------------------------------------
                            DeviceId:               XXXXXX
                            Device type:            iPhone
                            UserAgent:              Apple-iPhone9C3/1505.302
                            Device Model:           iPhone9C3
                            Device friendly name:   Negro iPhone 7
                            Device OS:              iOS 11.3.1 15E302
                            Device OS Language:     es-ES
                            ActiveSync version:     14.1
                            First sync:             2018-04-29 12:13
                            Last sync:              2018-04-29 12:13
                            Sync Period:            unlimited (0)
                            Total folders:          0
                            Short folder Ids:       No
                            Synchronized folders:   0
                            Synchronized data:      None available
                            Additional Folders:     none
                            Status:                 OK
                            WipeRequest on:         not set
                            WipeRequest by:         not set
                            Wiped on:               not set
                            Policy name:            default
                            Attention needed:       No errors known
                            

                            Thanks! :)

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

                              Hi ablanco,

                              how do you deleted all devices? With z-push-admin?

                              Please also post z-push.log at least at DEBUG level.

                              Have you tried removing the account on the device and adding it again?

                              Manfred

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

                                This post is deleted!
                                ablanco 1 Reply Last reply Reply Quote 0
                                • ablanco
                                  ablanco @ablanco last edited by ablanco

                                  Hi Manfred,

                                  Yes I delete all devices with z-push-admin and remove the account on all devices.

                                  The log at the same moment:

                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] -------- Start
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] cmd='FolderSync' devType='iPad' devId='XXXX' getUser='ablanco' from='77.228.72.112' version='2.4.1.beta1+3-                                                                        0' method='POST'
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] Used timezone 'Europe/Madrid'
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] ZPush::GetBackend(): trying autoload backend 'BackendKopano'
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] BackendKopano using PHP-MAPI version: 8.6.80 - PHP version: 5.5.9-1ubuntu4.24
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] Request::ProcessHeaders() ASVersion: 14.1
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] ZPush::CommandNeedsProvisioning(9): true
                                  29/04/2018 12:12:02 [12054] [ INFO] [ablanco] StateNotFoundException: FileStateMachine->GetStateHash(): Could not locate state '/var/lib/z-push/g/y/appldmplk0dbf4yg-                                                                        devicedata' - code: 0 - file: /usr/share/z-push/lib/default/filestatemachine.php:93
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] TopCollector(): Initialized mutexid Resource id #58 and memid Resource id #59.
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] LoopDetection(): Initialized mutexid Resource id #63 and memid Resource id #64.
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] LoopDetection initialised with IPC provider 'IpcSharedMemoryProvider' with type '1337'
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] ZPush::HierarchyCommand(9): true
                                  29/04/2018 12:12:02 [12054] [ INFO] [ablanco] StateNotFoundException: FileStateMachine->GetStateHash(): Could not locate state '/var/lib/z-push/g/y/appldmplk0dbf4yg-                                                                        devicedata' - code: 0 - file: /usr/share/z-push/lib/default/filestatemachine.php:93
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] DeviceManager->ProvisioningRequired('789513718') saved device key '-1': true
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] DeviceManager->getPolicyName(): determined policy name: 'default'
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] DeviceManager->getProvisioningPolicies(): loaded 'default' policy.
                                  29/04/2018 12:12:02 [12054] [ INFO] [ablanco] ProvisioningRequiredException: Retry after sending a PROVISION command - code: 0 - file: /usr/share/z-push/index.php:82
                                  29/04/2018 12:12:02 [12054] [ INFO] [ablanco] User-agent: 'Apple-iPad4C2/1505.302'
                                  29/04/2018 12:12:02 [12054] [FATAL] [ablanco] Exception: (ProvisioningRequiredException) - Retry after sending a PROVISION command
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] DeviceManager->Save(): Device data changed
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] LoopDetection->ProcessLoopDetectionTerminate()
                                  29/04/2018 12:12:02 [12054] [ INFO] [ablanco] cmd='FolderSync' memory='4.91 MiB/5.25 MiB' time='0.04s' devType='iPad' devId='XXX' getUser='ablanco' from                                                                        ='77.228.72.112' idle='0s' version='2.4.1.beta1+3-0' method='POST' httpcode='449'
                                  29/04/2018 12:12:02 [12054] [DEBUG] [ablanco] -------- End
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] -------- Start
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] cmd='Provision' devType='iPad' devId='XXXX' getUser='ablanco' from='77.228.72.112' version='2.4.1.beta1+3-0                                                                        ' method='POST'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] Used timezone 'Europe/Madrid'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] ZPush::GetBackend(): trying autoload backend 'BackendKopano'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] BackendKopano using PHP-MAPI version: 8.6.80 - PHP version: 5.5.9-1ubuntu4.24
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] Request::ProcessHeaders() ASVersion: 14.1
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] ZPush::CommandNeedsProvisioning(20): false
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] ZPush::CommandNeedsAuthentication(20): false
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] FileStateMachine->GetState() read '862' bytes from file: '/var/lib/z-push/g/y/appldmplk0dbf4yg-devicedata'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] ASDevice data loaded for user: 'ablanco'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] TopCollector(): Initialized mutexid Resource id #58 and memid Resource id #59.
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] LoopDetection(): Initialized mutexid Resource id #63 and memid Resource id #64.
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] LoopDetection initialised with IPC provider 'IpcSharedMemoryProvider' with type '1337'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] ZPush::HierarchyCommand(20): false
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] ZPush::CommandNeedsPlainInput(20): false
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] RequestProcessor::HandleProvision(): Forcing delayed Authentication
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] KopanoBackend->Logon(): Trying to authenticate user 'ablanco'..
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] KopanoBackend->openMessageStore('ablanco'): Found 'DEFAULT' store: 'Resource id #78'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] KopanoBackend->Logon(): User 'ablanco' is authenticated
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] Store supports properties containing Unicode characters.
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I  <Provision:Provision>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I   <Provision:Policies>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I    <Provision:Policy>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I     <Provision:PolicyType>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I      MS-EAS-Provisioning-WBXML
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I     </Provision:PolicyType>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I     <Provision:PolicyKey>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I      195388125
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I     </Provision:PolicyKey>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I     <Provision:Status>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I      1
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I     </Provision:Status>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I    </Provision:Policy>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I   </Provision:Policies>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] I  </Provision:Provision>
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] DeviceManager->SetPolicyKey('713581845')
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O  <Provision:Provision>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O   <Provision:Status>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O   1
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O   </Provision:Status>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O   <Provision:Policies>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O    <Provision:Policy>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O     <Provision:PolicyType>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O     MS-EAS-Provisioning-WBXML
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O     </Provision:PolicyType>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O     <Provision:Status>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O     1
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O     </Provision:Status>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O     <Provision:PolicyKey>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O     713581845
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O     </Provision:PolicyKey>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O    </Provision:Policy>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O   </Provision:Policies>
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] O  </Provision:Provision>
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] WBXMLEncoder->endTag() WBXML output completed
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] WBXML-OUT: AwFqAAAORUsDMQABRkdIA01TLUVBUy1Qcm92aXNpb25pbmctV0JYTUwAAUsDMQABSQM3MTM1ODE4NDUAAQEBAQ==
                                  29/04/2018 12:12:08 [20278] [WBXML] [ablanco] WBXML-IN : AwFqAAAORUZHSANNUy1FQVMtUHJvdmlzaW9uaW5nLVdCWE1MAAFJAzE5NTM4ODEyNQABSwMxAAEBAQE=
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] DeviceManager->Save(): Device data changed
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] FileStateMachine->SetState() written 912 bytes on file: '/var/lib/z-push/g/y/appldmplk0dbf4yg-devicedata'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] DeviceManager->Save(): Device data saved
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] LoopDetection->ProcessLoopDetectionTerminate()
                                  29/04/2018 12:12:08 [20278] [ INFO] [ablanco] cmd='Provision' memory='5.15 MiB/5.50 MiB' time='0.05s' devType='iPad' devId='XXXX' getUser='ablanco' from=                                                                        '77.228.72.112' idle='0s' version='2.4.1.beta1+3-0' method='POST' httpcode='200'
                                  29/04/2018 12:12:08 [20278] [DEBUG] [ablanco] -------- End
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] -------- Start
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] cmd='FolderSync' devType='iPad' devId='XXX' getUser='ablanco' from='77.228.72.112' version='2.4.1.beta1+3-                                                                        0' method='POST'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] Used timezone 'Europe/Madrid'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] ZPush::GetBackend(): trying autoload backend 'BackendKopano'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] BackendKopano using PHP-MAPI version: 8.6.80 - PHP version: 5.5.9-1ubuntu4.24
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] Request::ProcessHeaders() ASVersion: 14.1
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] ZPush::CommandNeedsProvisioning(9): true
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] FileStateMachine->GetState() read '912' bytes from file: '/var/lib/z-push/g/y/appldmplk0dbf4yg-devicedata'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] ASDevice data loaded for user: 'ablanco'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] TopCollector(): Initialized mutexid Resource id #57 and memid Resource id #58.
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] LoopDetection(): Initialized mutexid Resource id #62 and memid Resource id #63.
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] LoopDetection initialised with IPC provider 'IpcSharedMemoryProvider' with type '1337'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] ZPush::HierarchyCommand(9): true
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] DeviceManager->ProvisioningRequired('713581845') saved device key '713581845': false
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] DeviceManager->getPolicyName(): determined policy name: 'default'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] DeviceManager->getProvisioningPolicies(): loaded 'default' policy.
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] ZPush::CommandNeedsAuthentication(9): true
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] KopanoBackend->Logon(): Trying to authenticate user 'ablanco'..
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] KopanoBackend->openMessageStore('ablanco'): Found 'DEFAULT' store: 'Resource id #78'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] KopanoBackend->Logon(): User 'ablanco' is authenticated
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] Store supports properties containing Unicode characters.
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] ZPush::CommandNeedsPlainInput(9): false
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] I  <FolderHierarchy:FolderSync>
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] I   <FolderHierarchy:SyncKey>
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] I    {ef18fb64-7ad4-4179-b73f-8b44d40d2421}2
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] I   </FolderHierarchy:SyncKey>
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] StateManager->loadHierarchyCache(): 'appldmplk0dbf4yg-ef18fb64-7ad4-4179-b73f-8b44d40d2421-hc-2'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] StateManager::UnLinkState(''): saved state 'ef18fb64-7ad4-4179-b73f-8b44d40d2421' will be deleted.
                                  29/04/2018 12:12:10 [15510] [ INFO] [ablanco] StateNotFoundException: No hierarchy UUID linked to device. Requesting folder resync. - code: 0 - file: /usr/share/z-pu                                                                        sh/lib/core/statemanager.php:486
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] ASDevice->GetHierarchyCache(): HierarchyCache is up - Cached objects: 0
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] I  </FolderHierarchy:FolderSync>
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] LoopDetection->ProcessLoopDetectionAddStatus: 'hierarchy' with status 9
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] O  <FolderHierarchy:FolderSync>
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] O   <FolderHierarchy:Status>
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] O   9
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] O   </FolderHierarchy:Status>
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] O  </FolderHierarchy:FolderSync>
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] WBXMLEncoder->endTag() WBXML output completed
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] WBXML-OUT: AwFqAAAHVkwDOQABAQ==
                                  29/04/2018 12:12:10 [15510] [WBXML] [ablanco] WBXML-IN : AwFqAAAHVlIDe2VmMThmYjY0LTdhZDQtNDE3OS1iNzNmLThiNDRkNDBkMjQyMX0yAAEB
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] LoopDetection->ProcessLoopDetectionTerminate()
                                  29/04/2018 12:12:10 [15510] [ INFO] [ablanco] cmd='FolderSync' memory='5.82 MiB/6.25 MiB' time='0.06s' devType='iPad' devId='XXXX' getUser='ablanco' from='77.228.72.112' idle='0s' version='2.4.1.beta1+3-0' method='POST' httpcode='200'
                                  29/04/2018 12:12:10 [15510] [DEBUG] [ablanco] -------- End
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] -------- Start
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] cmd='' devType='' devId='' getUser='ablanco' from='77.228.72.112' version='2.4.1.beta1+3-0' method='OPTIONS'
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] Used timezone 'Europe/Madrid'
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] ZPush::GetBackend(): trying autoload backend 'BackendKopano'
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] BackendKopano using PHP-MAPI version: 8.6.80 - PHP version: 5.5.9-1ubuntu4.24
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] Request::ProcessHeaders() ASVersion: 14.1
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] KopanoBackend->Logon(): Trying to authenticate user 'ablanco'..
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] KopanoBackend->openMessageStore('ablanco'): Found 'DEFAULT' store: 'Resource id #49'
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] KopanoBackend->Logon(): User 'ablanco' is authenticated
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] Store supports properties containing Unicode characters.
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] NoPostRequestException: Options request - code: 1 - file: /usr/share/z-push/index.php:66
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] ZPush::GetSupportedProtocolVersions(): 12.0,12.1,14.0,14.1
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] ZPush::GetSupportedCommands(): Sync,SendMail,SmartForward,SmartReply,GetAttachment,GetHierarchy,CreateCollection,Delete                                                                        Collection,MoveCollection,FolderSync,FolderCreate,FolderDelete,FolderUpdate,MoveItems,GetItemEstimate,MeetingResponse,ResolveRecipients,ValidateCert,Provision,Search                                                                        ,Ping,Notify,ItemOperations,Settings
                                  29/04/2018 12:13:08 [23261] [ INFO] [ablanco] Options request
                                  29/04/2018 12:13:08 [23261] [ INFO] [ablanco] cmd='' memory='3.58 MiB/4.25 MiB' time='0.05s' devType='' devId='' getUser='ablanco' from='77.228.72.112' idle='0s' ver                                                                        sion='2.4.1.beta1+3-0' method='OPTIONS' httpcode='200'
                                  29/04/2018 12:13:08 [23261] [DEBUG] [ablanco] -------- End
                                  
                                  
                                  

                                  Arturo

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

                                    Hi ablanco,

                                    is this all of the z-push.log?

                                    Have you also removed the account from the device and added it again?

                                    Were these errors in the log before removing the devices with z-push-admin?

                                    Manfred

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

                                      Hi Manfred,

                                      This is part of the log, I cant send all log (limit characters).

                                      Yes I remove the account several times and both devices.

                                      If you tell me an email address I will send the complete log.

                                      And these errors are after remove the devices (using z-push-admin).

                                      Something very strange is that after a while (I could not determine it), it synchronizes the Inbox folder, but the other folders are never synchronized.

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

                                        Hi ablanco,

                                        you can also upload it somewhere and send me the link.

                                        Manfred

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

                                          Hi!

                                          I just sent you the links by the chat.

                                          Thank you very much

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

                                            Hi ablanco,

                                            for some reason the folder hierarchy is not synced, even if the device requests it.

                                            I suggest you to try the following:

                                            • remove the account from the device.
                                            • remove the device using z-push-admin.
                                            • make sure there’s nothing in /var/lib/z-push/c/3 directory. If there are any files, remove them as well.
                                            • (if you didn’t do it after KC update, restart apache and php-fpm depending on your setup)
                                            • add the account on the device.

                                            Which KC version did you have before the update to 8.6? Does webapp work fine and all the folders and emails are there?

                                            Manfred

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