DP Exchange GRE "An error occurred while retrieving the backup versions available for restore"

Hello Expert,

CM= Windows 2012 R2, DP=9.08.113 build

clinet= WIndows 2008 R2, DP=9.08_113 build, Exchnage 2010

Trying to restore single mail uisng GRE but getting error as soon I select Database and click next it gives error as An error occurred while retrieving the backup versions available for restore.

Able to restore sucessfully from mbx1 but not from mbx2. Host is added in the userlist with SYSTEM NT AUTHORITY host fqdn.

Debug.log

017-04-03 12:28:24,198 - 5420 - (:0)
Begin : GetAllBackupVersionsForDatabaseImport
2017-04-03 12:28:47,774 - 8592 - (:0)
Begin : Ping
2017-04-03 12:28:48,008 - 8592 - (:0)
End : Ping
2017-04-03 12:29:44,647 - 5420 - ("trunk/ExchangeGre/src/WebSite/EchangeWCFClient/ExchangeWSAdapter.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
GetAllBackupVersionsForDatabaseImport Failed . ErrorDetail =

2017-04-03 12:29:44,647 - 5420 - (:0)
End : GetAllBackupVersionsForDatabaseImport
2017-04-03 12:29:44,647 - 5420 - ("trunk/ExchangeGre/src/GUI/MmcGui/src/Wizards/ImportWizard/UserControls/ImportBackupWizard_BackupVersionSelectScreen.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
Error getting backup versions for mailbox/database = 4GB-A, GreReturnCode = GRE_OBJECTSNOTFOUND,
m_errorDetail = No detail

Parents Reply Children
  • .Net change it v4, screenshot attached.

    Not much details in debug logs as well.

    debugs_GreGui.txt file says as:

    egin : RefreshBackupVersionSelectionScreen
    2017-04-03 15:23:50,771 - 7176 - ("trunk/ExchangeGre/src/GUI/MmcGui/src/Wizards/ImportWizard/UserControls/ImportBackupWizard_BackupVersionSelectScreen.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    Calling GetAllBackupVersionsForMailbox() on the database '2GB-C'

    2017-04-03 15:23:50,787 - 7176 - (:0)
    Begin : GetAllBackupVersionsForDatabaseImport
    2017-04-03 15:24:33,906 - 2808 - (:0)
    Begin : Ping
    2017-04-03 15:24:34,124 - 2808 - (:0)
    End : Ping
    2017-04-03 15:25:34,137 - 2808 - (:0)
    Begin : Ping
    2017-04-03 15:25:34,356 - 2808 - (:0)
    End : Ping
    2017-04-03 15:26:24,806 - 7176 - ("trunk/ExchangeGre/src/WebSite/EchangeWCFClient/ExchangeWSAdapter.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    GetAllBackupVersionsForDatabaseImport Failed . ErrorDetail =

    2017-04-03 15:26:24,806 - 7176 - (:0)
    End : GetAllBackupVersionsForDatabaseImport
    2017-04-03 15:26:24,806 - 7176 - ("trunk/ExchangeGre/src/GUI/MmcGui/src/Wizards/ImportWizard/UserControls/ImportBackupWizard_BackupVersionSelectScreen.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    Error getting backup versions for mailbox/database = 2GB-C, GreReturnCode = GRE_OBJECTSNOTFOUND,
    m_errorDetail = No detail

    2017-04-03 15:26:25,820 - 5432 - ("trunk/ExchangeGre/src/GUI/MmcGui/src/Wizards/ImportWizard/UserControls/ImportBackupWizard_BackupVersionSelectScreen.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    Error fetching the backup versions available, ProxyRetCode = GRE_OBJECTSNOTFOUND, ErrorDetail =

    2017-04-03 15:26:31,358 - 5432 - (:0)
    End : RefreshBackupVersionSelectionScreen
    2017-04-03 15:26:34,244 - 5432 - ("trunk/ExchangeGre/src/GUI/MmcGui/src/Wizards/ImportWizard/UserControls/ImportBackupWizard_BackupVersionSelectScreen.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    Call to cleanup import cache

    note_webService.txt file says as below:

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/DPFacade.cs $Rev: 1454 $ $Date:: 2016-01-26 07:55:37":0) 09.00.20088
    End : GetSessionsForLogAndFileObjects

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/Parser.cs $Rev: 1471 $ $Date:: 2016-03-11 08:25:30":0) 09.00.20088
    Begin : IsObjectsNotFound

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/Parser.cs $Rev: 1471 $ $Date:: 2016-03-11 08:25:30":0) 09.00.20088
    End : IsObjectsNotFound

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/DPFacade.cs $Rev: 1454 $ $Date:: 2016-01-26 07:55:37":0) 09.00.20088
    no objects found returned by omnidb

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/DPFacade.cs $Rev: 1454 $ $Date:: 2016-01-26 07:55:37":0) 09.00.20088
    End : GetBackupVersionsOfDatabaseBasedOnExchangeVersion

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/ProxyGenOperations.cs $Rev: 1455 $ $Date:: 2016-01-26 08:08:46":0) 09.00.20088
    End : GetAllBackupVersionsForDatabaseImport

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/WebSite/ExchangeGREWebService/ExchangeGREService.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    GetAllBackupVersionsForDatabaseImport Failed : Return Code = GRE_OBJECTSNOTFOUND, ErrorDetail =

  • do you get the objects when you run "omnidb -e2010" on your GRE host? 

  • Does your Windows Server use the English Localization ?

    From Installation Guide 9.08 Page 115:

    Other non-Data Protector software and services
    Install Windows PowerShell 1.0 or later (a Windows Management Framework Core package)
    Localization for PowerShell other than English is not supported (The Windows OS must use the English Localization).
    Keep the TCP/IP port 60000 (default) free for the Granular Recovery Web service.
    Configure a firewall to allow new ports.

  • Sorry for the delay in reply..

    markovdi,

    omnidb -e2010 list all objects on GRE host

    DiAc,

    I don't think there is any issue with windows server or firewall.... There is no firewall between CS & GRE host/firewall on GRE host, all the posts are open. I have restore using the same host in past many times using GRE and randomly keep getting error with GRE restore.. 

    I faced the same issue 1 year back and that time uninstall & install of DP on GRE resolve this issue.

    Thanks,

  • yet, you get this: 

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/DPFacade.cs $Rev: 1454 $ $Date:: 2016-01-26 07:55:37":0) 09.00.20088
    no objects found returned by omnidb

     

    Once you select the database it does something like this: 

    2017-04-05 11:40:27,511 - 12004 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088

    CommandBuilder : msg level : 0: msg : Start processing Command
    "omnidb" -e2010 "hostname:/c1844252-9061-449c-a513-97059e509127/testdb" -detail

    You can check it that's executed and what it returns in debugs_webservice.txt

  • The old logs shared was from debugs_GreGui.txt.

    debugs_webService.txt logs are below:

    CommandBuilder : msg level : 0: msg : Start processing Command
    "omnidb" -e2010 "skvmbx2:/Microsoft Exchange Writer(Exchange Information Store)/Microsoft Information Store/931e9ec8-e3b9-4f72-a0a6-180a720ae436/Logs" MSVSSW-APP -detail

    2017-04-03 15:25:46,493 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder : msg level : 0: msg : SUCCESS : stdin pipe creation

    2017-04-03 15:25:46,493 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder : msg level : 0: msg : SUCCESS : STDOUT STDERR single Handle created

    2017-04-03 15:25:46,493 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder : msg level : 0: msg : SUCCESS : stdin pipe creation

    2017-04-03 15:25:46,493 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder : msg level : 0: msg : SUCCESS : STDOUT STDERR single Handle created

    2017-04-03 15:25:46,493 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder : msg level : 2: msg : succesfully duplicated the token (2932),duplicatedtoken (1)

    2017-04-03 15:25:46,493 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder : msg level : 0: msg : SUCCESS : Process creation

    2017-04-03 15:25:46,493 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder : msg level : 1: msg : Process created : 6448

    2017-04-03 15:25:46,508 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder: Function End : ExecuteCmd

    2017-04-03 15:25:46,508 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder: Function End : BuildExecute

    2017-04-03 15:25:46,508 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder: Function Start : ReadProcessOutput 1

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder : msg level : 0: msg : Total Bytes recived : 24

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    CommandBuilder: Function End : ReadProcessOutput 1

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/DPFacade.cs $Rev: 1454 $ $Date:: 2016-01-26 07:55:37":0) 09.00.20088
    End : GetSessionsForLogAndFileObjects

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/Parser.cs $Rev: 1471 $ $Date:: 2016-03-11 08:25:30":0) 09.00.20088
    Begin : IsObjectsNotFound

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/Parser.cs $Rev: 1471 $ $Date:: 2016-03-11 08:25:30":0) 09.00.20088
    End : IsObjectsNotFound

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/DPFacade.cs $Rev: 1454 $ $Date:: 2016-01-26 07:55:37":0) 09.00.20088
    no objects found returned by omnidb

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/DPFacade.cs $Rev: 1454 $ $Date:: 2016-01-26 07:55:37":0) 09.00.20088
    End : GetBackupVersionsOfDatabaseBasedOnExchangeVersion

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/ProxyGenOperations.cs $Rev: 1455 $ $Date:: 2016-01-26 08:08:46":0) 09.00.20088
    End : GetAllBackupVersionsForDatabaseImport

    2017-04-03 15:26:24,291 - 7600 - ("trunk/ExchangeGre/src/WebSite/ExchangeGREWebService/ExchangeGREService.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    GetAllBackupVersionsForDatabaseImport Failed : Return Code = GRE_OBJECTSNOTFOUND, ErrorDetail =

    2017-04-03 15:26:34,260 - 5116 - ("trunk/ExchangeGre/src/WebSite/ExchangeGREWebService/ExchangeGREService.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    Begin 'ExchangeGREService.CleanUpImportCache' method

    2017-04-03 15:26:34,275 - 5116 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/DataContainerForImportFromBackup.cs $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20088
    Begin : ClearCache

  • ok, this executed manually then returns nothing? 

    omnidb -e2010 "skvmbx2:/Microsoft Exchange Writer(Exchange Information Store)/Microsoft Information Store/931e9ec8-e3b9-4f72-a0a6-180a720ae436/Logs" MSVSSW-APP -detail

    Which would mean logs object for that database is missing in backups. 

  • Hi,

    But I am able to restore same databse backup from other exchange node.

  • is that another node in same dag? is it executing same  omnidb command when you check debugs_webService.txt ? 

  • yes, the other node is in same dag.

    omnidb command check o/p fron mode1 as follows:

    2017-04-06 15:12:11,196 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder : msg level : 0: msg : Start processing Command
    "omnidb" -e2010 "skmbx1.emaarec.com:/Microsoft Exchange Writer(Exchange Information Store)/Microsoft Information Store/f1d2e92b-2f61-4912-817e-118323e97470/File" MSVSSW-APP -detail

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder : msg level : 0: msg : SUCCESS : stdin pipe creation

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder : msg level : 0: msg : SUCCESS : STDOUT STDERR single Handle created

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder : msg level : 0: msg : SUCCESS : stdin pipe creation

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder : msg level : 0: msg : SUCCESS : STDOUT STDERR single Handle created

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder : msg level : 2: msg : succesfully duplicated the token (4584),duplicatedtoken (1)

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder : msg level : 0: msg : SUCCESS : Process creation

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder : msg level : 1: msg : Process created : 16228

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder: Function End : ExecuteCmd

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder: Function End : BuildExecute

    2017-04-06 15:12:11,212 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder: Function Start : ReadProcessOutput 1

    2017-04-06 15:12:40,803 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder : msg level : 0: msg : Total Bytes recived : 15266

    2017-04-06 15:12:40,803 - 25200 - ("trunk/ExchangeGre/src/Infrastructure/CommandBuilderWrapper/CommandBuilderWrapper.cpp $Rev: 1444 $ $Date:: 2015-10-20 07:40:53":0) 09.00.20288
    CommandBuilder: Function End : ReadProcessOutput 1

    2017-04-06 15:12:40,803 - 25200 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/DPFacade.cs $Rev: 1454 $ $Date:: 2016-01-26 07:55:37":0) 09.00.20288
    End : GetSessionsForLogAndFileObjects

    2017-04-06 15:12:40,803 - 25200 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/Parser.cs $Rev: 1471 $ $Date:: 2016-03-11 08:25:30":0) 09.00.20288
    Begin : IsObjectsNotFound

    2017-04-06 15:12:40,803 - 25200 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/Parser.cs $Rev: 1471 $ $Date:: 2016-03-11 08:25:30":0) 09.00.20288
    End : IsObjectsNotFound

    2017-04-06 15:12:40,803 - 25200 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/Parser.cs $Rev: 1471 $ $Date:: 2016-03-11 08:25:30":0) 09.00.20288
    Begin : GetSessionDetailsForObject

    2017-04-06 15:12:40,803 - 25200 - ("trunk/ExchangeGre/src/proxy/ExchangeProxy/Parser.cs $Rev: 1471 $ $Date:: 2016-03-11 08:25:30":0) 09.00.20288
    input string :
    SessionID : 2017/03/31-65
    Started at : Friday, March 31, 2017, 7:00:10 PM
    Finished at : Saturday, April 01, 2017, 12:24:05 AM
    Object status : Completed
    Object size : 243150913 KB
    Backup type : Full
    Protection : Protected for 52 weeks
    Catalog retention : Protected for 52 weeks
    Version type : Normal
    Access : Public
    Number of warnings : 0
    Number of errors : 0
    Device name : HP:Ultrium 5-SCSI_2_skdp
    Backup ID : 2017/03/31-39
    Copy ID : FBFAE4DB-E2FC-4769-8E78-9C89C8CDF7F6/2058303 (Copy)
    Encrypted : No

    And it continues with all the session ID details like above