5 Replies Latest reply on Sep 21, 2017 5:44 AM by phoffmann

    SWD LDMS 10 Download Error 105 (12)

    CKuhl Apprentice

      Good Morning Guys!

       

      Edit: Masked Hostnames

       

      We upgeraded from LDMS 9.6 to IEM 10.1. We got one core and serverall NAS as prefered server in other locations.

      Now i got an odd problem with the download of files from the NAS. Interesstingly, the package for the RC Viewer 10 Works, but old Packages can´t be downloaded.

      These files are all in the same share and i tested that the configured user got access to the files. (UNC and HTTP).

      Oddly the new package works, but the old once doesn´t. In other locations they are working fine.

      Also we configured, that the core can´t be used als fall back to reudce the load on the WAN connection.

      It seems to me that the client isn´t even trying to download the file and i have hit a wall.

      I compared the HASH in the xml file on the prefered server and in the database and they are all the same. I realy don´t see the reason, why i isn´t working.

       

      Best Regards and thanks the help in advance

       

      Carsten

       

      Here is the xtracelog:

       

      Wed, 20 Sep 2017 18:47:42 GetFileInformation results: time: low B457A580 high 1D15753, size 40102072
      Wed, 20 Sep 2017 18:47:42 Updating system environment variable LDMS_PREFERRED_SERVER: RONAS.FQDN
      Wed, 20 Sep 2017 18:47:42 LDRedirectFilePath: SUCCESS redirected from http://IEMServerLDMS.FQDN/LDMS-STAB/SWD/Microsoft/VSTOR/10.0.6/files/vstor_redist.exe to http://RONAS.stab.corp.local/LDMS-STAB/SWD/Microsoft/VSTOR/10.0.6/files/vstor_redist.exe
      Wed, 20 Sep 2017 18:47:42 GetFileHashFromServerW called for http://RONAS.FQDN/LDMS-STAB/SWD/Microsoft/VSTOR/10.0.6/files/vstor_redist.exe
      Wed, 20 Sep 2017 18:47:42 GetFileInformation called for http://RONAS.FQDN/LDMS-STAB/SWD/Microsoft/VSTOR/10.0.6/files/LDHashDir/vstor_redist.exe.hash.xml
      Wed, 20 Sep 2017 18:47:42 Initialize curl using user supplied proxy 127.0.0.1:9592
      Wed, 20 Sep 2017 18:47:42 Curl INFO: Found bundle for host RONAS.FQDN: 0x638a20

      Wed, 20 Sep 2017 18:47:42 Curl INFO: Re-using existing connection! (#0) with host 127.0.0.1

      Wed, 20 Sep 2017 18:47:42 Curl INFO: Connected to 127.0.0.1 (127.0.0.1) port 9592 (#0)

      Wed, 20 Sep 2017 18:47:42 Curl REQUEST:
      HEAD http://RONAS.FQDN/LDMS-STAB/SWD/Microsoft/VSTOR/10.0.6/files/LDHashDir/vstor_redist.exe.hash.xml HTTP/1.1

      User-Agent: LANDeskDownloader

      Host: RONAS.FQDN

      Accept: */*

      Proxy-Connection: Keep-Alive

       

      Wed, 20 Sep 2017 18:47:42 Curl INFO: Server nginx is not blacklisted

      Wed, 20 Sep 2017 18:47:42 Curl INFO: Connection #0 to host 127.0.0.1 left intact

      Wed, 20 Sep 2017 18:47:42 GetFileInformation results: time: low EBDB7300 high 1D15948, size 253
      Wed, 20 Sep 2017 18:47:42 Initialize curl using user supplied proxy 127.0.0.1:9592
      Wed, 20 Sep 2017 18:47:42 CURLOPT_FILE, hashFileBuffer
      Wed, 20 Sep 2017 18:47:42 Downloading byte range - '0-252'
      Wed, 20 Sep 2017 18:47:42 Curl INFO: Found bundle for host RONAS.FQDN: 0x638a20

      Wed, 20 Sep 2017 18:47:42 Curl INFO: Re-using existing connection! (#0) with host 127.0.0.1

      Wed, 20 Sep 2017 18:47:42 Curl INFO: Connected to 127.0.0.1 (127.0.0.1) port 9592 (#0)

      Wed, 20 Sep 2017 18:47:42 Curl REQUEST:
      GET http://RONAS.FQDN/LDMS-STAB/SWD/Microsoft/VSTOR/10.0.6/files/LDHashDir/vstor_redist.exe.hash.xml HTTP/1.1

      Range: bytes=0-252

      User-Agent: LANDeskDownloader

      Host: RONAS.FQDN

      Accept: */*

      Proxy-Connection: Keep-Alive

       

      Wed, 20 Sep 2017 18:47:42 Curl INFO: Server nginx is not blacklisted

      Wed, 20 Sep 2017 18:47:42 Curl INFO: Connection #0 to host 127.0.0.1 left intact

      Wed, 20 Sep 2017 18:47:42 Download failed unable to get path, error code: 12 file: http://IEMServerLDMS.FQDN/LDMS-STAB/SWD/Microsoft/VSTOR/10.0.6/files/vstor_redist.exe
      Wed, 20 Sep 2017 18:47:42 Pushing http://IEMServerLDMS.FQDN/LDMS-STAB/SWD/Microsoft/VSTOR/10.0.6/files/vstor_redist.exe to done
      Wed, 20 Sep 2017 18:47:42 Download Error: err=12, path=http://IEMServerLDMS.FQDN/LDMS-STAB/SWD/Microsoft/VSTOR/10.0.6/files/vstor_redist.exe
      Wed, 20 Sep 2017 18:47:42 PushToDoneTail: m_fileDoneCount = 2, m_fileCount = 0
      Wed, 20 Sep 2017 18:47:42 About to release m_workCompleteSemaphore
      Wed, 20 Sep 2017 18:47:42 ReceiveFilesWorkerThread finished
      Wed, 20 Sep 2017 18:47:42 Download Complete: 1 successful, 1 failed
      Wed, 20 Sep 2017 18:47:42 Actual download of data took 0 ms, but slept 0 ms of that time, 0.000000 bandwidth used
      Wed, 20 Sep 2017 18:47:42 Push of files took 0 ms, but slept 0 ms of that time, 0.000000 bandwidth used
      Wed, 20 Sep 2017 18:47:43 DiscoveryWorkerThread: thread 3248 exiting
      Wed, 20 Sep 2017 18:47:43 processing of package is complete, result -1918107543 (0x8dac0069 - code 105)

        • 1. Re: SWD LDMS 10 Download Error 105 (12)
          Markus.Gonser ITSMMVPGroup

          Hi CKuhl,

           

          please reset the package hash and check it again.

           

          best regards

          Markus

          • 2. Re: SWD LDMS 10 Download Error 105 (12)
            CKuhl Apprentice

            Hi Markus.Gonser,

             

            What I did:

             

            1. Reset Package Hash

            2. Started Content replication

            3. Scheduled the package and run it.

             

            this time it downloaded the powershell file. But the exe is still missing.... Just confirmed that

             

            Thu, 21 Sep 2017 10:42:50 ******* sdclient starting to process task *******
            Thu, 21 Sep 2017 10:42:50 Task id to process: 9140
            Thu, 21 Sep 2017 10:42:50 Command line: /policyfile="C:\ProgramData\LANDesk\Policies\CP.9140.RunNow._DsA5GkmyalcO+3YZ56PssLnFseI=.xml"
            Thu, 21 Sep 2017 10:42:50 The nostatus flag has NOT been set.
            Thu, 21 Sep 2017 10:42:50 Core name 'IEMServer.FQDN' obtained from the registry
            Thu, 21 Sep 2017 10:42:50 Sending task status, cmd line -coreandip=IEMServer.FQDN -taskid=9140 -retcode=229392442 -pkgid=785
            Thu, 21 Sep 2017 10:42:52 GetCurrentHashForFile: GetFileStatsW failed with %d
            Thu, 21 Sep 2017 10:42:52 GetFilePrevCountExWork: failed to get a hash of the file
            Thu, 21 Sep 2017 10:42:52 IsFileInCache: Cache2.GetFilePrevCountEx failed - path=\\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1
            Thu, 21 Sep 2017 10:42:52 File (\\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1) is not in cache
            Thu, 21 Sep 2017 10:42:52 Top of InitCurl
            Thu, 21 Sep 2017 10:42:52 Top of InitCurl
            Thu, 21 Sep 2017 10:42:52 Initialize curl using user supplied proxy 127.0.0.1:9592
            Thu, 21 Sep 2017 10:42:52 The nostatus flag has NOT been set.
            Thu, 21 Sep 2017 10:42:52 Core name 'IEMServer.FQDN' obtained from the registry
            Thu, 21 Sep 2017 10:42:52 Sending task status, cmd line -coreandip=IEMServer.FQDN -taskid=9140 -retcode=229392444 -pkgid=785
            Thu, 21 Sep 2017 10:42:54 AddFileToDownloadSet (utf8):called with sourcePath \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1, hash 8zA7BHfiySPgGu4XHuiUCmNL6P+XHHMkiz+NLUre20U=
            Thu, 21 Sep 2017 10:42:54 AddFileToDownloadSet (utf8):called with sourcePath \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe, hash w04Dwk7qAfkNV5ZJDziCKITeen2jQjJSbnKP/IBzwqE=
            Thu, 21 Sep 2017 10:42:54 About to call DownloadFiles (2 files) with these settings:
            Thu, 21 Sep 2017 10:42:54 m_allowedBandwidthWAN: 50
            Thu, 21 Sep 2017 10:42:54 m_allowedBandwidthLAN: 75
            Thu, 21 Sep 2017 10:42:54 m_discardPeriodSeconds: 604800
            Thu, 21 Sep 2017 10:42:54 m_preserveDirectoryStructure: 1
            Thu, 21 Sep 2017 10:42:54 m_bUseWanBWForPush: 0
            Thu, 21 Sep 2017 10:42:54 m_bSynchronize: 0
            Thu, 21 Sep 2017 10:42:54 Allowed download methods(m_downloadControl):
            Thu, 21 Sep 2017 10:42:54 PeerOneSource
            Thu, 21 Sep 2017 10:42:54 Peer
            Thu, 21 Sep 2017 10:42:54 Source
            Thu, 21 Sep 2017 10:42:54 m_preferredServerControl: RequirePreferredServer
            Thu, 21 Sep 2017 10:42:54 ReceiveFilesWorkerThread started
            Thu, 21 Sep 2017 10:42:54 ListenForDiscoveryUpdates started
            Thu, 21 Sep 2017 10:42:54 DiscoveryWorkerThread started
            Thu, 21 Sep 2017 10:42:54 DoSingleThreadedPreDownloadWork: Top of function
            Thu, 21 Sep 2017 10:42:54 ReceiveMessageThread started
            Thu, 21 Sep 2017 10:42:55 Thread 4956 is processing \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1
            Thu, 21 Sep 2017 10:42:55 GetCurrentHashForFile: GetFileStatsW failed with %d
            Thu, 21 Sep 2017 10:42:55 GetFilePrevCountExWork: failed to get a hash of the file
            Thu, 21 Sep 2017 10:42:55 GetFilePrevCountEx returned -2 where -3 = whole file, -2 = none, and >=0 = part, for file: LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1
            Thu, 21 Sep 2017 10:42:55 Thread 4956 is processing \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:42:55 GetFilePrevCountEx returned -2 where -3 = whole file, -2 = none, and >=0 = part, for file: LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:42:55 ReceiveFilesWorkerThreadWork: Processing next file (order index=0) \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1
            Thu, 21 Sep 2017 10:42:55 receiveCommand = from peer for LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1
            Thu, 21 Sep 2017 10:42:55 ReceiveMessageThread started
            Thu, 21 Sep 2017 10:42:55 Got PeerCount of 1 for LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1
            Thu, 21 Sep 2017 10:42:55 DownloadFileFromPeer - ConnectToValidAddressEx 10.40.20.118 for \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1 took 1 ms
            Thu, 21 Sep 2017 10:42:55 SAD ProcessNeedFileReply about to download LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1 from peer 10.40.20.118
            Thu, 21 Sep 2017 10:42:55 GetCurrentHashForFile: GetFileStatsW failed with %d
            Thu, 21 Sep 2017 10:42:55 GetFilePrevCountExWork: failed to get a hash of the file
            Thu, 21 Sep 2017 10:42:55 GetFilePrevCountEx returned -2 where -3 = whole file, -2 = none, and >=0 = part, for file: LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1
            Thu, 21 Sep 2017 10:42:55 Discard period of 604800 will be set for this file
            Thu, 21 Sep 2017 10:42:55 Checking free disk space for 'C:\Program Files\LANDesk\LDClient\sdmcache\': total free 26204581888, needed 20224, reserved 10485760)
            Thu, 21 Sep 2017 10:42:55 There is sufficent available space
            Thu, 21 Sep 2017 10:42:55 Sleep top:deltaTimeNotSleptYet = 0.000000
            Thu, 21 Sep 2017 10:42:55 curSleep using performance counter delta time=19.693495 (measured=19.693495, excluded=0.000000)
            Thu, 21 Sep 2017 10:42:55 Bandwidth sleep calculation: inputs lastReadTimeMS=19.693495, _bandwidth=75, returning 6.564498
            Thu, 21 Sep 2017 10:42:55 Attempted sleep of 6.564498, actually slept 0.002095
            Thu, 21 Sep 2017 10:42:55 SAD ProcessNeedFileReply - GetFileFromPeerInternal for \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1 returned(0) took 25 ms
            Thu, 21 Sep 2017 10:42:55 DownloadFileFromPeersLoop: returning 0
            Thu, 21 Sep 2017 10:42:55 DownloadFileFromPeersLoop returned 0 for LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1
            Thu, 21 Sep 2017 10:42:55 Calculating new hash for LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1 since file time changed
            Thu, 21 Sep 2017 10:42:55 Pushing \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\install.ps1 to done
            Thu, 21 Sep 2017 10:42:55 PushToDoneTail: m_fileDoneCount = 1, m_fileCount = 1
            Thu, 21 Sep 2017 10:43:07 ReceiveFilesWorkerThreadWork: Processing next file (order index=1) \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:43:07 receiveCommand = from source for LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:43:07 PeerOneSourceRequired was set, attempting peer even though command was download from source
            Thu, 21 Sep 2017 10:43:07 GetPeerListForFile: ReceiveMessageFromSocket timed out, socket receive timeout =10, i = 0, additionalTimeSlept = 0
            Thu, 21 Sep 2017 10:43:07 GetPeerListForFile: ReceiveMessageFromSocket timed out, socket receive timeout =10, i = 1, additionalTimeSlept = 10
            Thu, 21 Sep 2017 10:43:07 Got PeerCount of 0 for LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:43:07 Command was source: About to download from source
            Thu, 21 Sep 2017 10:43:07 GetFileInformation called for \\RONASNAS.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:43:07 Top of InitCurl
            Thu, 21 Sep 2017 10:43:07 Initialize curl using user supplied proxy 127.0.0.1:9592
            Thu, 21 Sep 2017 10:43:07 Curl INFO: Hostname was NOT found in DNS cache

            Thu, 21 Sep 2017 10:43:07 Curl INFO:   Trying 127.0.0.1...

            Thu, 21 Sep 2017 10:43:07 Curl INFO: Connected to 127.0.0.1 (127.0.0.1) port 9592 (#0)

            Thu, 21 Sep 2017 10:43:07 Curl REQUEST:
            POST http://IEMServer.FQDN:443/LANDesk/managementsuite/core/serverauthentication/serverauthentication.asmx HTTP/1.1

            User-Agent: LANDeskDownloader

            Host: IEMServer.FQDN:443

            Accept: */*

            Proxy-Connection: Keep-Alive

            Content-Type: text/xml; charset=utf-8

            Content-Length: 420

            SOAPAction: "http://tempuri.org/GetCredentials2"

            Thu, 21 Sep 2017 10:43:07 Curl TRANSMIT: 420 bytes
            Thu, 21 Sep 2017 10:43:07 Curl INFO: upload completely sent off: 420 out of 420 bytes

            Thu, 21 Sep 2017 10:43:09 Curl INFO: Server Microsoft-IIS/10.0 is not blacklisted

            Thu, 21 Sep 2017 10:43:09 Curl INFO: Connection #0 to host 127.0.0.1 left intact

            Thu, 21 Sep 2017 10:43:09 GetFileInformation results: time: low B46B322D high 1D15753, size 40102072
            Thu, 21 Sep 2017 10:43:09 Updating system environment variable LDMS_PREFERRED_SERVER: RONAS.FQDN
            Thu, 21 Sep 2017 10:43:09 LDRedirectFilePath: SUCCESS redirected from \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe to \\RONAS.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:43:09 GetFileHashFromServerW called for \\RONAS.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:43:09 Download failed unable to get path, error code: 12 file: \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:43:09 Pushing \\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe to done
            Thu, 21 Sep 2017 10:43:09 Download Error: err=12, path=\\IEMServer.FQDN\LDMS-STAB\SWD\Microsoft\VSTOR\10.0.6\files\vstor_redist.exe
            Thu, 21 Sep 2017 10:43:09 PushToDoneTail: m_fileDoneCount = 2, m_fileCount = 0
            Thu, 21 Sep 2017 10:43:09 About to release m_workCompleteSemaphore
            Thu, 21 Sep 2017 10:43:09 ReceiveFilesWorkerThread finished
            Thu, 21 Sep 2017 10:43:09 DiscoveryWorkerThread: thread 4956 exiting
            Thu, 21 Sep 2017 10:43:09 Download Complete: 1 successful, 1 failed
            Thu, 21 Sep 2017 10:43:09 Actual download of data took 25 ms, but slept 0 ms of that time, 100.000000 bandwidth used
            Thu, 21 Sep 2017 10:43:09 Push of files took 0 ms, but slept 0 ms of that time, 0.000000 bandwidth used
            Thu, 21 Sep 2017 10:43:10 processing of package is complete, result -1918107543 (0x8dac0069 - code 105)

            • 3. Re: SWD LDMS 10 Download Error 105 (12)
              Markus.Gonser ITSMMVPGroup

              HI CKuhl,

               

              did you verified that the file is on the depot nas available?

              It could be possible, that the content replication has not replicated all data to the nas storage.

               

              best regards

              Markus

              • 4. Re: SWD LDMS 10 Download Error 105 (12)
                CKuhl Apprentice

                Hi Markus.Gonser ,

                 

                I found the "problem". I deleted the LDHashDir folder on the NAS and not it works.... I don´t quite understand why this caused the problem...

                 

                Best Regards

                 

                Carsten

                • 5. Re: SWD LDMS 10 Download Error 105 (12)
                  phoffmann SupportEmployee

                  Sounds like one of the files on the NAS changed after ist has was calculated.

                   

                  Maybe an aggressive AV (or some other script) poked it open & changed something (we've seen that sometimes. Even things like "opening a file in NOTEPAD" can sometimes change something in a file, even though you don't actually save anything -- that was fun to figure out with log-files from MAC-s for instance). Windows does it itself at times (which is fun & unexpected... ).

                   

                  Logically, that'd be at least consistent with what you were seeing. So - if that happened, not sure how good your auditing options are, but maybe you'll be able to trace / figure out what poked the file(s) in question & changed something in them?