• Solved

  • Mobile device and archive

Hi @didier-walraet ,

could you also post some excerpt from /var/log/grommunio-sync/grommunio-sync.log, ideally an OPTIONS request (it has method='OPTIONS' in the line after -------- Start) and some POST request, e.g. cmd='Provision'. You may anonymise the data, I just would like to see what the device sends in those requests.

    andreaslang
    Sorry for delay.
    there is content of asked log when my mobile synchronise
    Here is the content of the log requested when my mobile synchronizes with the server.
    But, I don't see the requested entries.

    1/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] -------- Start
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] cmd='FolderSync' devType='Android' devId='androidcxxxxxxxx' getUser='didier.walraet@cpas-andenne.eu' from='xxx.xxx.xxx.xxx' version='1.0.17' method='POST'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Used timezone 'Europe/Vienna'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio using PHP-MAPI version: 1.25.60.b49eb230c - PHP version: 7.4.6
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Request::ProcessHeaders() ASVersion: 14.1
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] GSync::CommandNeedsProvisioning(9): true
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] ProvisioningManager->ProvisioningRequired('xxxxxxxxxx') saved device key 'xxxxxxxxx': false
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] ProvisioningManager->ProvisioningRequired() saved policy hash '16e9d28d8d85649de7b4deb661ba5dc2' matches
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] GSync::CommandNeedsAuthentication(9): true
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->Logon(): Trying to authenticate user 'didier.walraet@cpas-andenne.eu'..
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->openMessageStore('didier.walraet@cpas-andenne.eu'): Found 'DEFAULT' store: 'Resource id #19'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->Logon(): User 'didier.walraet@cpas-andenne.eu' is authenticated
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Store supports properties containing Unicode characters.
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] GSync::HierarchyCommand(9): true
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->GetState(): top class 'ASDevice'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] GSync::CommandNeedsPlainInput(9): false
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] I <FolderHierarchy:FolderSync>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] I <FolderHierarchy:SyncKey>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] I {e16fa155-1857-4e87-8c4e-7bd97e8885c6}1
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] I </FolderHierarchy:SyncKey>
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateManager->loadHierarchyCache(): '-e16fa155-1857-4e87-8c4e-7bd97e8885c6-hc-1'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->CleanStates(): Found 0 states to clean (e16fa155-1857-4e87-8c4e-7bd97e8885c6-hc)
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->GetState(): top class 'ChangesMemoryWrapper'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): top class 'SyncFolder'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->CleanStates(): Found 0 states to clean (e16fa155-1857-4e87-8c4e-7bd97e8885c6)
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->GetState(): top class 'SyncParameters'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): sub class 'ContentParameters'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] ASDevice->GetHierarchyCache(): HierarchyCache is up - Cached objects: 15
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] I </FolderHierarchy:FolderSync>
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] ExportChangesICS->Config() initialized with state: 0x02000201174010000100050000000000520a1752191d50000201966710000100520000000000018000000000fc00
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] ExportChangesICS->InitializeExporter() successfully. 0 changes ready to sync for 'hierarchy'.
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O <FolderHierarchy:FolderSync>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O <FolderHierarchy:Status>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O 1
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O </FolderHierarchy:Status>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O <FolderHierarchy:SyncKey>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O {e16fa155-1857-4e87-8c4e-7bd97e8885c6}1
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O </FolderHierarchy:SyncKey>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O <FolderHierarchy:Changes>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O <FolderHierarchy:Count>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O 0
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O </FolderHierarchy:Count>
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O </FolderHierarchy:Changes>
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] DeviceManager->CheckFolderData() checking integrity of hierarchy cache with synchronized folders
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] ASDevice->GetHierarchyCache(): HierarchyCache is up - Cached objects: 15
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] O </FolderHierarchy:FolderSync>
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] WBXMLEncoder->endTag() WBXML output completed
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] WBXML-OUT: AwFqAAAHVkwDMQABUgN7ZTE2ZmExNTUtMTg1Ny00ZTg3LThjNGUtN2JkOTdlODg4NWM2fTEAAU5XAzAAAQEB
    01/07/2022 10:47:16 [20150] [WBXML] [didier.walraet@cpas-andenne.eu] WBXML-IN : AwFqAAAHVlIDe2UxNmZhMTU1LTE4NTctNGU4Ny04YzRlLTdiZDk3ZTg4ODVjNn0xAAEB
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] LoopDetection->ProcessLoopDetectionTerminate()
    01/07/2022 10:47:16 [20150] [ INFO] [didier.walraet@cpas-andenne.eu] cmd='FolderSync' memory='1.88 MiB/4.00 MiB' time='0.03s' devType='Android' devId='androidcxxxxxxxx' getUser='didier.walraet@cpas-andenne.eu' from='192.168.10.4' idle='0s' version='1.0.17' method='POST' httpcode='200'
    01/07/2022 10:47:16 [20150] [DEBUG] [didier.walraet@cpas-andenne.eu] -------- End
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] -------- Start
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] cmd='Sync' devType='Android' devId='androidcxxxxxxxxx' getUser='didier.walraet@cpas-andenne.eu' from='xxx.xxx.xxx.xxx' version='1.0.17' method='POST'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Used timezone 'Europe/Vienna'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio using PHP-MAPI version: 1.25.60.b49eb230c - PHP version: 7.4.6
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Request::ProcessHeaders() ASVersion: 14.1
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] GSync::CommandNeedsProvisioning(0): true
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] ProvisioningManager->ProvisioningRequired('xxxxxxxx') saved device key 'xxxxxxxxx': false
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] ProvisioningManager->ProvisioningRequired() saved policy hash '16e9d28d8d85649de7b4deb661ba5dc2' matches
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] GSync::CommandNeedsAuthentication(0): true
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->Logon(): Trying to authenticate user 'didier.walraet@cpas-andenne.eu'..
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->openMessageStore('didier.walraet@cpas-andenne.eu'): Found 'DEFAULT' store: 'Resource id #19'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->Logon(): User 'didier.walraet@cpas-andenne.eu' is authenticated
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Store supports properties containing Unicode characters.
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] GSync::HierarchyCommand(0): false
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->GetState(): top class 'ASDevice'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] GSync::CommandNeedsPlainInput(0): false
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <Synchronize>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <Folders>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <Folder>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <SyncKey>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I {1df1e2bc-5206-4ac9-8bc3-5da6d3516a0e}1
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </SyncKey>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <FolderId>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I U588a4
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </FolderId>
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->GetState(): top class 'SyncParameters'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): sub class 'ContentParameters'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] StateObject->jsonDeserialize(): sub class 'BodyPreference'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] DeviceManager->GetBackendIdForFolderId(): folderid U588a4 => 0d000000a5187b6fbcdcea1ed03c5657000000000012
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] SyncCollections->AddCollection(): Folder id 'U588a4' : ref. Lifetime '', last sync at ''
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <DeletesAsMoves/>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <GetChanges/>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <WindowSize>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I 10
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </WindowSize>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <Options>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <FilterType>
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] SyncParameters->UseCPO('DEFAULT')
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I 0
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </FilterType>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <AirSyncBase:BodyPreference>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <AirSyncBase:Type>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I 1
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </AirSyncBase:Type>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I <AirSyncBase:TruncationSize>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I 200000
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </AirSyncBase:TruncationSize>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </AirSyncBase:BodyPreference>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </Options>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </Folder>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </Folders>
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] I </Synchronize>
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] HandleSync(): Start Output
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] GSync::GetAdditionalSyncFolderStore('0d000000a5187b6fbcdcea1ed03c5657000000000012'): 'false'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] Grommunio->GetFolderStat() fetched status information of 32 folders for store 'didier.walraet@cpas-andenne.eu'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] SyncParameters->IsExporterRunRequired(): false - current: 1656073221/0/0/-1 - saved: 1656073221/0/0/-1 - expiring: 2022-07-28 10:34:54
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] HandleSync: No changes found for Tasks folder id 'U588a4'. Omitting output.
    01/07/2022 10:47:16 [20151] [WBXML] [didier.walraet@cpas-andenne.eu] WBXML-IN : AwFqAEVcT0sDezFkZjFlMmJjLTUyMDYtNGFjOS04YmMzLTVkYTZkMzUxNmEwZX0xAAFSA1U1ODhhNAABHhNVAzEwAAFXWAMwAAEAEUVGAzEAAUcDMjAwMDAwAAEBAQEBAQ==
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] LoopDetection->ProcessLoopDetectionTerminate()
    01/07/2022 10:47:16 [20151] [ INFO] [didier.walraet@cpas-andenne.eu] cmd='Sync' memory='1.84 MiB/2.00 MiB' time='0.02s' devType='Android' devId='androidcxxxxxxxx' getUser='didier.walraet@cpas-andenne.eu' from='192.168.10.4' idle='0s' version='1.0.17' method='POST' httpcode='200'
    01/07/2022 10:47:16 [20151] [DEBUG] [didier.walraet@cpas-andenne.eu] -------- End

    Best regards

      Hi @didier-walraet ,

      there were still a couple of deviceid entries in your post, I've anonymised them as well.

      The device sends its id in the request, so it's strange that it's not included in the response.

      Are there any OPTIONS requests in /var/log/grommunio-sync/grommunio-sync.log?

      andreaslang One possibility would be to remove the account on device, remove the device from the list in the admin UI and then create the account on the mobile again.

      Did you try exactly these steps?

          Hi @didier-walraet ,

          was there a "Success" snackbar after clicking on "Delete device" icon in the Admin UI? Were there any errors? What happens if you reload the "Mobile devices" tab in the Admin UI after removing the device?

            didier-walraet

            When you have deleted a device but not removed the account from the mobile that's normal. Your device still hat the account credentials and the device is reprovisioned. If you don't want that to happen, you can change the password of the account and then delete the device, hereafter your device won't show up anymore since it will not be able to authenticate anymore.

            • crpb replied to this.

                didier-walraet When I delete device from admin UI, I see success message, when reload mobile device tab, my device is always present.
                mwilliams

                Maybe he just means the same behavior as i have (had?):

                andreaslang crpb When i remove a Device in either the Web-UI or Admin-UI the Device wouldn't be listed in the Web-UI anymore but the Deviced ID is still listed in the Admin-UI without any other known facts.

                Shouldn't those devices be removed from the Admin-UI aswell? I tried Refresh/Relog/Reboot in case of "Browser-Cache-Issues" :-).

                Yes, they actually should be removed in the Admin-UI as well. We'll look into it. You have to be aware though, that simply removing device from a list doesn't prevent it from syncing again if the account is still configured on the device.

                        6 days later

                        Hi @didier-walraet ,

                        with grommunio-sync version 1.0.26-lp153.135.1 the MDM plugin should also list the mobile devices. We are still investigating the issue in the Admin UI.

                          2 months later

                          © 2020-2024 grommunio GmbH. All rights reserved. | https://grommunio.com | Data Protection | Legal notice