Hi,

I am trying to get Z-Push (version 2.4.4) running with access to the apps MailPlus Server, Calendar, CardDAV Server of a Synology Diskstation (DSM 6.2-23739 Update 2). The backends “IMAP” and “CalDAV” work perfectly. With “CardDAV” I get the following error message in the log:

"BackendCardDAV-> ChangesSinkInitialize - Error doing the initial sync for 'Https://xxxxx.xx.xxxxxxxxxx.de:8443/addressbooks/users/ladmin/addressbook/': Woops, something's gone wrong! The CardDAV server returned the http status code 403. "

The client is an iPhone (iOS 11.4.1). When I set up access from the iPhone directly to the CardDAV server (without Z-Push), all contacts are displayed.
 
 Here the detailed log:

09/08/2018 16:36:45 [   21] [DEBUG] [ladmin] -------- Start
09/08/2018 16:36:45 [   21] [DEBUG] [ladmin] cmd='Ping' devType='iPhone' devId='b3b6naubi94pv80lq2dmch0nic' getUser='ladmin' from='xx.xx.xx.xx' version='2.4.4+0-0' method='POST'
09/08/2018 16:36:45 [   21] [DEBUG] [ladmin] Used timezone 'Europe/Berlin'
09/08/2018 16:36:45 [   21] [DEBUG] [ladmin] Request::ProcessHeaders() ASVersion: 14.0
09/08/2018 16:36:45 [   21] [DEBUG] [ladmin] ZPush::CommandNeedsProvisioning(18): false
09/08/2018 16:36:45 [   21] [DEBUG] [ladmin] ZPush::CommandNeedsAuthentication(18): true
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] BackendCardDAV->Logon(): User 'ladmin' is authenticated on 'https://xxxxx.xx.xxxxx-xxxxx.de:8443/addressbooks/users/ladmin/addressbook/'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] BackendCardDAV::discoverAddressbooks() Found addressbook 'https://xxxxx.xx.xxxxx-xxxxx.de:8443/addressbooks/users/ladmin/addressbook/'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] FileStateMachine->GetState() read '2613' bytes from file: '/var/lib/z-push/c/i/b3b6naubi94pv80lq2dmch0nic-devicedata'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] ASDevice data loaded for user: 'ladmin'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] TopCollector(): Initialized mutexid Resource id #20 and memid Resource id #21.
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] LoopDetection(): Initialized mutexid Resource id #24 and memid Resource id #25.
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] LoopDetection initialised with IPC provider 'IpcSharedMemoryProvider' with type '1337'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] ZPush::HierarchyCommand(18): false
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] ZPush::CommandNeedsPlainInput(18): false
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I  <Ping:Ping>
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] FileStateMachine->GetState() read '857' bytes from file: '/var/lib/z-push/c/i/b3b6naubi94pv80lq2dmch0nic-163820ce-c96d-4f41-bd52-950d7c707d75-fd'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] SyncParameters->UseCPO('DEFAULT')
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] ZPush::GetAdditionalSyncFolderStore('contacts'): 'false'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] SyncCollections->AddCollection(): Folder id 'contacts' : ref. PolicyKey '425253863', ref. Lifetime '600', last sync at '1533822859'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] SyncCollections->AddCollection(): Updated reference PolicyKey '425253863', reference Lifetime '600', Last sync at '1533822859'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] SyncParameters->GetLatestSyncKey(): '{163820ce-c96d-4f41-bd52-950d7c707d75}2'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] FileStateMachine->GetState() read '6' bytes from file: '/var/lib/z-push/c/i/b3b6naubi94pv80lq2dmch0nic-163820ce-c96d-4f41-bd52-950d7c707d75-2'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] FileStateMachine->GetState() read '379' bytes from file: '/var/lib/z-push/c/i/b3b6naubi94pv80lq2dmch0nic-4feb40e8-4d5a-47c3-ba7c-1b765275eeb7-fd'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] SyncParameters->UseCPO('DEFAULT')
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] SyncCollections->AddCollection(): Folder id '' : ref. PolicyKey '425253863', ref. Lifetime '10', last sync at '1533825344'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] SyncCollections->AddCollection(): Updated reference PolicyKey '425253863', reference Lifetime '600', Last sync at '1533825344'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] SyncParameters->GetLatestSyncKey(): '{4feb40e8-4d5a-47c3-ba7c-1b765275eeb7}1'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] StateManager->loadHierarchyCache(): 'b3b6naubi94pv80lq2dmch0nic-4feb40e8-4d5a-47c3-ba7c-1b765275eeb7-hc-1'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] FileStateMachine->GetState() read '246' bytes from file: '/var/lib/z-push/c/i/b3b6naubi94pv80lq2dmch0nic-4feb40e8-4d5a-47c3-ba7c-1b765275eeb7-hc-1'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] FileStateMachine->GetState() read '97' bytes from file: '/var/lib/z-push/c/i/b3b6naubi94pv80lq2dmch0nic-4feb40e8-4d5a-47c3-ba7c-1b765275eeb7-1'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] HandlePing(): reference PolicyKey for PING: 425253863
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] HandlePing(): initialization data received
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I   <Ping:LifeTime>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I    600
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I   </Ping:LifeTime>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I   <Ping:Folders>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I    <Ping:Folder>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I     <Ping:ServerEntryId>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I      contacts
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I     </Ping:ServerEntryId>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I     <Ping:FolderType>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I      Contacts
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I     </Ping:FolderType>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I    </Ping:Folder>
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] HandlePing(): using saved sync state for 'Contacts' id 'contacts'
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I   </Ping:Folders>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] I  </Ping:Ping>
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] SyncCollections->SaveCollection(): Data of folder 'contacts' changed
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] FileStateMachine->SetState() written 1 bytes on file: '/var/lib/z-push/c/i/b3b6naubi94pv80lq2dmch0nic-163820ce-c96d-4f41-bd52-950d7c707d75-fd'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] DeviceManager->DoAutomaticASDeviceSaving(): save automatically: false
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] PingTracking(): Initialized mutexid Resource id #72 and memid Resource id #73.
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] PingTracking initialised with IPC provider 'IpcSharedMemoryProvider' with type '2'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] Announce process as PUSH connection
09/08/2018 16:36:46 [   21] [ INFO] [ladmin] SyncCollections->CheckForChanges(): Waiting for store changes... (lifetime 600 seconds)
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] ZPush::GetAdditionalSyncFolderStore('contacts'): 'false'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] BackendCardDAV->ChangesSinkInitialize(): folderid 'contacts'
09/08/2018 16:36:46 [   21] [ERROR] [ladmin] BackendCardDAV->ChangesSinkInitialize - Error doing the initial sync for 'https://xxxxx.xx.xxxxx-xxxxx.de:8443/addressbooks/users/ladmin/addressbook/': Woops, something's gone wrong! The CardDAV server returned the http status code 403.
09/08/2018 16:36:46 [   21] [WARN] [ladmin] /usr/share/z-push/backend/carddav/carddav.php:208 Undefined index: https://xxxxx.xx.xxxxx-xxxxx.de:8443/addressbooks/users/ladmin/addressbook/ (8)
09/08/2018 16:36:46 [   21] [ INFO] [ladmin] StatusException: Error initializing ChangesSink for folder id contacts/contacts - code: 2 - file: /usr/share/z-push/lib/core/synccollections.php:525
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] LoopDetection->ProcessLoopDetectionAddStatus: 'hierarchy' with status 7
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] O  <Ping:Ping>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] O   <Ping:Status>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] O   7
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] O   </Ping:Status>
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] O  </Ping:Ping>
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] WBXMLEncoder->endTag() WBXML output completed
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] WBXML-OUT: AwFqAAANRUcDNwABAQ==
09/08/2018 16:36:46 [   21] [WBXML] [ladmin] WBXML-IN : AwFqAAANRUgDNjAwAAFJSksDY29udGFjdHMAAUwDQ29udGFjdHMAAQEBAQ==
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] BackendCardDAV->Logoff(): disconnected from CARDDAV server
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] LoopDetection->ProcessLoopDetectionTerminate()
09/08/2018 16:36:46 [   21] [ INFO] [ladmin] cmd='Ping' memory='1.89 MiB/2.00 MiB' time='0.54s' devType='iPhone' devId='b3b6naubi94pv80lq2dmch0nic' getUser='ladmin' from='87.138.86.22' idle='0s' version='2.4.4+0-0' method='POST' httpcode='200'
09/08/2018 16:36:46 [   21] [DEBUG] [ladmin] -------- End

Does anyone have a hint, what to do?
 
Thanks
Mark