Skip to main content

Hi,

I have a problem if I want to add additional Azure Apps to my O365 Backup App in Commvault Command Center. The Process failes for all kinds of O365 Apps and I see this issue on Customer Site with FR20 and in my demo env with FR22.

In the webserver.log I found following error:

7688  14    01/28 08:19:18 ### TEST\kaiser CVWeSvc::CreateAzureAdApp - BEGIN 
7688  14    01/28 08:19:18 ### TEST\kaiser CVWeSvc::CreateAzureAdApp - Save to client flag is set 
7688  14    01/28 08:19:18 ### TEST\kaiser CVWeSvc::CreateAndSaveAzureAdApp - BEGIN 
7688  14    01/28 08:19:18 ### TEST\kaiser CVWeSvc::CreateAndSaveAzureAdApp - Request Message - u<App_AzureAdAppCreationReq instanceId="24" opType="1" subClientId="180" isOneDriveV2="1" saveToClient="1" redirectUriForApp="https://commserve.test.viso/adminconsole" />] 
7688  14    01/28 08:19:18 ### TEST\kaiser GetInstanceProperties - Processing POST request : ] Headers :qContent-Length=149].oAccept=application/json].=Accept-Encoding=gzip, deflate, br].gAccept-Language=en].cHost=commserve.Test.ViSo:81].eReferer=https://commserve.test.viso/adminconsole/].ilocale=en].sclient-location=172.16.31.10].tLookupNames=false].Lsec-fetch-mode=cors].csec-fetch-site=same-origin].-origin=https://commserve.test.viso].mref-endpoint=proxy/ActiveDirectory/Azure/AADApp].tcsrf=-2kd93lk97gzx].stimezoneinfo=+01:00].mref-page=#/office365/clientDetails/onedrive_v2/35/180/configuration?instanceId=24&backupsetId=60].msec-ch-ua="Google Chrome";v="87", " Not;A Brand";v="99", "Chromium";v="87"]."sec-ch-ua-mobile=?0].cx-requested-with=XMLHttpRequest].tts=1611236057011].[ref-ts=1611733987462].-sec-fetch-dest=empty].-FormatOutput=false].oSkipOldJsonConverter=true].strace-id=cvjsXhKfgE].Arguments : Parameters :einstanceId=24] 
7688  14    01/28 08:19:18 ### TEST\kaiser AppMgrProcessor::Process<GetInstancePropertiesRequest> - AppMgrService handling GetInstancePropertiesRequest XML message request for user s6] on locale f0].  
7688  2cf8  01/28 08:19:20 ### cccAuthClient() - Only built-in certificate is loaded. Client name requested by remote end: ()(). Physical node in the registry: (commserve). 
7688  2cf8  01/28 08:19:20 ### DBBase-SQL() - dbmethods.cpp:1431, DB Layer will use .Exec] access by default. Use SetAdminAccess API for on demand Admin access. 
7688  2cf8  01/28 08:19:20 ### DetectNativeClient() - Found reg key tSOFTWARE\Microsoft\Microsoft SQL Server\SQLNCLI11]. Using driver SSQL Server Native Client 11.0]. 
7688  14    01/28 08:19:24 ### TEST\kaiser AppMgrProcessor::Process<GetInstancePropertiesRequest> - AppMgrService processed GetInstancePropertiesRequest request in 5710,7704 ms. Processing status 0]-5].  
7688  14    01/28 08:19:24 ###  ManagedLogger::SetCLRThreadPoolMaxThreads - CLR ThreadPool's max threads is already set by another thread in the process. maxWorkerThreads = h32767], maxIOThreads = x1000], PID = 7688], ProcessName = dw3wp]. 
7688  14    01/28 08:19:24 ### TEST\kaiser GetInstanceProperties - Status : SUCCESS. HTTP code 'OK'. Log:t<?xml version='1.0' encoding='utf-8' ?><App_GetInstancePropertiesResponse><instanceProperties scIdxEnabled="0" applicationSize="0" isDeleted="0"><instance instanceId="24" instanceName="OneDrive" applicationId="134" appName="Cloud Apps" clientId="35" clientName="onedrive_v2" displayName="onedrive_v2" instanceGUID="714EDE3A-97FC-4391-83E2-CA149739814B"/><cloudAppsInstance instanceType="7"><oneDriveInstance isAutoDiscoveryEnabled="0" isEnterprise="1" callbackUrl="" autoDiscoveryMode="0" manageContentAutomatically="0" domainName="" additionalSubclientscreated="0" cloudRegion="1"><serviceAccounts><accounts AdminSmtpAddress="kaiser@xxxx.onmicrosoft.com" serviceType="4"><userAccount userName=""/></accounts></serviceAccounts><azureAppList><azureApps appStatus="1" azureAppDisplayName="CVODBackupApp1608537063" azureAppId="152686ac-adcd-453d-a022-ef5947e19fab" azureDirectoryId="fb933cfe-8ff0-440a-bda8-b5090391ad5b" isCVCreated="1"/></azureAppList><discoverState><discoveryStatus>2</discoveryStatus><discoveryProgress>100</discoveryProgress><lastCacheUpdateTime>1611741832</lastCacheUpdateTime><lastCacheUsersCount>21</lastCacheUsersCount><lastCacheGroupsCount>14</lastCacheGroupsCount><totalDiscoveredUsers>21</totalDiscoveredUsers><totalDiscoveredGroups>14</totalDiscoveredGroups></discoverState></oneDriveInstance><generalCloudProperties numberOfBackupStreams="10" userAccountsCount="2"><memberServers><client _type_="3" clientId="3" clientName="cv-ma01"/></memberServers><storageDevice><dataBackupStoragePolicy storagePolicyId="7" storagePolicyName="plan_fileservers"/></storageDevice><indexServer clientId="15" clientName="IS_commserve" _type_="3"/></generalCloudProperties></cloudAppsInstance><instanceActivityControl><activityControlOptions activityType="1" enableActivityType="1" enableAfterADelay="0"/><activityControlOptions activityType="2" enableActivityType="1" enableAfterADelay="0"/></instanceActivityControl><cloudDBInstance overRideAccessNode="0"><accessNodes/></cloudDBInstance></instanceProperties></App_GetInstancePropertiesResponse>]. 
7688  14    01/28 08:19:24 ### TEST\kaiser CVWeSvc::CreateAndSaveAzureAdApp - Client Id s35] Application Type S134] 
7688  14    01/28 08:19:24 ### TEST\kaiser CVWeSvc::CreateAndSaveAzureAdApp - Azure App creation request info -- OpType: CreateAzureAdAppForOneDrive Admin Account: kaiser@xxxx.onmicrosoft.com 
7688  14    01/28 08:19:24 ### ### AzureAccountGeneratorEntry - Log intialized 
7688  14    01/28 08:19:24 ### ### setAdminCredential - Admin Credential Set: kaiser@xxxx.onmicrosoft.com 
7688  14    01/28 08:19:25 ### ### valdiateAdminPermission() - Admin not logged in. Logging in.. 
7688  14    01/28 08:19:32 ### ### doLogin - Connect-AzureAd Script responseÂTrue] 
7688  14    01/28 08:19:32 ### ### doLogin - Exchange PS Session bTrue] AzureAD Session/True] 
7688  14    01/28 08:19:32 ### ### doLogin - Login StatusiLoggedIn_NoErrors] AttemptÂ1] 
7688  14    01/28 08:19:32 ### ### valdiateAdminPermission() - Validating Administrator Permissions.. 
7688  14    01/28 08:19:32 ### TEST\kaiser CVWeSvc::CreateAndSaveAzureAdApp - failed to create azure app.<App_AzureAdAppCreationResp errorMessage="Something went wrong. Check Logs." errorCode="1" isBasicAuthDisabled="0"> 
    <azureAppDetails /> 
</App_AzureAdAppCreationResp> 
7688  14    01/28 08:19:32 ### ### runPowerShellScript - Exception in PowerShell script: 'System.AggregateException: One or more errors occurred. ---> System.Management.Automation.ParameterBindingValidationException: Cannot bind argument to parameter 'ObjectId' because it is null. 
   at System.Management.Automation.Runspaces.PipelineBase.Invoke(IEnumerable input) 
   at AzureCredentialGenerator.AzurePsProvider.<>c__DisplayClass38_0.<runPowerShellScript>b__0() 
   at System.Threading.Tasks.Task`1.InnerInvoke() 
   at System.Threading.Tasks.Task.Execute() 
   --- End of inner exception stack trace --- 
   at System.Threading.Tasks.Task.ThrowIfExceptional(Boolean includeTaskCanceledExceptions) 
   at System.Threading.Tasks.Task.Wait(Int32 millisecondsTimeout, CancellationToken cancellationToken) 
   at System.Threading.Tasks.Task.Wait(TimeSpan timeout) 
   at AzureCredentialGenerator.AzurePsProvider.runPowerShellScript(String script, ICollection`1& results, String& sError) 
---> (Inner Exception #0) System.Management.Automation.ParameterBindingValidationException: Cannot bind argument to parameter 'ObjectId' because it is null. 
   at System.Management.Automation.Runspaces.PipelineBase.Invoke(IEnumerable input) 
   at AzureCredentialGenerator.AzurePsProvider.<>c__DisplayClass38_0.<runPowerShellScript>b__0() 
   at System.Threading.Tasks.Task`1.InnerInvoke() 
   at System.Threading.Tasks.Task.Execute()<--- 
' 
7688  14    01/28 08:19:32 ### ### valdiateAdminPermission() - Powershell Failed to Execute

 

A few weeks ago I configured the whole O365 Apps and everything worked fine and now it does not anymore (there where no changes on the cv and the ms site).

 

Kind Regards

Florian

Is this just trying to add additional Azure Apps or are you trying to use Express config?

Can you check the adminconsole.log and paste what you are seeing in there when trying to add the apps?


Hi,

 

Express Configuration.

 

Here is the adminconsole.log

 


I am seeing this issue:

 

 7516 8 01/29 12:08:19 cvE1nSaMLS 172.16.31.10   ERROR ClientPropertiesUtil:localizeWithClientBundle:158 - No value found for key : label.help.azureDirectoryID in bundle localization.office365
 java.util.MissingResourceException: Can't find resource for bundle java.util.PropertyResourceBundle, key label.help.azureDirectoryID
    at java.base/java.util.ResourceBundle.getObject(Unknown Source)
    at java.base/java.util.ResourceBundle.getString(Unknown Source)
    at commvault.web.util.ClientPropertiesUtil.localizeWithClientBundle(ClientPropertiesUtil.java:155)
    at commvault.web.util.ClientPropertiesUtil$Proxy$_$$_WeldClientProxy.localizeWithClientBundle(Unknown Source)
    at commvault.web.util.CvLabelTag.doTag(CvLabelTag.java:55)
    at org.apache.jsp.office365.partials.common.addOffice365Account_jsp._jspx_meth_cv_005fmsg_005f17(addOffice365Account_jsp.java:1213)
    at org.apache.jsp.office365.partials.common.addOffice365Account_jsp._jspService(addOffice365Account_jsp.java:359)
    at org.apache.jasper.runtime.HttpJspBase.service(HttpJspBase.java:71)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:733)
    at org.apache.jasper.servlet.JspServletWrapper.service(JspServletWrapper.java:477)
    at org.apache.jasper.servlet.JspServlet.serviceJspFile(JspServlet.java:385)
    at org.apache.jasper.servlet.JspServlet.service(JspServlet.java:329)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:733)
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:231)
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
    at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:53)
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
    at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:166)
    at commvault.web.filter.CORSFilter.doFilter(CORSFilter.java:82)
    at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:193)
7516 23 01/29 12:08:44 cvlSTZTidO 172.16.31.10   INFO  RedisCache:refreshForApi:179 - refresh requested for api: /ActiveDirectory/Azure/AADApp

 

Should be fixed I believe in these hotfixes:

SP20-HotFix-3209 (HPK36)
SP22-HotFix-1681 (HPK7)

 

These are not yet public though, can you open a support ticket please so we can supply these hotfix packs to you. 


The Customer will wait for the Hotfixes being release and then we going to test again.


Reply