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

    Kopano's data is not synchronised when using BackendCombined for Kopano + Dovecot

    Z-Push when using Kopano
    2
    4
    415
    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.
    • ukus
      ukus last edited by ukus

      Dear Developers

      Thank you for developing Z-Push very much!

      The undefined GetImpersonatedUser() issue when using BackendKopano under BackendCombined has been solved, refer the following post.
      https://forum.kopano.io/topic/2598/undefined-getimpersonateduser-if-backendcombined-for-kopano-dovecot

      Then I am seeing different issue.

      [Symptom]
      In /etc/z-push/z-push.conf.php,
      (1)Kopano’s Mails, Contacts, Calendars, Tasks, Notes are syncronised correctly if BACKEND_PROVIDER is BackendKopano
      (2)Dovecot’s Mails are syncronised correctly if BACKEND_PROVIDER is BackendImap
      (3)Kopano’s Contacts, Calendars, Tasks, Notes are not synchronised if BACKEND_PROVIDER is BackendCombined for BackendKopano + BackendImap

      [Environment]
      After ‘yum -y update’ in the following environment
      CentOS 7
      Apache 2.4.6-89.el7.centos.1
      PHP 7.3.8-1.el7.remi
      Kopano core-8.7.82.61 + small fix for the undefined GetImpersonatedUser() issue
      Z-Push 2.5.0+0-117.1
      Dovecot 1:2.2.36-3.el7

      [Details]
      To make the investigation simpler, only the Kopano’s ‘Notes’ was enabled and tested in iPhone’s Settings - Passwords&Accounts.

      (1)
      define(‘BACKEND_PROVIDER’, ‘BackendKopano’); in /etc/z-push/z-push.conf.php
      Kopano’s Notes can be syncronised correctly.
      IMG_0314.PNG

      (2)
      define(‘BACKEND_PROVIDER’, ‘BackendImap’); in /etc/z-push/z-push.conf.php
      ‘Notes’ is not supported by BackendImap.

      (3)
      /etc/z-push/z-push.conf.php
      define(‘BACKEND_PROVIDER’, ‘BackendCombined’);
      Kopano’s Notes is not synchronised.
      IMG_0315.PNG

      Z-push log for Notes

      Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] -------- Start
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] cmd='FolderSync' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' version='2.5.0+0' method='POST'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Used timezone 'UTC'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Including backend file: '/usr/share/z-push/backend/kopano/kopano.php'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] BackendKopano using PHP-MAPI version: 8.7.82.59.aadca417e - PHP version: 7.3.8
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Combined 1 backends loaded.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Request::ProcessHeaders() ASVersion: 14.0
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ZPush::CommandNeedsProvisioning(9): true
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] FileStateMachine->GetState() read '3150' bytes from file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-devicedata'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice data loaded for user: 'hoho'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] TopCollector(): Initialized mutexid Resource id #9 and memid Resource id #10.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] LoopDetection(): Initialized mutexid Resource id #11 and memid Resource id #12.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] LoopDetection initialised with IPC provider 'IpcSharedMemoryProvider' with type '1337'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ZPush::HierarchyCommand(9): true
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] DeviceManager->ProvisioningRequired('708379090') saved device key '708379090': false
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] DeviceManager->getPolicyName(): determined policy name: 'default'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] DeviceManager->getProvisioningPolicies(): loaded 'default' policy.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ZPush::CommandNeedsAuthentication(9): true
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Combined->Logon('hoho', '',***))
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] KopanoBackend->Logon(): Trying to authenticate user 'hoho'..
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] KopanoBackend->openMessageStore('hoho'): Found 'DEFAULT' store: 'Resource id #15'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] KopanoBackend->Logon(): User 'hoho' is authenticated
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Store supports properties containing Unicode characters.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Combined->Logon() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ZPush::CommandNeedsPlainInput(9): false
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ZPush::GetSupportedProtocolVersions(): 12.0,12.1,14.0
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ZPush::GetSupportedCommands(): Sync,SendMail,SmartForward,SmartReply,GetAttachment,GetHierarchy,CreateCollection,DeleteCollection,MoveCollection,FolderSync,FolderCreate,FolderDelete,FolderUpdate,MoveItems,GetItemEstimate,MeetingResponse,ResolveRecipients,ValidateCert,Provision,Search,Ping,Notify,ItemOperations,Settings
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] FileStateMachine->GetState() read '379' bytes from file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-a9a7fe3b-041d-4203-9002-6b08c82bb0b2-fd'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] SyncParameters->UseCPO('DEFAULT')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetHierarchyCache(): HierarchyCache is up - Cached objects: 0
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Combined->Setup('', 'false', '', 'false')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Combined->Setup() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Combined->GetExporter('')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined constructed
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->Config(...)
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS exporter.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesICS->Config() initialized with state: 0x0000000000000000
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->Config() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->InitializeExporter(...)
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->__construct('z',...)
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesICS->InitializeExporter() successfully. 15 changes ready to sync for 'hierarchy'.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->InitializeExporter(...) success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->GetChangeCount()
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->GetChangeCount() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->Synchronize()
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] MAPIProvider->GetStoreProps(): Getting store properties.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/U9675c'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'U9675c'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] MAPIProvider->getInboxProps(): Getting inbox properties.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U9675c')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U9675c displayname: Inbox
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/U57fb1'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'U57fb1'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U57fb1')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U57fb1 displayname: Outbox
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/U95862'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'U95862'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U95862')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U95862 displayname: Deleted Items
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/Uc6446'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'Uc6446'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Uc6446')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Uc6446 displayname: Sent Items
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/Ucdea9'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'Ucdea9'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Ucdea9')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Ucdea9 displayname: Contacts
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/Ue4d18'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'Ue4d18'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Ue4d18')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Ue4d18 displayname: Calendar
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/U255f5'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'U255f5'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U255f5')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U255f5 displayname: Drafts
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/Ubcbd3'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'Ubcbd3'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Ubcbd3')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Ubcbd3 displayname: Journal
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/Ub7136'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'Ub7136'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Ub7136')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Ub7136 displayname: Notes
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/U769db'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'U769db'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U769db')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U769db displayname: Tasks
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 09:55:25 localhost z-push/core[14249]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/Uef7fd'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): found backendid in contentdata but with different folder type. Lookup 'U' - synchronized id 'Uef7fd'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Uef7fd')
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Uef7fd displayname: Junk E-mail
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] MAPIProvider->GetFolder(): folder 'RSS Feeds' should not be synchronized
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] MAPIProvider->GetFolder(): invalid folder 'Conversation Action Settings' as it is a hidden folder (PR_ATTR_HIDDEN)
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] MAPIProvider->GetFolder(): invalid folder 'Quick Step Settings' as it is a hidden folder (PR_ATTR_HIDDEN)
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] MAPIProvider->GetFolder(): folder 'Suggested Contacts' should not be synchronized
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->Synchronize() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->GetState()
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ExportChangesCombined->GetState() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] StateManager::UnLinkState(''): saved state 'a9a7fe3b-041d-4203-9002-6b08c82bb0b2' will be deleted.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] FileStateMachine->CleanStates(): Deleting file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-a9a7fe3b-041d-4203-9002-6b08c82bb0b2-1'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] FileStateMachine->CleanStates(): Deleting file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-a9a7fe3b-041d-4203-9002-6b08c82bb0b2-fd'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] FileStateMachine->CleanStates(): Deleting file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-a9a7fe3b-041d-4203-9002-6b08c82bb0b2-hc-1'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] StateManager::linkState(#ASDevice, 'b8f05047-3470-44b5-867e-036e86bce6ad','HierarchyCache'): linked to uuid 'b8f05047-3470-44b5-867e-036e86bce6ad'.
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] ASDevice->GetHierarchyCache(): HierarchyCache is up - Cached objects: 11
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] FileStateMachine->SetState() written 2844 bytes on file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-b8f05047-3470-44b5-867e-036e86bce6ad-hc-1'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] FileStateMachine->SetState() written 29 bytes on file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-b8f05047-3470-44b5-867e-036e86bce6ad-1'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] SyncCollections::InvalidatePingableFlags(): Invalidating now
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] FileStateMachine->SetState() written 379 bytes on file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-b8f05047-3470-44b5-867e-036e86bce6ad-fd'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] WBXMLEncoder->endTag() WBXML output completed
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Special header: MS-ASProtocolVersions: 12.0,12.1,14.0
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Special header: MS-ASProtocolCommands: Sync,SendMail,SmartForward,SmartReply,GetAttachment,GetHierarchy,CreateCollection,DeleteCollection,MoveCollection,FolderSync,FolderCreate,FolderDelete,FolderUpdate,MoveItems,GetItemEstimate,MeetingResponse,ResolveRecipients,ValidateCert,Provision,Search,Ping,Notify,ItemOperations,Settings
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Combined->Logoff()
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] Combined->Logoff() success
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] DeviceManager->Save(): Device data changed
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] FileStateMachine->SetState() written 3150 bytes on file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-devicedata'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] DeviceManager->Save(): Device data saved
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] LoopDetection->ProcessLoopDetectionTerminate()
Aug  6 09:55:25 localhost z-push/core[14249]: [INFO] [hoho] cmd='FolderSync' memory='2.15 MiB/4.00 MiB' time='0.48s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
Aug  6 09:55:25 localhost z-push/core[14249]: [DEBUG] [hoho] -------- End

      /etc/z-push/combined.conf.php

      <?php
/***********************************************
* File      :   backend/combined/config.php
* Project   :   Z-Push
* Descr     :   configuration file for the
*               combined backend.
*
* Created   :   29.11.2010
*
* Copyright 2007 - 2016 Zarafa Deutschland GmbH
*
* This program is free software: you can redistribute it and/or modify
* it under the terms of the GNU Affero General Public License, version 3,
* as published by the Free Software Foundation.
*
* This program is distributed in the hope that it will be useful,
* but WITHOUT ANY WARRANTY; without even the implied warranty of
* MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
* GNU Affero General Public License for more details.
*
* You should have received a copy of the GNU Affero General Public License
* along with this program.  If not, see <http://www.gnu.org/licenses/>.
*
* Consult LICENSE file for details
************************************************/

class BackendCombinedConfig {

    // *************************
    //  BackendCombined settings
    // *************************
    /**
     * Returns the configuration of the combined backend
     *
     * @access public
     * @return array
     *
     */
    public static function GetBackendCombinedConfig() {
        //use a function for it because php does not allow
        //assigning variables to the class members (expecting T_STRING)
        return array(
            //the order in which the backends are loaded.
            //login only succeeds if all backend return true on login
            //sending mail: the mail is sent with first backend that is able to send the mail
            'backends' => array(
                'i' => array(
                    'name' => 'BackendIMAP',
                ),
                'z' => array(
                    'name' => 'BackendKopano',
                ),
                'm' => array(
                    'name' => 'BackendMaildir',
                ),
                'v' => array(
                    'name' => 'BackendVCardDir',
                ),
                'l' => array(
                    'name' => 'BackendLDAP',
                ),
                'd' => array(
                    'name' => 'BackendCardDAV',
                ),
                'c' => array(
                    'name' => 'BackendCalDAV',
                ),
            ),
            'delimiter' => '/',
            //force one type of folder to one backend
            //it must match one of the above defined backends
            'folderbackend' => array(
                SYNC_FOLDER_TYPE_INBOX => 'i',
                SYNC_FOLDER_TYPE_DRAFTS => 'i',
                SYNC_FOLDER_TYPE_WASTEBASKET => 'i',
                SYNC_FOLDER_TYPE_SENTMAIL => 'i',
                SYNC_FOLDER_TYPE_OUTBOX => 'i',
                SYNC_FOLDER_TYPE_TASK => 'z',
                SYNC_FOLDER_TYPE_APPOINTMENT => 'z',
                SYNC_FOLDER_TYPE_CONTACT => 'z',
                SYNC_FOLDER_TYPE_NOTE => 'z',
                SYNC_FOLDER_TYPE_JOURNAL => 'z',
                SYNC_FOLDER_TYPE_OTHER => 'z',
                SYNC_FOLDER_TYPE_USER_MAIL => 'i',
                SYNC_FOLDER_TYPE_USER_APPOINTMENT => 'z',
                SYNC_FOLDER_TYPE_USER_CONTACT => 'z',
                SYNC_FOLDER_TYPE_USER_TASK => 'z',
                SYNC_FOLDER_TYPE_USER_JOURNAL => 'z',
                SYNC_FOLDER_TYPE_USER_NOTE => 'z',
                SYNC_FOLDER_TYPE_UNKNOWN => 'z',
            ),
            //creating a new folder in the root folder should create a folder in one backend
            'rootcreatefolderbackend' => 'z',
        );
    }
}

      /etc/z-push/kopano.conf.php

      <?php
/***********************************************
* File      :   config.php
* Project   :   Z-Push
* Descr     :   Kopano backend configuration file
*
* Created   :   27.11.2012
*
* Copyright 2007 - 2016 Zarafa Deutschland GmbH
*
* This program is free software: you can redistribute it and/or modify
* it under the terms of the GNU Affero General Public License, version 3,
* as published by the Free Software Foundation.
*
* This program is distributed in the hope that it will be useful,
* but WITHOUT ANY WARRANTY; without even the implied warranty of
* MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the
* GNU Affero General Public License for more details.
*
* You should have received a copy of the GNU Affero General Public License
* along with this program.  If not, see <http://www.gnu.org/licenses/>.
*
* Consult LICENSE file for details
************************************************/

// ************************
//  BackendKopano settings
// ************************

// Defines the server to which we want to connect.
//
// Depending on your setup, it might be advisable to change the lines below to one defined with your
// default socket location.
// Normally "default:" points to the default setting ("file:///var/run/kopano/server.sock")
// Examples: define("MAPI_SERVER", "default:");
//           define("MAPI_SERVER", "http://localhost:236/kopano");
//           define("MAPI_SERVER", "https://localhost:237/kopano");
//           define("MAPI_SERVER", "file:///var/run/kopano/server.sock");
// If you are using ZCP >= 7.2.0, set it to the zarafa location, e.g.
//           define("MAPI_SERVER", "http://localhost:236/zarafa");
//           define("MAPI_SERVER", "https://localhost:237/zarafa");
//           define("MAPI_SERVER", "file:///var/run/zarafad/server.sock");
// For ZCP versions prior to 7.2.0 the socket location is different (http(s) sockets are the same):
//           define("MAPI_SERVER", "file:///var/run/zarafa");

define('MAPI_SERVER', 'default:');

// Read-Only shared folders
//   When trying to write a change on a read-only folder this data is dropped and replaced on the device of the user.
//   Enabling the option below, sends an email to the user notifying that this happened (default enabled).
//   If this is disabled, the data will be dropped silently and will be lost.
//   The template of the email sent can be customized here. The placeholders can also be used in the subject.
define('READ_ONLY_NOTIFY_LOST_DATA', true);
// String to mark the data changed by the user (that he is trying to save)
define('READ_ONLY_NOTIFY_YOURDATA', 'Your data');
// Email template to be sent to the user
define('READ_ONLY_NOTIFY_SUBJECT', "Z-Push: Writing operation not permitted - data reset");
define('READ_ONLY_NOTIFY_BODY', <<<END
Dear **USERFULLNAME**,

on **DATE** at **TIME** you've tried to save a data in the folder '**FOLDERNAME**' on your device '**MOBILETYPE**' ID: '**MOBILEDEVICEID**'.

This operation was not successful, as you lack write access to this folder.
Your data has been dropped and replaced with the original data on your device to ensure data integrity.

Below is a copy of the data you tried to save. If you want your changes to be stored permanently you should forward this email to a person with write access to this folder asking to perform these changes again.
**DIFFERENCES**

If you have questions about this email, please contact your e-mail administrator.

Sincerely,
Your Z-Push system
END
         );
// Format of the **DATE** and **TIME** placeholders - more information on formats, see http://php.net/manual/en/function.strftime.php
define('READ_ONLY_NOTIFY_DATE_FORMAT', "%d.%m.%Y");
define('READ_ONLY_NOTIFY_TIME_FORMAT', "%H:%M:%S");

// Comma separated list of folder ids as string for which the notification emails of the changes in read-only folders shouldn't be sent.
// E.g. define('READ_ONLY_NONOTIFY', '1, 2, 3, 4');
// When configuring $additionalFolders it is possible to use DeviceManager::FLD_FLAGS_NOREADONLYNOTIFY in the flags bitmask
// in order to prevent the notifications as well.
define('READ_ONLY_NONOTIFY', '');
      1 Reply Last reply Reply Quote 0
      • Manfred
        Manfred Kopano last edited by

        Hi ukus,

        I’ve created https://jira.z-hub.io/browse/ZP-1517 to address this issue.

        In the meantime you can workaround this by changing

        $origin = substr($folderid, 0, 1);

        to

        $origin = substr($folderid, 2, 1);

        in [z-push-folder]/lib/utils/utils.php at line 1102.

        Be aware that this only works if you’re using BackendCombined! If you switch to BackendKopano, you have to reverse the change.

        Manfred

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

          Dear Manfred,

          Thank you for your response.
          I tried substr($folderid, 2, 1), but it did not work fine, it left the logs

          Aug 6 17:14:08 localhost z-push/core[6849]: [INFO] [hoho] StatusException: HandleSync() could not get an exporter for folder id z/z/Ub7136/31511f0adb1145b48f692f935a383820100000000000 - code: 12 - file: /usr/share/z-push/lib/request/sync.php:873

          and also

          Aug 6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id ‘z/z/U9675c’

          The followings are the Z-push log after changed to $origin = substr($folderid, 2, 1); As there wwas 32KBytes limitation to post here, I picked up one block in the log, it means the followings are not whole log I am afraid.

          Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] -------- Start
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] cmd='FolderSync' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' version='2.5.0+0' method='POST'
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] Used timezone 'UTC'
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] Including backend file: '/usr/share/z-push/backend/kopano/kopano.php'
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] BackendKopano using PHP-MAPI version: 8.7.82.59.aadca417e - PHP version: 7.3.8
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] Combined 1 backends loaded.
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] Request::ProcessHeaders() ASVersion: 14.0
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] ZPush::CommandNeedsProvisioning(9): true
Aug  6 17:14:04 localhost z-push/core[6849]: [INFO] [hoho] ProvisioningRequiredException: Retry after sending a PROVISION command - code: 0 - file: /usr/share/z-push/index.php:82
Aug  6 17:14:04 localhost z-push/core[6849]: [INFO] [hoho] User-agent: 'Apple-iPhone7C1/1606.203'
Aug  6 17:14:04 localhost z-push/core[6849]: [FATAL] [hoho] Exception: (ProvisioningRequiredException) - Retry after sending a PROVISION command
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] TopCollector(): Initialized mutexid Resource id #8 and memid Resource id #9.
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
Aug  6 17:14:04 localhost z-push/core[6849]: [INFO] [hoho] cmd='FolderSync' memory='1.68 MiB/2.00 MiB' time='0.01s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='449'
Aug  6 17:14:04 localhost z-push/core[6849]: [DEBUG] [hoho] -------- End
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] -------- Start
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] cmd='FolderSync' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' version='2.5.0+0' method='POST'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Used timezone 'UTC'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Including backend file: '/usr/share/z-push/backend/kopano/kopano.php'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] BackendKopano using PHP-MAPI version: 8.7.82.59.aadca417e - PHP version: 7.3.8
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Combined 1 backends loaded.
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Request::ProcessHeaders() ASVersion: 14.0
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ZPush::CommandNeedsProvisioning(9): true
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] FileStateMachine->GetState() read '608' bytes from file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-devicedata'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice data loaded for user: 'hoho'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] TopCollector(): Initialized mutexid Resource id #9 and memid Resource id #10.
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] LoopDetection(): Initialized mutexid Resource id #11 and memid Resource id #12.
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] LoopDetection initialised with IPC provider 'IpcSharedMemoryProvider' with type '1337'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ZPush::HierarchyCommand(9): true
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] DeviceManager->ProvisioningRequired('333124254') saved device key '333124254': false
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] DeviceManager->getPolicyName(): determined policy name: 'default'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] DeviceManager->getProvisioningPolicies(): loaded 'default' policy.
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ZPush::CommandNeedsAuthentication(9): true
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Combined->Logon('hoho', '',***))
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] KopanoBackend->Logon(): Trying to authenticate user 'hoho'..
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] KopanoBackend->openMessageStore('hoho'): Found 'DEFAULT' store: 'Resource id #15'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] KopanoBackend->Logon(): User 'hoho' is authenticated
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Store supports properties containing Unicode characters.
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Combined->Logon() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ZPush::CommandNeedsPlainInput(9): false
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ZPush::GetSupportedProtocolVersions(): 12.0,12.1,14.0
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ZPush::GetSupportedCommands(): Sync,SendMail,SmartForward,SmartReply,GetAttachment,GetHierarchy,CreateCollection,DeleteCollection,MoveCollection,FolderSync,FolderCreate,FolderDelete,FolderUpdate,MoveItems,GetItemEstimate,MeetingResponse,ResolveRecipients,ValidateCert,Provision,Search,Ping,Notify,ItemOperations,Settings
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetHierarchyCache(): HierarchyCache is up - Cached objects: 0
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Combined->Setup('', 'false', '', 'false')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Combined->Setup() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Combined->GetExporter('')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined constructed
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->Config(...)
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS exporter.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesICS->Config() initialized with state: 0x0000000000000000
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->Config() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->InitializeExporter(...)
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->__construct('z',...)
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesICS->InitializeExporter() successfully. 15 changes ready to sync for 'hierarchy'.
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->InitializeExporter(...) success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->GetChangeCount()
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->GetChangeCount() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->Synchronize()
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] MAPIProvider->GetStoreProps(): Getting store properties.
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'U9675c' for backend-folderid '31511f0adb1145b48f692f935a383820080000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] MAPIProvider->getInboxProps(): Getting inbox properties.
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U9675c')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U9675c displayname: Inbox
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'U57fb1' for backend-folderid '31511f0adb1145b48f692f935a383820090000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U57fb1')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U57fb1 displayname: Outbox
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'U95862' for backend-folderid '31511f0adb1145b48f692f935a3838200a0000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U95862')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U95862 displayname: Deleted Items
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'Uc6446' for backend-folderid '31511f0adb1145b48f692f935a3838200b0000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Uc6446')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Uc6446 displayname: Sent Items
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'Ucdea9' for backend-folderid '31511f0adb1145b48f692f935a3838200c0000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Ucdea9')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Ucdea9 displayname: Contacts
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'Ue4d18' for backend-folderid '31511f0adb1145b48f692f935a3838200d0000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Ue4d18')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Ue4d18 displayname: Calendar
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'U255f5' for backend-folderid '31511f0adb1145b48f692f935a3838200e0000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U255f5')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U255f5 displayname: Drafts
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'Ubcbd3' for backend-folderid '31511f0adb1145b48f692f935a3838200f0000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Ubcbd3')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Ubcbd3 displayname: Journal
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'Ub7136' for backend-folderid '31511f0adb1145b48f692f935a383820100000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Ub7136')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Ub7136 displayname: Notes
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'U769db' for backend-folderid '31511f0adb1145b48f692f935a383820110000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('U769db')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/U769db displayname: Tasks
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] UKUS mapiprovider.php Request::GetImpersonatedUser ##
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetFolderIdForBackendId(): generated new folderid 'Uef7fd' for backend-folderid '31511f0adb1145b48f692f935a383820120000000000'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange('Uef7fd')
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ImportHierarchyChangesCombinedWrap->ImportFolderChange() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] HierarchyCache: AddFolder() serverid: z/Uef7fd displayname: Junk E-mail
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] MAPIProvider->GetFolder(): folder 'RSS Feeds' should not be synchronized
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] MAPIProvider->GetFolder(): invalid folder 'Conversation Action Settings' as it is a hidden folder (PR_ATTR_HIDDEN)
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] MAPIProvider->GetFolder(): invalid folder 'Quick Step Settings' as it is a hidden folder (PR_ATTR_HIDDEN)
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] MAPIProvider->GetFolder(): folder 'Suggested Contacts' should not be synchronized
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->Synchronize() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->GetState()
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ExportChangesCombined->GetState() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] StateManager::linkState(#ASDevice, '8343092e-221d-4681-be9d-cbcc565ee8fe','HierarchyCache'): linked to uuid '8343092e-221d-4681-be9d-cbcc565ee8fe'.
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] ASDevice->GetHierarchyCache(): HierarchyCache is up - Cached objects: 11
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] FileStateMachine->SetState() written 2844 bytes on file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-8343092e-221d-4681-be9d-cbcc565ee8fe-hc-1'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] FileStateMachine->SetState() written 29 bytes on file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-8343092e-221d-4681-be9d-cbcc565ee8fe-1'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] SyncCollections::InvalidatePingableFlags(): Invalidating now
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] FileStateMachine->SetState() written 379 bytes on file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-8343092e-221d-4681-be9d-cbcc565ee8fe-fd'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] WBXMLEncoder->endTag() WBXML output completed
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Special header: MS-ASProtocolVersions: 12.0,12.1,14.0
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Special header: MS-ASProtocolCommands: Sync,SendMail,SmartForward,SmartReply,GetAttachment,GetHierarchy,CreateCollection,DeleteCollection,MoveCollection,FolderSync,FolderCreate,FolderDelete,FolderUpdate,MoveItems,GetItemEstimate,MeetingResponse,ResolveRecipients,ValidateCert,Provision,Search,Ping,Notify,ItemOperations,Settings
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Combined->Logoff()
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] Combined->Logoff() success
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] DeviceManager->Save(): Device data changed
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] FileStateMachine->SetState() written 1639 bytes on file: '/var/lib/z-push/4/9/smirvfp8kt1qj93696qj4r0d94-devicedata'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] DeviceManager->Save(): Device data saved
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] LoopDetection->ProcessLoopDetectionTerminate()
Aug  6 17:14:05 localhost z-push/core[6849]: [INFO] [hoho] cmd='FolderSync' memory='3.57 MiB/6.00 MiB' time='0.19s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
Aug  6 17:14:05 localhost z-push/core[6849]: [DEBUG] [hoho] -------- End
Aug  6 17:14:06 localhost z-push/core[6849]: [INFO] [hoho] cmd='FolderSync' memory='2.02 MiB/2.00 MiB' time='0.02s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
Aug  6 17:14:08 localhost z-push/core[6849]: [INFO] [hoho] StatusException: HandleSync() could not get an exporter for folder id z/z/Ub7136/31511f0adb1145b48f692f935a383820100000000000 - code: 12 - file: /usr/share/z-push/lib/request/sync.php:873
Aug  6 17:14:08 localhost z-push/core[6849]: [INFO] [hoho] cmd='Sync' memory='2.03 MiB/2.00 MiB' time='0.01s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
Aug  6 17:14:08 localhost z-push/core[6849]: [INFO] [hoho] cmd='FolderSync' memory='2.02 MiB/2.00 MiB' time='0.02s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
Aug  6 17:14:10 localhost z-push/core[6849]: [INFO] [hoho] StatusException: HandleSync() could not get an exporter for folder id z/z/Ub7136/31511f0adb1145b48f692f935a383820100000000000 - code: 12 - file: /usr/share/z-push/lib/request/sync.php:873
Aug  6 17:14:10 localhost z-push/core[6849]: [INFO] [hoho] cmd='Sync' memory='2.03 MiB/2.00 MiB' time='0.01s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U9675c'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U57fb1'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U95862'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Uc6446'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Ucdea9'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Ue4d18'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U255f5'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Ubcbd3'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Ub7136'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U769db'
Aug  6 17:14:11 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Uef7fd'
Aug  6 17:14:11 localhost z-push/core[6849]: [INFO] [hoho] cmd='FolderSync' memory='2.15 MiB/2.00 MiB' time='0.08s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
Aug  6 17:14:12 localhost z-push/core[6849]: [INFO] [hoho] cmd='FolderSync' memory='2.02 MiB/2.00 MiB' time='0.02s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
Aug  6 17:14:14 localhost z-push/core[6849]: [INFO] [hoho] StatusException: HandleSync() could not get an exporter for folder id z/z/Ub7136/31511f0adb1145b48f692f935a383820100000000000 - code: 12 - file: /usr/share/z-push/lib/request/sync.php:873
Aug  6 17:14:14 localhost z-push/core[6849]: [INFO] [hoho] cmd='Sync' memory='2.03 MiB/2.00 MiB' time='0.01s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U9675c'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U57fb1'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U95862'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Uc6446'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Ucdea9'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Ue4d18'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U255f5'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Ubcbd3'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Ub7136'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/U769db'
Aug  6 17:14:15 localhost z-push/core[6849]: [WARN] [hoho] Utils->GetFolderOriginFromId(): Unknown folder origin for folder with id 'z/z/Uef7fd'
Aug  6 17:14:16 localhost z-push/core[6849]: [INFO] [hoho] cmd='FolderSync' memory='2.15 MiB/2.00 MiB' time='0.08s' devType='iPhone' devId='smirvfp8kt1qj93696qj4r0d94' getUser='hoho' from='192.168.150.128' idle='0s' version='2.5.0+0' method='POST' httpcode='200'
          1 Reply Last reply Reply Quote 0
          • Manfred
            Manfred Kopano last edited by

            Hi ukus,

            I suggest you to reset all the changes you’ve done to Z-Push yourself and leave only those Sebastian and I mentioned. Then remove ActiveSync account from your device and remove device using z-push-admin so that you start with the fresh installation.

            However I’m also not sure this will work as BackendKopano had too many changes and probably won’t work with BackendCombined properly. Our suggestions were to work around the immediate issues which occur, but apparently they cause other problems to appear. It’s also not something we will investigate in the near future.

            You’d be better of using CardDAV and CalDAV which are known to work well with CombinedBackend for contacts, appointments and tasks. Or you configure two ActiveSync accounts on your mobile - one for IMAP and Kopano for the rest if using Kopano backend only is not an option for you.

            Manfred

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