8 Replies Latest reply on May 7, 2018 3:52 AM by bomber1

    Client Sync schlägt fehl - "Bad document format"

    Rookie

      Hallo Zusammen,

       

      vielleicht kann mir jemand bei diesem Fehlerbild weiterhelfen. Wir hatten bis dato einige wenige Fälle dieses Sync Problems, aber keine alternative Lösung, als

      das DSM Objekt komplett neu anzulegen und eine Neuinstallation des Rechners vorzunehmen.

       

      Der besagte Client lief bis vor ein paar Tagen völlig unaufällig und erhielt alle Policies. Nun schlägt der Sync fehl, weil offenbar das Sync Archiv nicht korrekt gelesen werden kann.

       

      Folgende Lösungsversuche brachten keinen Erfolg:

       

      - Löschen des Sync Ordners auf dem Client

       

      ============================================================================================

      Eintäge aus dem NISRV32.log

      ________________________________________________________________________________________________

      04:19:40.634 2     Retrieving login information from xnidNT32.dll (NT-Server, LAN-Manager, LAN-Server)

      04:19:42.996 2     WkstaGroups :

      04:19:43.030 2  SWMSRT: Initializing SWMSRunTimeMgr

      04:19:47.093 2    SWMSRT: Could not get all needed ClientObjects!

      04:19:47.094 2   SWMSRT: Performing client sync for computer '226973' and user '302' with QoS level 'Polling'

      04:20:18.827 E   Warning (Module:SWMSClntLib, Severity:0x03): Failed to synchronize with BLS

      Bad document format. (0xe0080711)

      04:20:18.828 E   Warning (Module:SWMSRT, Severity:0x03): Client sync () failed [-536344815]

      04:20:18.831 E   Warning (Module:SWMSRT, Severity:0x03): ClientSync failed with error code 3758622481

      Bad document format. (0xe0080711)

      04:20:18.833 2   SWMSRT: Client sync for computer '226973' and user '302' (QoS level 'Polling') failed with 'Bad document format. (0xe0080711)' (3758622481)

      04:20:18.833 E   Warning (Module:SWMSRT, Severity:0x03): The initialize synchronization failed

      04:20:18.835 E   Warning (Module:Main, Severity:0x03): Initialization of TargetProvider SWMSTP failed!

      ________________________________________________________________________________________________

      Einträge aus dem PerformSync_AGG.log

       

      09:44.23.030  0 syncserv.dll    :"NI","Version":"7.3.0.3181"},"LocalTime":"2017-07-12T09:44:23+02:00","ServerInfo":{"CmdbGuid":"{45CAD71B-E4F9-4918-9C2E-04E9129DDD3C}","MetaModelVers

      09:44.23.030  0 syncserv.dll    ion":0},"UserCulture":"en"},"UserRevisions":{}}

      09:44.23.046  2 CMSClntLib.dll  Calling 'http://XXXX.XXX.ads.XXX:8080/blsClientManagement/ClientService.svc/Sync?qos=0'

      09:44.23.623  0 HttpSupport.dll  Request was compressed by 82 percent. Compressed size 15920 bytes. Uncompressed size 84147 bytes

      09:44.23.623  2 CMSClntLib.dll  Webservice call suceeded with status code 200

      09:44.23.623  0 syncserv.dll  HTTP status of sync request is 200

      09:44.23.638  0 syncserv.dll  Archiver command line is nisyncar.exe "C:\Program Files (x86)\Common Files\enteo\sync\archive" "C:\Windows\Temp\JARC7A7.tmp" 25920000000000 sync_ SyncLogs\nisyncar

      09:44.23.638  0 syncserv.dll  Successfully launched archiver process

      09:44.23.638  2 syncserv.dll  The response from the server is not a valid document

       

      Vorab vielen Dank für jede Unterstützung!

       

      Schönen Gruß

       

      Carsten

        • 1. Re: Client Sync schlägt fehl - "Bad document format"
          swabedoo Apprentice

          Hallo Carsten,

           

          stelle die Frage bitte im Subspace DSM (https://community.ivanti.com/community/heat-software/desktop-server-management-dsm-powered-by-heat), sonst wird sie nur per Zufall gefunden.

           

          Danke,

          swabedoo

          • 2. Re: Client Sync schlägt fehl - "Bad document format"
            _Mel_ Master

            sowas hatte ich vor einer weile mal.

            ich meine das problem war, daß ein device objekt einen ungültigen namen hatte.

            schau mal im syncarchiv die response vom server an und such darin mal nach "\0" (ohne die anführungszeichen)

            wenn es das ist, dann mach ein supportticket auf, die müssen das in der datenbank fixen

            • 3. Re: Client Sync schlägt fehl - "Bad document format"
              KaiNitzsche Apprentice

              Hi.

               

               

              Ich hänge mich mal hier dran, da ich eben auf einen PC gestoßen bin, der ein ähnliches Problem hat. Wir sind aktuell auf 2016.2 R2 und ich habe einen Computer welche keine Software mehr installiert, letzter DSM-Sync war am 13.11.. Schaue ich in die Logs auf dem Client sehe ich folgende Fehler:

               

               

              11:08:33.423 E   Warning (Module:SWMSClntLib, Severity:0x03): Failed to synchronize with BLS

              Das Dokument hat kein gültiges Format. (0xe0080711)

              11:08:33.424 E   Warning (Module:SWMSRT, Severity:0x03): Client sync () failed [-536344815]

              11:08:33.425 E   Warning (Module:SWMSRT, Severity:0x03): ClientSync failed with error code 3758622481

              Das Dokument hat kein gültiges Format. (0xe0080711)

              11:08:33.426 2   SWMSRT: Client sync for computer '89395' and user '89979' (QoS level 'Polling') failed with 'Das Dokument hat kein gültiges Format. (0xe0080711)' (3758622481)

              11:08:33.427 2   SWMSRT: Installer will wait for Packages that are not yet downloaded.

              11:08:33.427 1   SWMSRT: Reporting of user parts is not configured - choosing default for workstations

              11:08:33.427 1   SWMSRT: Reporting of user parts is enabled for local profiles.

              11:08:33.427 1   SWMSRT: ODS Variable: The user is not allowed to delay the installer run

              11:08:33.427 1   SWMSRT: ODS Variable: Reboot/logoff negotiation timeout dialog is shown infinite until the user dismisses it

              11:08:33.427 1   SWMSRT: ODS Variable: No reboot/logoff will be performed if the user does not react within time

              11:08:33.427 1   SWMSRT: ODS Variable: No notifications on Window 8 desktop will be shown

              11:08:33.427 E   Warning (Module:SWMSRT, Severity:0x03): The client sync failed. The installer will still continue to work on the cache only.

               

               

              Wie von Mel empfohlen habe ich mal in das Sync-Archiv geschaut, dort finde ich in der Tat den String \0, nämlich hier:

               

               

              "1817572":{

                    "Properties":{

                      "Association":{

                        "SourceObjectId":89215,

                        "TargetObjectId":68813,

                        "TargetSchemaTag":"Device"

                      },

                      "Base":{

                        "CreationDate":"2015-04-02T01:17:28Z"

                      },

                      "ComputerDevice":{

                        "InstanceId":"ACPI_HAL\\PNP0C08\\0"

                      }

                    },

                    "Rev":"1:1",

                    "Schema":"ComputerDevice"

                  },

               

               

              IMHO bezieht sich der Eintrag auf ein anderes Computer-Objekt, da die ID für den betreffenden PC "89395" lautet.

              Hat jemand Ideen?

               

              Viele Grüße

              Kai

              • 4. Re: Client Sync schlägt fehl - "Bad document format"
                _Mel_ Master

                evtl war der computrer früher mal ein anderes computerobjekt und das zeug von damals steht noch im cache, weil er für das neue keinen sync durchbekommt ?

                das interessante ist die reply vom server, denn dort müßten die ungültigen zeichen drin stehen.

                 

                "\\0" ist ok, das ist einfach nur die json-codierung für "\0"

                aber "\0" ohne einen \ vor dem \ wäre die json-codierung für das NULL zeichen und das kommt in C-strings nicht so gut, weil es da das zeichen für das ende des strings ist.

                • 5. Re: Client Sync schlägt fehl - "Bad document format"
                  KaiNitzsche Apprentice

                  Hi.

                   

                  Das Computerobjekt ist sein Februar 2016 das gleiche, wir benennen auch prinzipiell keine um, daher würde ich das als Fehler ausschließen. Wo finde ich das Reply vom Server?

                   

                   

                  Danke Kai

                  • 6. Re: Client Sync schlägt fehl - "Bad document format"
                    _Mel_ Master

                    C:\Program Files (x86)\Common Files\enteo\sync\archive

                    da drin sind zips von jedem sync was der inhalt des caches war und was gesendet wurde und was vom bls zurückkam

                    • 7. Re: Client Sync schlägt fehl - "Bad document format"
                      KaiNitzsche Apprentice

                      Mal noch als späte Rückmeldung, da leider der Nutzer und der Laptop "verschollen" waren:

                       

                      Das Problem war ein zu alter DSM-Stand auf dem Laptop. Was ich nicht wusste, bevor das Problem auftrat, war der Laptop mehrere Monate nicht im Netz und hatte wohl so auch den Umzug von BLS und Depot mitbekommen. Nach einer händischen Aktualisierung des DSM-Clients, funktionierte auch die Softwareinstallation normal.

                       

                       

                      Ich wünsche euch ein schönes Weihnachtsfest und danke euch für euren Super-Support für alle Probleme und Problechen rund um DSM.

                       

                      Viele Grüße

                      Kai

                      • 8. Re: Client Sync schlägt fehl - "Bad document format"
                        bomber1 Apprentice

                        Hallo,

                         

                        ich hänge mich hier auch mal dran. Von ca. 500 Clients habe ich bei ca. 150 jetzt auch das Problem, dass der Installationsstatus eines neuen Pakets nicht mehr zurückgemeldet wird. Die Installation hat aber statt gefunden.

                        Eine neue Revision eines alten Pakets anlegen und verteilen funktioniert dagegen. Der Compliance Status wird hier normal zurück gemeldet.

                        Wir haben eine relativ alte Version von DSM im Einsatz (2014.1) und wollen auch bald updaten. Das Update bei uns ist aber immer ein riesen Akt, weil wir eine nicht supportete Umgebung betreiben. (z.b. Managment-Point in den Außenstellen auf einem Windows 7 Client, SAMBA NT Workgroup in den Außenstellen mit Depot).

                        Ich erhalte auf dem Client immer eine Fehlermeldung vom BLS:

                        Auf einem Client wo der Synch nicht läuft bekomme ich folgende Meldung:

                        Command UpdatePolicyInstancesCommand failed with exception Property 'Base.CreationDate' not found

                         

                        Client Sync-Log:

                        10:13.32.467  0 ICDBHlp.dll  Only one MgntPoint is in the list for Random selection, select this [66032]

                        10:13.32.467  0 ICDBHlp.dll  Selected management point 66032, determining URL

                        10:13.32.467  0 ICDBHlp.dll  Creating new URL cache entry for Management Point 66032

                        10:13.32.467  0 ICDBHlp.dll  Caching and returning new 'blsClientManagement' URL 'http://NETINSTALL.example.com:8080/blsClientManagement/' for Management Point 66032

                        10:13.32.467  2 CMSClntLib.dll  Using [http://NETINSTALL.example.com:8080/blsClientManagement/ClientManagementService.asmx] for communication with the BL

                        10:13.32.467  2 CMSClntLib.dll  Or using [http://NETINSTALL.examle.com:8080/blsClientManagement/ClientService.svc/] for communication with the BL

                        10:13.32.467  2 CMSClntLib.dll  Calling 'http://NETINSTALL.example.com:8080/blsClientManagement/ClientService.svc/Sync?qos=10'

                        10:13.34.823  0 HttpSupport.dll  Request was compressed by 41 percent. Compressed size 1391 bytes. Uncompressed size 2355 bytes

                        10:13.34.823  2 CMSClntLib.dll  Webservice call suceeded with status code 200

                        10:13.34.823  0 syncserv.dll  HTTP status of sync request is 200

                        10:13.34.839  0 syncserv.dll  Archiver command line is nisyncar.exe "C:\Program Files (x86)\Common Files\enteo\sync\archive" "C:\Windows\Temp\JARABAC.tmp" 25920000000000 sync_ SyncLogs\nisyncar

                        10:13.34.839  0 syncserv.dll  Successfully launched archiver process

                        10:13.34.839  2 syncserv.dll  The BLS says: Command UpdatePolicyInstancesCommand failed with exception Property 'Base.CreationDate' not found., see server logs for details

                        10:13.34.839  0 syncserv.dll  Logging 'SyncResponse' document now

                        10:13.34.854  0 syncserv.dll  Document 'SyncResponse' has been logged into log file C:\Program Files (x86)\Common Files\enteo\NiLogs\SyncLogs\SyncResponse_SYSTEM_0000055745.log

                        10:13.34.854  0 syncserv.dll  Updating sync cache

                        10:13.35.010  0 syncserv.dll  moving files...

                         

                         

                        Und im BLS:

                        2018-05-07 10:13:27,909 [934] ERROR Enteo.BlServer.ClientManagement - UpdatePolicyInstancesCommand failed. Continuing with next command.

                        System.Collections.Generic.KeyNotFoundException: Property 'Base.CreationDate' not found.

                           at Enteo.Mds.Synchronization.Types.VirtualPropertyHashList.get_Item(IPropertyKey propertyKey)

                           at Enteo.BlServer.Base.ClientManagement.SynchronizationCommands.UpdateVirtualObjectsCommandBase.WritePropertiesJson(SynchronizationData syncData, IVirtualObject existingObject, ObjectDelta updatedObject)

                           at Enteo.BlServer.Swms.ClientManagement.Commands.UpdatePolicyInstancesCommand.WriteProperties(SynchronizationData syncData, IVirtualObject existingObject, ObjectDelta updatedObject)

                           at Enteo.BlServer.Base.ClientManagement.SynchronizationCommands.UpdateVirtualObjectsCommandBase.TryUpdateObject(SynchronizationData syncData, IDictionary`2 reloadedObjects, ObjectDelta updatedObject)

                           at System.Collections.Generic.List`1.ForEach(Action`1 action)

                           at Enteo.BlServer.Base.ClientManagement.SynchronizationCommands.UpdateVirtualObjectsCommandBase.Execute(SynchronizationData syncData)

                           at Enteo.BlServer.Base.ClientManagement.CommandInfrastructure.SynchronizationInvoker.ExecuteSingleCommand(ISynchronizationCommand command, SynchronizationData data)

                           at Enteo.BlServer.Base.ClientManagement.CommandInfrastructure.InvokerBase`2.Execute(TData data)

                        2018-05-07 10:13:28,166 [934] INFO  Enteo.BlServer.Summary - 10.124.224.24 Anonymous en 302ms NI 7.2.3.2582 Sync [AutoInstaller] (Computer 29586, User 29592, 201 Changes, 2737 Revs)

                        2018-05-07 10:13:33,873 [934] ERROR Enteo.BlServer.ClientManagement - UpdatePolicyInstancesCommand failed. Continuing with next command.

                        System.Collections.Generic.KeyNotFoundException: Property 'Base.CreationDate' not found.

                           at Enteo.Mds.Synchronization.Types.VirtualPropertyHashList.get_Item(IPropertyKey propertyKey)

                           at Enteo.BlServer.Base.ClientManagement.SynchronizationCommands.UpdateVirtualObjectsCommandBase.WritePropertiesJson(SynchronizationData syncData, IVirtualObject existingObject, ObjectDelta updatedObject)

                           at Enteo.BlServer.Swms.ClientManagement.Commands.UpdatePolicyInstancesCommand.WriteProperties(SynchronizationData syncData, IVirtualObject existingObject, ObjectDelta updatedObject)

                           at Enteo.BlServer.Base.ClientManagement.SynchronizationCommands.UpdateVirtualObjectsCommandBase.TryUpdateObject(SynchronizationData syncData, IDictionary`2 reloadedObjects, ObjectDelta updatedObject)

                           at System.Collections.Generic.List`1.ForEach(Action`1 action)

                           at Enteo.BlServer.Base.ClientManagement.SynchronizationCommands.UpdateVirtualObjectsCommandBase.Execute(SynchronizationData syncData)

                           at Enteo.BlServer.Base.ClientManagement.CommandInfrastructure.SynchronizationInvoker.ExecuteSingleCommand(ISynchronizationCommand command, SynchronizationData data)

                           at Enteo.BlServer.Base.ClientManagement.CommandInfrastructure.InvokerBase`2.Execute(TData data)

                         

                        Weiß jemand was es mit der Property 'Base.CreationDate' auf sich hat?

                         

                        Gruß

                        Klaus