Open wahyuen opened 1 year ago
Hi @wahyuen thanks for reporting. I noticed that the "operation status could not be de-serialized" error you mentioned did not show up in the debug output. Instead, the debug output was about "The operation failed because resource is in the: 'Failed' state.". Were they two different issues with different reproduce steps? If so, could you share the reproduce steps and debug log of the "could not be de-serialized" error?
@isra-fel I'm not entirely sure why it doesn't show up in the debug log. This is what we get as output when debug log is NOT turned on. These are not separate issues from our perspective, we just ran the same command with debug output turned on
@isra-fel I mentioned this error to the Managed Applications product team and they will also review this issue.
I verified the same error when I deployed a managed application with the -Debug
parameter. The command returned the error New-AzManagedApplication: The operation failed because the operation status could not be de-serialized
in the debug log and on the command line. The managed application's deployment appeared to be successful. There were no resources that showed being in a failed state and I didn't find any deployment errors in the Azure Activity Logs.
Version Name
------- ----
6.5.1 Az.Resources
9.3.0 Az
Name Value
---- -----
PSVersion 7.3.3
Noting this is still broken in v9.5.0
Anyone can share the full debug log?
I cannot reproduce the could not be de-serialized
issue.
Rerun today on v9.5.0, sensitive information sanitised
❯ New-AzManagedApplication -Name sozewahtestapp -Kind ServiceCatalog -ResourceGroupName soze-wahtest-arg -Location australiaeast -ManagedApplicationDefinitionId /subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef -ManagedResourceGroupName soze-wahtest-mrg
DEBUG: 1:02:52 PM - NewAzureManagedApplicationCmdlet begin processing with ParameterSet '__AllParameterSets'.
DEBUG: 1:02:52 PM - using account id 'sanitised'...
DEBUG: 1:02:52 PM - [ConfigManager] Got nothing from [DisplayBreakingChangeWarning], Module = [], Cmdlet = []. Returning default value [True].
DEBUG: [Common.Authentication]: Authenticating using Account: 'sanitised', environment: 'AzureCloud', tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf'
DEBUG: 1:02:52 PM - [ConfigManager] Got [True] from [EnableLoginByWam], Module = [], Cmdlet = [].
DEBUG: 1:02:52 PM - [SilentAuthenticator] Calling SharedTokenCacheCredential.GetTokenAsync - TenantId:'11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', Scopes:'https://management.core.windows.net//.default', AuthorityHost:'https://login.microsoftonline.com/', UserId:'sanitised'
DEBUG: SharedTokenCacheCredential.GetToken invoked. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 4e7d6329-511c-4ed8-ae81-248561520d67] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 4e7d6329-511c-4ed8-ae81-248561520d67] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 4e7d6329-511c-4ed8-ae81-248561520d67] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 4e7d6329-511c-4ed8-ae81-248561520d67] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 4e7d6329-511c-4ed8-ae81-248561520d67] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z] [WamBroker] WAM supported OS.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z] [WamBroker] ListWindowsWorkAndSchoolAccounts option was not enabled.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - ce987109-7408-4571-aec4-8329e0118f8d] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z] Found 1 cache accounts and 0 broker accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z] Returning 1 accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] MSAL MSAL.NetCore with assembly version '4.49.1.0'. CorrelationId(0d8b7648-2d1c-4fee-8812-5a24b0328c75)
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] === AcquireTokenSilent Parameters ===
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] LoginHint provided: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] Account provided: True
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] ForceRefresh: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75]
=== Request Data ===
Authority Provided? - True
Scopes - https://management.core.windows.net//.default
Extra Query Params Keys (space separated) -
ApiId - AcquireTokenSilent
IsConfidentialClient - False
SendX5C - False
LoginHint ? False
IsBrokerConfigured - True
HomeAccountId - False
CorrelationId - 0d8b7648-2d1c-4fee-8812-5a24b0328c75
UserAssertion set: False
LongRunningOboCacheKey set: False
Region configured:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] === Token Acquisition (SilentRequest) started:
Scopes: https://management.core.windows.net//.default
Authority Host: login.microsoftonline.com
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] Access token is not expired. Returning the found cache entry. [Current time (03/20/2023 05:02:52) - Expiration Time (03/20/2023 05:34:54 +00:00) - Extended Expiration Time (03/20/2023 04:14:03 +00:00)]
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] Returning access token found in cache. RefreshOn exists ? False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75]
=== Token Acquisition finished successfully:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:52Z - 0d8b7648-2d1c-4fee-8812-5a24b0328c75] AT expiration time: 20/03/2023 5:34:54 AM +00:00, scopes: https://management.core.windows.net//user_impersonation https://management.core.windows.net//.default. source: Cache
DEBUG: SharedTokenCacheCredential.GetToken succeeded. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId: ExpiresOn: 2023-03-20T05:34:54.0000000+00:00
DEBUG: [Common.Authentication]: Received token with LoginType 'User', Tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', UserId: 'sanitised'
DEBUG: ============================ HTTP REQUEST ============================
HTTP Method:
PUT
Absolute Uri:
https://management.azure.com/subscriptions/sanitised/resourcegroups/soze-wahtest-arg/providers/Microsoft.Solutions/applications/sozewahtestapp?api-version=2017-09-01
Headers:
User-Agent : PSVersion/v7.3.3,AzurePowershell/v9.5.0,Az.Resources/6.5.3
ParameterSetName : __AllParameterSets
CommandName : New-AzManagedApplication
Body:
{
"name": "sozewahtestapp",
"location": "australiaeast",
"properties": {
"managedResourceGroupId": "/subscriptions/sanitised/resourcegroups/soze-wahtest-mrg",
"applicationDefinitionId": "/subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef"
},
"kind": "ServiceCatalog"
}
DEBUG: ============================ HTTP RESPONSE ============================
Status Code:
Created
Headers:
Cache-Control : no-cache
Pragma : no-cache
ETag : "22022ac4-0000-1b00-0000-6417e9030000"
x-ms-ratelimit-remaining-subscription-writes: 1199
x-ms-providerhub-traffic : True
mise-correlation-id : 914e33bb-1fed-4a4d-a515-5f0b6768d93e
x-ms-request-id : 0bf8a1c6-02ca-4945-88b1-a3066bc8ba50
x-ms-client-request-id : 263b7f68-9cd3-4500-9fd2-0da45be43b5b
Azure-AsyncOperation : https://management.azure.com/subscriptions/sanitised/providers/Microsoft.Solutions/locations/AUSTRALIAEAST/operationStatuses/5be76d27-9e10-4fd7-a262-a8d43e93ae2d*549261CFD619DD855786B889300461C8CC26392E748AE12A5B2910DE2274B989?api-version=2017-09-01
x-ms-correlation-request-id : 3746b76e-1a32-4cba-b3d6-c2e25291a350
x-ms-routing-request-id : AUSTRALIASOUTHEAST:20230320T050259Z:3746b76e-1a32-4cba-b3d6-c2e25291a350
Strict-Transport-Security : max-age=31536000; includeSubDomains
X-Content-Type-Options : nosniff
Date : Mon, 20 Mar 2023 05:02:59 GMT
Body:
{
"id": "/subscriptions/sanitised/resourceGroups/soze-wahtest-arg/providers/Microsoft.Solutions/applications/sozewahtestapp",
"name": "sozewahtestapp",
"type": "microsoft.solutions/applications",
"kind": "ServiceCatalog",
"location": "australiaeast",
"etag": "\"2202c5ba-0000-1b00-0000-6417de260000\"",
"systemData": {
"createdBy": "hong.wahyuen@modis.com",
"createdByType": "User",
"createdAt": "2023-03-17T02:09:10.4045195Z",
"lastModifiedBy": "hong.wahyuen@modis.com",
"lastModifiedByType": "User",
"lastModifiedAt": "2023-03-20T05:02:53.3917561Z"
},
"properties": {
"managedResourceGroupId": "/subscriptions/sanitised/resourcegroups/soze-wahtest-mrg",
"applicationDefinitionId": "/subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef",
"publisherPackageId": "/subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef",
"provisioningState": "Accepted"
}
}
DEBUG: [Common.Authentication]: Authenticating using Account: 'sanitised', environment: 'AzureCloud', tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf'
DEBUG: 1:02:59 PM - [ConfigManager] Got [True] from [EnableLoginByWam], Module = [], Cmdlet = [].
DEBUG: 1:02:59 PM - [SilentAuthenticator] Calling SharedTokenCacheCredential.GetTokenAsync - TenantId:'11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', Scopes:'https://management.core.windows.net//.default', AuthorityHost:'https://login.microsoftonline.com/', UserId:'sanitised'
DEBUG: SharedTokenCacheCredential.GetToken invoked. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - dec1a393-82b1-4a86-bd5f-fe8e7294e380] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - dec1a393-82b1-4a86-bd5f-fe8e7294e380] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - dec1a393-82b1-4a86-bd5f-fe8e7294e380] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - dec1a393-82b1-4a86-bd5f-fe8e7294e380] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - dec1a393-82b1-4a86-bd5f-fe8e7294e380] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z] [WamBroker] WAM supported OS.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z] [WamBroker] ListWindowsWorkAndSchoolAccounts option was not enabled.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 592b0bbc-e4ea-446a-a69e-5004ed04d91a] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z] Found 1 cache accounts and 0 broker accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z] Returning 1 accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] MSAL MSAL.NetCore with assembly version '4.49.1.0'. CorrelationId(0001daf0-77c6-40c1-8a43-c15df7f9696b)
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] === AcquireTokenSilent Parameters ===
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] LoginHint provided: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] Account provided: True
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] ForceRefresh: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b]
=== Request Data ===
Authority Provided? - True
Scopes - https://management.core.windows.net//.default
Extra Query Params Keys (space separated) -
ApiId - AcquireTokenSilent
IsConfidentialClient - False
SendX5C - False
LoginHint ? False
IsBrokerConfigured - True
HomeAccountId - False
CorrelationId - 0001daf0-77c6-40c1-8a43-c15df7f9696b
UserAssertion set: False
LongRunningOboCacheKey set: False
Region configured:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] === Token Acquisition (SilentRequest) started:
Scopes: https://management.core.windows.net//.default
Authority Host: login.microsoftonline.com
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] Access token is not expired. Returning the found cache entry. [Current time (03/20/2023 05:02:59) - Expiration Time (03/20/2023 05:34:54 +00:00) - Extended Expiration Time (03/20/2023 04:14:03 +00:00)]
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] Returning access token found in cache. RefreshOn exists ? False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b]
=== Token Acquisition finished successfully:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 0001daf0-77c6-40c1-8a43-c15df7f9696b] AT expiration time: 20/03/2023 5:34:54 AM +00:00, scopes: https://management.core.windows.net//user_impersonation https://management.core.windows.net//.default. source: Cache
DEBUG: SharedTokenCacheCredential.GetToken succeeded. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId: ExpiresOn: 2023-03-20T05:34:54.0000000+00:00
DEBUG: [Common.Authentication]: Received token with LoginType 'User', Tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', UserId: 'sanitised'
DEBUG: [Common.Authentication]: Authenticating using Account: 'sanitised', environment: 'AzureCloud', tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf'
DEBUG: 1:02:59 PM - [ConfigManager] Got [True] from [EnableLoginByWam], Module = [], Cmdlet = [].
DEBUG: 1:02:59 PM - [SilentAuthenticator] Calling SharedTokenCacheCredential.GetTokenAsync - TenantId:'11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', Scopes:'https://management.core.windows.net//.default', AuthorityHost:'https://login.microsoftonline.com/', UserId:'sanitised'
DEBUG: SharedTokenCacheCredential.GetToken invoked. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 41b15c7a-95a4-41d7-84d5-29c9de18e3f9] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 41b15c7a-95a4-41d7-84d5-29c9de18e3f9] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 41b15c7a-95a4-41d7-84d5-29c9de18e3f9] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 41b15c7a-95a4-41d7-84d5-29c9de18e3f9] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 41b15c7a-95a4-41d7-84d5-29c9de18e3f9] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z] [WamBroker] WAM supported OS.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z] [WamBroker] ListWindowsWorkAndSchoolAccounts option was not enabled.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 98b46fb7-2274-41c7-8752-5b3d1cc79202] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z] Found 1 cache accounts and 0 broker accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z] Returning 1 accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] MSAL MSAL.NetCore with assembly version '4.49.1.0'. CorrelationId(4a861142-6d3e-44af-93dc-e1769eb1758b)
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] === AcquireTokenSilent Parameters ===
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] LoginHint provided: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] Account provided: True
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] ForceRefresh: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b]
=== Request Data ===
Authority Provided? - True
Scopes - https://management.core.windows.net//.default
Extra Query Params Keys (space separated) -
ApiId - AcquireTokenSilent
IsConfidentialClient - False
SendX5C - False
LoginHint ? False
IsBrokerConfigured - True
HomeAccountId - False
CorrelationId - 4a861142-6d3e-44af-93dc-e1769eb1758b
UserAssertion set: False
LongRunningOboCacheKey set: False
Region configured:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] === Token Acquisition (SilentRequest) started:
Scopes: https://management.core.windows.net//.default
Authority Host: login.microsoftonline.com
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] Access token is not expired. Returning the found cache entry. [Current time (03/20/2023 05:02:59) - Expiration Time (03/20/2023 05:34:54 +00:00) - Extended Expiration Time (03/20/2023 04:14:03 +00:00)]
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] Returning access token found in cache. RefreshOn exists ? False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b]
=== Token Acquisition finished successfully:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:02:59Z - 4a861142-6d3e-44af-93dc-e1769eb1758b] AT expiration time: 20/03/2023 5:34:54 AM +00:00, scopes: https://management.core.windows.net//user_impersonation https://management.core.windows.net//.default. source: Cache
DEBUG: SharedTokenCacheCredential.GetToken succeeded. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId: ExpiresOn: 2023-03-20T05:34:54.0000000+00:00
DEBUG: [Common.Authentication]: Received token with LoginType 'User', Tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', UserId: 'sanitised'
DEBUG: ============================ HTTP REQUEST ============================
HTTP Method:
GET
Absolute Uri:
https://management.azure.com/subscriptions/sanitised/providers/Microsoft.Solutions/locations/AUSTRALIAEAST/operationStatuses/5be76d27-9e10-4fd7-a262-a8d43e93ae2d*549261CFD619DD855786B889300461C8CC26392E748AE12A5B2910DE2274B989?api-version=2017-09-01
Headers:
User-Agent : PSVersion/v7.3.3,AzurePowershell/v9.5.0,Az.Resources/6.5.3
ParameterSetName : __AllParameterSets
CommandName : New-AzManagedApplication
Body:
DEBUG: ============================ HTTP RESPONSE ============================
Status Code:
OK
Headers:
Cache-Control : no-cache
Pragma : no-cache
ETag : "1c00e6fb-0000-1b00-0000-6417e9010000"
x-ms-ratelimit-remaining-subscription-reads: 11996
x-ms-request-id : 062cabe7-eada-47c2-82ad-edb060924097
x-ms-correlation-request-id : 30d999b2-85a2-4d1e-be13-ca5229868d44
x-ms-routing-request-id : AUSTRALIASOUTHEAST:20230320T050300Z:30d999b2-85a2-4d1e-be13-ca5229868d44
Strict-Transport-Security : max-age=31536000; includeSubDomains
X-Content-Type-Options : nosniff
Date : Mon, 20 Mar 2023 05:02:59 GMT
Body:
{
"id": "/subscriptions/sanitised/providers/Microsoft.Solutions/locations/AUSTRALIAEAST/operationStatuses/5be76d27-9e10-4fd7-a262-a8d43e93ae2d*549261CFD619DD855786B889300461C8CC26392E748AE12A5B2910DE2274B989",
"name": "5be76d27-9e10-4fd7-a262-a8d43e93ae2d*549261CFD619DD855786B889300461C8CC26392E748AE12A5B2910DE2274B989",
"resourceId": "/subscriptions/sanitised/resourceGroups/soze-wahtest-arg/providers/Microsoft.Solutions/applications/sozewahtestapp",
"status": "Accepted",
"startTime": "2023-03-20T05:02:56.7891367Z"
}
DEBUG: [Common.Authentication]: Authenticating using Account: 'sanitised', environment: 'AzureCloud', tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf'
DEBUG: 1:03:00 PM - [ConfigManager] Got [True] from [EnableLoginByWam], Module = [], Cmdlet = [].
DEBUG: 1:03:00 PM - [SilentAuthenticator] Calling SharedTokenCacheCredential.GetTokenAsync - TenantId:'11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', Scopes:'https://management.core.windows.net//.default', AuthorityHost:'https://login.microsoftonline.com/', UserId:'sanitised'
DEBUG: SharedTokenCacheCredential.GetToken invoked. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 31bf89dc-2fa1-4f98-8a1c-3fa663593431] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 31bf89dc-2fa1-4f98-8a1c-3fa663593431] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 31bf89dc-2fa1-4f98-8a1c-3fa663593431] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 31bf89dc-2fa1-4f98-8a1c-3fa663593431] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 31bf89dc-2fa1-4f98-8a1c-3fa663593431] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z] [WamBroker] WAM supported OS.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z] [WamBroker] ListWindowsWorkAndSchoolAccounts option was not enabled.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 8b5a7fab-f0f9-4fd0-87a5-ded086c880d5] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z] Found 1 cache accounts and 0 broker accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z] Returning 1 accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] MSAL MSAL.NetCore with assembly version '4.49.1.0'. CorrelationId(854f14eb-9b93-4c3c-a802-714c29b5da03)
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] === AcquireTokenSilent Parameters ===
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] LoginHint provided: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] Account provided: True
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] ForceRefresh: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03]
=== Request Data ===
Authority Provided? - True
Scopes - https://management.core.windows.net//.default
Extra Query Params Keys (space separated) -
ApiId - AcquireTokenSilent
IsConfidentialClient - False
SendX5C - False
LoginHint ? False
IsBrokerConfigured - True
HomeAccountId - False
CorrelationId - 854f14eb-9b93-4c3c-a802-714c29b5da03
UserAssertion set: False
LongRunningOboCacheKey set: False
Region configured:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] === Token Acquisition (SilentRequest) started:
Scopes: https://management.core.windows.net//.default
Authority Host: login.microsoftonline.com
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] Access token is not expired. Returning the found cache entry. [Current time (03/20/2023 05:03:00) - Expiration Time (03/20/2023 05:34:54 +00:00) - Extended Expiration Time (03/20/2023 04:14:03 +00:00)]
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] Returning access token found in cache. RefreshOn exists ? False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03]
=== Token Acquisition finished successfully:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:03:00Z - 854f14eb-9b93-4c3c-a802-714c29b5da03] AT expiration time: 20/03/2023 5:34:54 AM +00:00, scopes: https://management.core.windows.net//user_impersonation https://management.core.windows.net//.default. source: Cache
DEBUG: SharedTokenCacheCredential.GetToken succeeded. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId: ExpiresOn: 2023-03-20T05:34:54.0000000+00:00
DEBUG: [Common.Authentication]: Received token with LoginType 'User', Tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', UserId: 'sanitised'
DEBUG: ============================ HTTP REQUEST ============================
HTTP Method:
GET
Absolute Uri:
https://management.azure.com/subscriptions/sanitised/resourcegroups/soze-wahtest-arg/providers/Microsoft.Solutions/applications/sozewahtestapp?api-version=2017-09-01
Headers:
User-Agent : PSVersion/v7.3.3,AzurePowershell/v9.5.0,Az.Resources/6.5.3
ParameterSetName : __AllParameterSets
CommandName : New-AzManagedApplication
Body:
DEBUG: ============================ HTTP RESPONSE ============================
Status Code:
OK
Headers:
Cache-Control : no-cache
Pragma : no-cache
ETag : "22022ac4-0000-1b00-0000-6417e9030000"
x-ms-ratelimit-remaining-subscription-resource-requests: 59999
x-ms-providerhub-traffic : True
mise-correlation-id : e8f31830-d542-4e6b-955f-57ef48adeb75
x-ms-request-id : 646d812f-1355-4834-958c-b4e85448a9a1
x-ms-client-request-id : f2e4b377-0a6b-41c2-946e-ed799b80e1d7
x-ms-correlation-request-id : 0bc20188-b641-48a7-8afc-6dbf52f39bf4
x-ms-routing-request-id : AUSTRALIASOUTHEAST:20230320T050304Z:0bc20188-b641-48a7-8afc-6dbf52f39bf4
Strict-Transport-Security : max-age=31536000; includeSubDomains
X-Content-Type-Options : nosniff
Date : Mon, 20 Mar 2023 05:03:04 GMT
Body:
{
"id": "/subscriptions/sanitised/resourceGroups/soze-wahtest-arg/providers/Microsoft.Solutions/applications/sozewahtestapp",
"name": "sozewahtestapp",
"type": "Microsoft.Solutions/applications",
"kind": "ServiceCatalog",
"location": "australiaeast",
"etag": "\"22022ac4-0000-1b00-0000-6417e9030000\"",
"properties": {
"managedResourceGroupId": "/subscriptions/sanitised/resourcegroups/soze-wahtest-mrg",
"applicationDefinitionId": "/subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef",
"publisherPackageId": "/subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef",
"provisioningState": "Accepted",
"authorizations": [
{
"principalId": "34abc34a-48e0-4b68-b1d4-b2a5b7eed769",
"roleDefinitionId": "8e3af657-a8ff-443c-a75c-2fe8c4bcb635"
},
{
"principalId": "887744d9-e64a-4269-b659-444026834a5e",
"roleDefinitionId": "b24988ac-6180-42a0-ab88-20f7382dd24c"
},
{
"principalId": "b785e266-8dea-45bc-8811-f7573b895aa8",
"roleDefinitionId": "b24988ac-6180-42a0-ab88-20f7382dd24c"
}
]
}
}
DEBUG: [Common.Authentication]: Authenticating using Account: 'sanitised', environment: 'AzureCloud', tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf'
DEBUG: 1:04:04 PM - [ConfigManager] Got [True] from [EnableLoginByWam], Module = [], Cmdlet = [].
DEBUG: 1:04:04 PM - [SilentAuthenticator] Calling SharedTokenCacheCredential.GetTokenAsync - TenantId:'11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', Scopes:'https://management.core.windows.net//.default', AuthorityHost:'https://login.microsoftonline.com/', UserId:'sanitised'
DEBUG: SharedTokenCacheCredential.GetToken invoked. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - 2dd805af-0f68-4db2-9fcb-1571441082a9] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - 2dd805af-0f68-4db2-9fcb-1571441082a9] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - 2dd805af-0f68-4db2-9fcb-1571441082a9] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - 2dd805af-0f68-4db2-9fcb-1571441082a9] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - 2dd805af-0f68-4db2-9fcb-1571441082a9] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z] [WamBroker] WAM supported OS.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z] [WamBroker] ListWindowsWorkAndSchoolAccounts option was not enabled.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - bb4e37aa-59eb-475b-85bc-882cabbd0838] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z] Found 1 cache accounts and 0 broker accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z] Returning 1 accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] MSAL MSAL.NetCore with assembly version '4.49.1.0'. CorrelationId(c211d8ae-7543-47e0-8145-8e73419d9a38)
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] === AcquireTokenSilent Parameters ===
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] LoginHint provided: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] Account provided: True
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] ForceRefresh: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38]
=== Request Data ===
Authority Provided? - True
Scopes - https://management.core.windows.net//.default
Extra Query Params Keys (space separated) -
ApiId - AcquireTokenSilent
IsConfidentialClient - False
SendX5C - False
LoginHint ? False
IsBrokerConfigured - True
HomeAccountId - False
CorrelationId - c211d8ae-7543-47e0-8145-8e73419d9a38
UserAssertion set: False
LongRunningOboCacheKey set: False
Region configured:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] === Token Acquisition (SilentRequest) started:
Scopes: https://management.core.windows.net//.default
Authority Host: login.microsoftonline.com
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] Access token is not expired. Returning the found cache entry. [Current time (03/20/2023 05:04:04) - Expiration Time (03/20/2023 05:34:54 +00:00) - Extended Expiration Time (03/20/2023 04:14:03 +00:00)]
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] Returning access token found in cache. RefreshOn exists ? False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38]
=== Token Acquisition finished successfully:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:04:04Z - c211d8ae-7543-47e0-8145-8e73419d9a38] AT expiration time: 20/03/2023 5:34:54 AM +00:00, scopes: https://management.core.windows.net//user_impersonation https://management.core.windows.net//.default. source: Cache
DEBUG: SharedTokenCacheCredential.GetToken succeeded. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId: ExpiresOn: 2023-03-20T05:34:54.0000000+00:00
DEBUG: [Common.Authentication]: Received token with LoginType 'User', Tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', UserId: 'sanitised'
DEBUG: ============================ HTTP REQUEST ============================
HTTP Method:
GET
Absolute Uri:
https://management.azure.com/subscriptions/sanitised/resourcegroups/soze-wahtest-arg/providers/Microsoft.Solutions/applications/sozewahtestapp?api-version=2017-09-01
Headers:
User-Agent : PSVersion/v7.3.3,AzurePowershell/v9.5.0,Az.Resources/6.5.3
ParameterSetName : __AllParameterSets
CommandName : New-AzManagedApplication
Body:
DEBUG: ============================ HTTP RESPONSE ============================
Status Code:
OK
Headers:
Cache-Control : no-cache
Pragma : no-cache
ETag : "22025bc4-0000-1b00-0000-6417e9370000"
x-ms-ratelimit-remaining-subscription-resource-requests: 59999
x-ms-providerhub-traffic : True
mise-correlation-id : 0a435776-2a96-4bdc-a34f-76203c34b7d7
x-ms-request-id : ed2dcab8-2134-481f-bf51-6b95c88ba76b
x-ms-client-request-id : f8585fda-c6ec-42fc-bf87-873249fcec25
x-ms-correlation-request-id : 4ffaed1a-46b4-403f-a43f-e06377e25582
x-ms-routing-request-id : AUSTRALIASOUTHEAST:20230320T050409Z:4ffaed1a-46b4-403f-a43f-e06377e25582
Strict-Transport-Security : max-age=31536000; includeSubDomains
X-Content-Type-Options : nosniff
Date : Mon, 20 Mar 2023 05:04:09 GMT
Body:
{
"id": "/subscriptions/sanitised/resourceGroups/soze-wahtest-arg/providers/Microsoft.Solutions/applications/sozewahtestapp",
"name": "sozewahtestapp",
"type": "Microsoft.Solutions/applications",
"kind": "ServiceCatalog",
"location": "australiaeast",
"etag": "\"22025bc4-0000-1b00-0000-6417e9370000\"",
"properties": {
"managedResourceGroupId": "/subscriptions/sanitised/resourcegroups/soze-wahtest-mrg",
"applicationDefinitionId": "/subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef",
"publisherPackageId": "/subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef",
"parameters": {},
"provisioningState": "Accepted",
"authorizations": [
{
"principalId": "34abc34a-48e0-4b68-b1d4-b2a5b7eed769",
"roleDefinitionId": "8e3af657-a8ff-443c-a75c-2fe8c4bcb635"
},
{
"principalId": "887744d9-e64a-4269-b659-444026834a5e",
"roleDefinitionId": "b24988ac-6180-42a0-ab88-20f7382dd24c"
},
{
"principalId": "b785e266-8dea-45bc-8811-f7573b895aa8",
"roleDefinitionId": "b24988ac-6180-42a0-ab88-20f7382dd24c"
}
]
}
}
DEBUG: [Common.Authentication]: Authenticating using Account: 'sanitised', environment: 'AzureCloud', tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf'
DEBUG: 1:05:09 PM - [ConfigManager] Got [True] from [EnableLoginByWam], Module = [], Cmdlet = [].
DEBUG: 1:05:09 PM - [SilentAuthenticator] Calling SharedTokenCacheCredential.GetTokenAsync - TenantId:'11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', Scopes:'https://management.core.windows.net//.default', AuthorityHost:'https://login.microsoftonline.com/', UserId:'sanitised'
DEBUG: SharedTokenCacheCredential.GetToken invoked. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - c8df2856-2771-418f-9680-dd887f39aea7] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - c8df2856-2771-418f-9680-dd887f39aea7] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - c8df2856-2771-418f-9680-dd887f39aea7] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - c8df2856-2771-418f-9680-dd887f39aea7] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - c8df2856-2771-418f-9680-dd887f39aea7] IsLegacyAdalCacheEnabled: yes
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z] [WamBroker] WAM supported OS.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z] [WamBroker] ListWindowsWorkAndSchoolAccounts option was not enabled.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - fb12bedb-974b-4cfd-bff0-05dd48f51fc5] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z] Found 1 cache accounts and 0 broker accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z] Returning 1 accounts
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] MSAL MSAL.NetCore with assembly version '4.49.1.0'. CorrelationId(83df1048-3cf8-4e2c-a387-8b4258ad6734)
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] === AcquireTokenSilent Parameters ===
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] LoginHint provided: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] Account provided: True
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] ForceRefresh: False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734]
=== Request Data ===
Authority Provided? - True
Scopes - https://management.core.windows.net//.default
Extra Query Params Keys (space separated) -
ApiId - AcquireTokenSilent
IsConfidentialClient - False
SendX5C - False
LoginHint ? False
IsBrokerConfigured - True
HomeAccountId - False
CorrelationId - 83df1048-3cf8-4e2c-a387-8b4258ad6734
UserAssertion set: False
LongRunningOboCacheKey set: False
Region configured:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] === Token Acquisition (SilentRequest) started:
Scopes: https://management.core.windows.net//.default
Authority Host: login.microsoftonline.com
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] Access token is not expired. Returning the found cache entry. [Current time (03/20/2023 05:05:09) - Expiration Time (03/20/2023 05:34:54 +00:00) - Extended Expiration Time (03/20/2023 04:14:03 +00:00)]
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] Returning access token found in cache. RefreshOn exists ? False
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] [Region discovery] Not using a regional authority.
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734]
=== Token Acquisition finished successfully:
DEBUG: False MSAL 4.49.1.0 MSAL.NetCore .NET 7.0.3 Microsoft Windows 10.0.19044 [2023-03-20 05:05:09Z - 83df1048-3cf8-4e2c-a387-8b4258ad6734] AT expiration time: 20/03/2023 5:34:54 AM +00:00, scopes: https://management.core.windows.net//user_impersonation https://management.core.windows.net//.default. source: Cache
DEBUG: SharedTokenCacheCredential.GetToken succeeded. Scopes: [ https://management.core.windows.net//.default ] ParentRequestId: ExpiresOn: 2023-03-20T05:34:54.0000000+00:00
DEBUG: [Common.Authentication]: Received token with LoginType 'User', Tenant: '11c4bafa-00bb-43f4-a42d-ed6f2663fbaf', UserId: 'sanitised'
DEBUG: ============================ HTTP REQUEST ============================
HTTP Method:
GET
Absolute Uri:
https://management.azure.com/subscriptions/sanitised/resourcegroups/soze-wahtest-arg/providers/Microsoft.Solutions/applications/sozewahtestapp?api-version=2017-09-01
Headers:
User-Agent : PSVersion/v7.3.3,AzurePowershell/v9.5.0,Az.Resources/6.5.3
ParameterSetName : __AllParameterSets
CommandName : New-AzManagedApplication
Body:
DEBUG: ============================ HTTP RESPONSE ============================
Status Code:
OK
Headers:
Cache-Control : no-cache
Pragma : no-cache
ETag : "220284c4-0000-1b00-0000-6417e9530000"
x-ms-ratelimit-remaining-subscription-resource-requests: 59999
x-ms-providerhub-traffic : True
mise-correlation-id : 70fc8ff0-82fe-45c5-8360-e86f1b5b4969
x-ms-request-id : df45f192-5cc0-4ef2-ac39-4fb826e974cd
x-ms-client-request-id : 41168398-9b8d-4eeb-8363-60d452e68e4d
x-ms-correlation-request-id : 45f2ca78-51a0-4f1f-abe0-af3700250043
x-ms-routing-request-id : AUSTRALIASOUTHEAST:20230320T050511Z:45f2ca78-51a0-4f1f-abe0-af3700250043
Strict-Transport-Security : max-age=31536000; includeSubDomains
X-Content-Type-Options : nosniff
Date : Mon, 20 Mar 2023 05:05:10 GMT
Body:
{
"id": "/subscriptions/sanitised/resourceGroups/soze-wahtest-arg/providers/Microsoft.Solutions/applications/sozewahtestapp",
"name": "sozewahtestapp",
"type": "Microsoft.Solutions/applications",
"kind": "ServiceCatalog",
"location": "australiaeast",
"etag": "\"220284c4-0000-1b00-0000-6417e9530000\"",
"properties": {
"managedResourceGroupId": "/subscriptions/sanitised/resourcegroups/soze-wahtest-mrg",
"applicationDefinitionId": "/subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef",
"publisherPackageId": "/subscriptions/sanitised/resourceGroups/soze-serviceconfig-rg/providers/Microsoft.Solutions/applicationDefinitions/soze-scdef",
"parameters": {},
"provisioningState": "Succeeded",
"authorizations": [
{
"principalId": "34abc34a-48e0-4b68-b1d4-b2a5b7eed769",
"roleDefinitionId": "8e3af657-a8ff-443c-a75c-2fe8c4bcb635"
},
{
"principalId": "887744d9-e64a-4269-b659-444026834a5e",
"roleDefinitionId": "b24988ac-6180-42a0-ab88-20f7382dd24c"
},
{
"principalId": "b785e266-8dea-45bc-8811-f7573b895aa8",
"roleDefinitionId": "b24988ac-6180-42a0-ab88-20f7382dd24c"
}
]
}
}
DEBUG: 1:05:11 PM - [ConfigManager] Got [True] from [EnableDataCollection], Module = [], Cmdlet = [].
New-AzManagedApplication: The operation failed because the operation status could not be de-serialized.
DEBUG: 1:05:11 PM - [ConfigManager] Got nothing from [DisplayBreakingChangeWarning], Module = [], Cmdlet = []. Returning default value [True].
DEBUG: 1:05:11 PM - [ConfigManager] Got nothing from [DisplayRegionIdentified], Module = [], Cmdlet = []. Returning default value [True].
DEBUG: AzureQoSEvent: Module: Az.Resources:6.5.3; CommandName: New-AzManagedApplication; PSVersion: 7.3.3; IsSuccess: False; Duration: 00:02:19.8094956; Exception: The operation failed because the operation status could not be de-serialized.;
DEBUG: 1:05:11 PM - NewAzureManagedApplicationCmdlet end processing.
This is caused by a behavior breaking change of the polling API. I'll involve in service team.
Details: after the first PUT request to create the application, we'll send continuous polling request to query whether the operation has finished. Old behavior of the polling request is to return 202 Accepted when it's in progress, and 200 OK when it's finished. New behavior always return 200 OK (you can see it in the attached debug logs). This change of behavior breaks client code and cauesd the response being deserialized against a wrong model. Hence the error.
P.S. according to my test and investigation, the issue is not related to the version of the PS module.
Thanks for the feedback! We are routing this to the appropriate team for follow-up. cc @MSEvanhi.
Author: | wahyuen |
---|---|
Assignees: | - |
Labels: | `Service Attention`, `bug`, `ARM - Managed Applications`, `customer-reported` |
Milestone: | - |
Description
This command has been working for awhile and with no changes other than upgrading the version of Az Powershell, it now fails with the following error message
The operation failed because the operation status could not be de-serialized.
We can confirm that this command works from v9.1.1 and failing on v9.4.
We 'think' that the managed application does get created within Azure, but due to the error message, we are not sure if it has been left in an incomplete state due to the black box nature of the command itself.
Issue script & Debug output
Environment data
Module versions
Error output