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
    4751
    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,

      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
                            • ablanco
                              ablanco last edited by

                              Hi Manfred,

                              All done and the result is the same:

                              02/05/2018 20:33:33 [ 6128] [FATAL] [ablanco] Exception: (ProvisioningRequiredException) - Retry after sending a PROVISION command

                              The version before update was 8.5.X (the last for 8.5), the webapp and the deskapp working perfectly only not work this…

                              On the previusly link are the new log z-push.log and z-push-error.log.

                              Thanks

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

                                Hi ablanco,

                                it looks like there’s something gone with the ICS and the hierarchy isn’t being exported.

                                If you have a valid Kopano subscription, please open a support issue. Otherwise you can create a new topic at https://forum.kopano.io/category/15/kopano-groupware-core. Either way you should mention that ICS doesn’t export hierarchy.

                                Are there any errors in /var/log/kopano/server.log ? Which OS are you using?

                                Manfred

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

                                  Hi Manfred,

                                  I created the post:

                                  https://forum.kopano.io/topic/1331/upgrade-problems-8-6-ics-doesn-t-export-hierarchy

                                  My SO is Ubuntu 14.04 and not have errors on server.log.

                                  Thanks!

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

                                    Problem of @ablanco was resolved by updating to a more recent build.

                                    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
                                    • First post
                                      Last post