Calendar synchronisation with iOS 11
-
Since update to iOS 11.0.1 E-Mail, Contacts works but Calendar is not realy synchronized .
Some entries are synchronized to, other in turn not. Respectively late
New created calendar items are not delivered.
Also at the bottom in the Calendar App is a “!” left from Calendar.
In the z-push.log, the following is:
30/09/2017 14:09:32 [ 1738] [ INFO] [rconstap] StatusException: SyncCollections->CheckForChanges(): Timeout forced after 59s from 900s due to other process - code: 3 - file: /usr/share/z-push/lib/core/synccollections.php:579
30/09/2017 14:09:32 [ 1738] [ INFO] [rconstap] cmd=‘Ping’ memory=‘5.49 MiB/2.00 MiB’ time=‘59.44s’ devType=‘iPhone’ devId=‘4diq3icvft5d1bb4m82diduc5k’ getUser=‘rconstap’ from=‘87.122.218.179’ idle=‘59s’ version=‘2.3.8+0-0’ method=‘POST’ httpcode=‘200’ -
Hello @zwockel ,
I have moved your post into a dedicated topic.
Could you share which backend(s) you are using? Could you create a wbxml of the device attempting to sync the calendar?
-
ii z-push-backend-imap 2.3.8+0-0 all Z-Push imap backend
ii z-push-backend-kopano 2.3.8+0-0 all Z-Push Kopano backend
ii z-push-common 2.3.8+0-0 all open source implementation of the ActiveSync protocol
ii z-push-config-apache 2.3.8+0-0 all Z-Push apache configuration
ii z-push-kopano-gabsync 2.3.8+0-0 all GAB sync for KopanoHow can i create a wbxml?
-
@zwockel said in Calendar synchronisation with iOS 11:
How can i create a wbxml?
You can find the needed instructions in the wiki: https://wiki.z-hub.io/plugins/servlet/mobile#content/view/5734653
-
i created the wbxml. How can i send it to you?
-
30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] -------- Start 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] cmd='Sync' devType='iPhone' devId='2hm2u8i68p5t76cbeht0qpikkg' getUser='rconstap' from='87.122.218.179' version='2.3.8+0-0' method='POST' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] Used timezone 'Europe/Amsterdam' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::GetBackend(): trying autoload backend 'BackendKopano' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] BackendKopano using PHP-MAPI version: 8.3.4-12 - PHP version: 7.0.22-0ubuntu0.16.04.1 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] Request::ProcessHeaders() ASVersion: 14.0 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::CommandNeedsProvisioning(0): true 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] FileStateMachine->GetState() read '78235' bytes from file: '/var/lib/z-push/g/k/2hm2u8i68p5t76cbeht0qpikkg-devicedata' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ASDevice data loaded for user: 'rconstap' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] TopCollector(): Initialized mutexid Resource id #9 and memid Resource id #10. 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] LoopDetection(): Initialized mutexid Resource id #11 and memid Resource id #12. 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] LoopDetection initialised with IPC provider 'IpcSharedMemoryProvider' with type '1337' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::HierarchyCommand(0): false 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] DeviceManager->ProvisioningRequired('632973763') saved device key '632973763': false 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] DeviceManager->getPolicyName(): determined policy name: 'default' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] DeviceManager->getProvisioningPolicies(): loaded 'default' policy. 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::CommandNeedsAuthentication(0): true 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] KopanoBackend->Logon(): Trying to authenticate user 'rconstap'.. 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] KopanoBackend->openMessageStore('rconstap'): Found 'DEFAULT' store: 'Resource id #15' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] KopanoBackend->Logon(): User 'rconstap' is authenticated 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] Store supports properties containing Unicode characters. 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::CommandNeedsPlainInput(0): false 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <Synchronize> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <Folders> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <Folder> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <SyncKey> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I {7f3ed5f9-92b9-4165-9549-c248b9ac034b}151 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </SyncKey> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <FolderId> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I Ua1d3e 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </FolderId> 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] FileStateMachine->GetState() read '970' bytes from file: '/var/lib/z-push/g/k/2hm2u8i68p5t76cbeht0qpikkg-7f3ed5f9-92b9-4165-9549-c248b9ac034b-fd' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] SyncParameters->UseCPO('DEFAULT') 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] DeviceManager->GetBackendIdForFolderId(): folderid Ua1d3e => 530f88894db34e14a8fde0045d4a16990301000000000000 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] SyncCollections->AddCollection(): Folder id 'Ua1d3e' : ref. PolicyKey '632973763', ref. Lifetime '600', last sync at '1506782709' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] SyncCollections->AddCollection(): Updated reference PolicyKey '632973763', reference Lifetime '600', Last sync at '1506782709' 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <GetChanges/> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <WindowSize> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I 25 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </WindowSize> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <Options> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <AirSyncBase:BodyPreference> 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] SyncParameters->UseCPO('DEFAULT') 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <AirSyncBase:Type> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I 1 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </AirSyncBase:Type> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I <AirSyncBase:TruncationSize> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I 32768 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </AirSyncBase:TruncationSize> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </AirSyncBase:BodyPreference> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </Options> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </Folder> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </Folders> 30/09/2017 16:45:14 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] I </Synchronize> 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] HandleSync(): Start Output 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::GetAdditionalSyncFolderStore('530f88894db34e14a8fde0045d4a16990301000000000000'): 'false' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] KopanoBackend->GetFolderStat() fetched status information of 681 folders for store 'rconstap' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] SyncParameters->IsExporterRunRequired(): true - current: 1506781662/9782/1/14 - saved: false - expiring: 2017-10-29 11:13:36 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] Sync->loadStates(): loading states for folder 'Ua1d3e' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] FileStateMachine->CleanStates(): Deleting file: '/var/lib/z-push/g/k/2hm2u8i68p5t76cbeht0qpikkg-7f3ed5f9-92b9-4165-9549-c248b9ac034b-150' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] FileStateMachine->GetState() read '94523' bytes from file: '/var/lib/z-push/g/k/2hm2u8i68p5t76cbeht0qpikkg-7f3ed5f9-92b9-4165-9549-c248b9ac034b-151' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::GetAdditionalSyncFolderStore('530f88894db34e14a8fde0045d4a16990301000000000000'): 'false' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::GetAdditionalSyncFolderStore('530f88894db34e14a8fde0045d4a16990301000000000000'): 'false' 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ExportChangesICS->Config(): synching inital data 30/09/2017 16:45:14 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ExportChangesICS->Config() initialized with state: 0x21e60400000000004e0c00000a6d100016000000530f88894db34e1 <log message with 189077 bytes truncated> 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ExportChangesICS->InitializeExporter() successfully. 6632 changes ready to sync for '530f88894db34e14a8fde0045d4a16990301000000000000'. 09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] LoopDetection->ProcessLoopDetectionAddStatus: 'Ua1d3e' with status 1 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] Folder type: Calendar 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <Synchronize> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <Folders> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <Folder> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <SyncKey> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O {7f3ed5f9-92b9-4165-9549-c248b9ac034b}152 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </SyncKey> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <FolderId> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O Ua1d3e 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </FolderId> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <Status> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 1 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </Status> 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] LoopDetection->Detect(): folderid:'Ua1d3e' uuid:'7f3ed5f9-92b9-4165-9549-c248b9ac034b' counter:'151' max:'25' queued:'6632' 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <MoreAvailable/> 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] PHPWrapper->ImportMessageChange(): Getting message from MAPIProvider, sourcekey: '530f88894db34e14a8fde0045d4a1699389e05000000', parentsourcekey: '530f88894db34e14a8fde0045d4a16990301000000000000', entryid: '00000000706aeeeb7c034000b134ed4b8824266f0100000005000000ff065270667346f392ba418f39d98f5100000000' 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] BodyPreference types: 1 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] GetBodyPreferenceBestMatch: 1 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] bpo: truncation size:'32768', allornone:'0', preview:'0' 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] MAPIStreamWrapper::stream_open(): initialized mapistream: Resource id #116 - streamlength: 12 - HTML-safe-truncate: false 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] TimezoneUtil::GetFullTZ() for Europe/Amsterdam 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] MAPIProvider->getAppointment(): setting ourself as the organizer for an appointment without attendees. 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::GetAdditionalSyncFolderStore('530f88894db34e14a8fde0045d4a16990301000000000000'): 'false' 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <Perform> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <Add> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <ServerEntryId> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O Ua1d3e:530f88894db34e14a8fde0045d4a1699389e05000000 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </ServerEntryId> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <Data> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:Timezone> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O xP///ygARwBNAFQAKwAwADEAOgAwADAAKQAgAEEAbQBzAHQAZQByAGQAYQBtACwAIABCAGUAcgBsAGkAbgAsACAAQgAAAAoAAAAFAAMAAAAAAAAAAAAAACgARwBNAFQAKwAwADEAOgAwADAAKQAgAEEAbQBzAHQAZQByAGQAYQBtACwAIABCAGUAcgBsAGkAbgAsACAAQgAAAAMAAAAFAAIAAAAAAAAAxP///w== 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:Timezone> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:DtStamp> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 20150202T105311Z 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:DtStamp> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:StartTime> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 20150202T100000Z 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:StartTime> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:Subject> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O Christian Heuer anrufen 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:Subject> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:UID> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 0FFFB046C77F4F58B6B0F10212C73CD60 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:UID> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:OrganizerName> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O R.Constapel 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:OrganizerName> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:OrganizerEmail> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O rconstap@hermannbecker.de 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:OrganizerEmail> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:Location> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O Oventrop 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:Location> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:EndTime> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 20150202T110000Z 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:EndTime> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:Sensitivity> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 0 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:Sensitivity> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:BusyStatus> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 2 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:BusyStatus> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:AllDayEvent> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 0 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:AllDayEvent> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <POOMCAL:MeetingStatus> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 0 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </POOMCAL:MeetingStatus> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <AirSyncBase:Body> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <AirSyncBase:Type> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 1 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </AirSyncBase:Type> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <AirSyncBase:EstimatedDataSize> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 12 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </AirSyncBase:EstimatedDataSize> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <AirSyncBase:Data> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <<< written 12 of 12 bytes of plain data >>> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </AirSyncBase:Data> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </AirSyncBase:Body> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <AirSyncBase:NativeBodyType> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O 3 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </AirSyncBase:NativeBodyType> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </Data> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </Add> 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] PHPWrapper->ImportMessageChange(): change for: 'Ua1d3e:530f88894db34e14a8fde0045d4a1699389e05000000' 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] PHPWrapper->ImportMessageChange(): Getting message from MAPIProvider, sourcekey: '530f88894db34e14a8fde0045d4a1699269e05000000', parentsourcekey: '530f88894db34e14a8fde0045d4a16990301000000000000', entryid: '00000000706aeeeb7c034000b134ed4b8824266f010000000500000015e006be75ad924881bff287ab6e174800000000' 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] BodyPreference types: 1 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] GetBodyPreferenceBestMatch: 1 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] bpo: truncation size:'32768', allornone:'0', preview:'0' 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] MAPIStreamWrapper::stream_open(): initialized mapistream: Resource id #202 - streamlength: 41 - HTML-safe-truncate: false 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] TimezoneUtil::GetFullTZ() for Europe/Amsterdam 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] MAPIProvider->getAppointment(): setting ourself as the organizer for an appointment without attendees. 30/09/2017 16:45:15 [ 2142] [DEBUG] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] ZPush::GetAdditionalSyncFolderStore('530f88894db34e14a8fde0045d4a16990301000000000000'): 'false' 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <Add> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O <ServerEntryId> 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O Ua1d3e:530f88894db34e14a8fde0045d4a1699269e05000000 30/09/2017 16:45:15 [ 2142] [WBXML] [rconstap] [2hm2u8i68p5t76cbeht0qpikkg] O </ServerEntryId>
-
Hi zwockel,
could you also post the output of z-push-admin -a list -u rconstap -d 2hm2u8i68p5t76cbeht0qpikkg?
Is this the entire log? In the part you’ve posted there’s nothing obviously wrong. The device is still synchronising the calendar folder and the “6632 changes ready to sync” indicates that it will still take some time.
Manfred
-
Hallo Manfred,
here is the output:
root@kopano:/var/log/z-push# z-push-admin -a list -u rconstap -d 2hm2u8i68p5t76cbeht0qpikkg
PHP Notice: Use of undefined constant rconstap - assumed ‘rconstap’ in /etc/z-push/z-push.conf.php on line 110Synchronized by user: rconstap
DeviceId: 2hm2u8i68p5t76cbeht0qpikkg
Device type: iPhone
UserAgent: Apple-iPhone9C3/1501.421
Device Model: iPhone9C3
Device friendly name: Schwarz iPhone 7
Device OS: iOS 11.0.2 15A421
Device OS Language: de-DE
ActiveSync version: 14.0
First sync: 2017-07-21 21:36
Last sync: 2017-10-04 19:42
Total folders: 512
Short folder Ids: Yes
Synchronized folders: 459
Synchronized data: Emails(454) Contacts Calendars Notes Tasks(2)
Additional Folders: none
Status: OK
WipeRequest on: not set
WipeRequest by: not set
Wiped on: not set
Policy name: default
Attention needed: 1 messages need attention because they could not be synchronized
Broken object: ‘SyncAppointment’ ignored on ‘2017-09-30 19:00’
Information: Subject: ‘Geburtstag Luzia Becker’ - On: ‘1999-12-03 02:00’
Reason: (4)
Item/Parent id: Ua1d3e:530f88894db34e14a8fde0045d4a1699bb06000000000000/Ua1d3eBest regards
Ralf -
Hi Ralf,
is it still synchronising? iOS 11.0.2 had some fixes for ActiveSync accounts as far as I know.
Do you have something in $specialLogUsers in Z-Push config? The user names you put there must be quoted.
Manfred
-
Hallo Manfred,
after the iOS Update to 11.0.3 and reconect the calendar acount everything works.
-
Hi Ralf,
thanks for the update. Good to hear that it works now.
Manfred