[2022-10-21 13:37:10.477] [info ] [tid 58] Info: Accepting {0} request for '{1}'. RemoteEndPoint='{2}', Via='{3}', Expect='{4}', Connection='{5}', Version='{6}', ClientRequestId='{7}', UserAgent='{8}' DurationStayedInQueueInMs='{9}', RemainingRequestsInQueueAtEnqueue='{10}', RemainingRequestsInQueueAtDequeue='{11}', WasInHighPriorityQueue='{12}', ToSetKeepAliveToFalse='{13}', ActiveWorkerThreads='{14}', ActiveCompletionThreads='{15}' PassedInActivityId={16}, EnqueueTime={17}, DequeueTime={18}, RequestTraceActvityId = '{19}', p0="PUT", p1="http://172.31.130.191:11002/devstoreaccount2/secondcontainer?restype=container", p2="172.31.128.1:64219", p3="", p4="", p5="keep-alive", p6="2021-08-06", p7="5d00617a-7b0b-4097-a851-d14c5f7a9cf1", p8="Microsoft Azure Storage Explorer", p9="0.0252", p10="0", p11="0", p12="False", p13="False", p14="1", p15="0", p16="null", p17="2022-10-21T13:37:10.4763079Z", p18="2022-10-21T13:37:10.4763261Z", p19="2007a3bd-b816-4134-a5ba-e64bd65f7fca" [2022-10-21 13:37:10.486] [info ] [tid 118] [ContainerInterface.cc:62] [GetBlobContainerProperties] Get container properties. Name:secondcontainer [2022-10-21 13:37:10.491] [info ] [tid 118] [MetaStore.cc:742] [GetBlobContainerRecord] Container not found. Name:secondcontainer [2022-10-21 13:37:10.491] [error ] [tid 118] [ContainerInterface.cc:76] [GetBlobContainerProperties] Get container properties failed. Name:secondcontainer Error:39987 [2022-10-21 13:37:10.512] [info ] [tid 119] WossProvider : Exception in EndGetProperties as container was not found {0}, p0="Microsoft.AzureStack.Services.Storage.FrontEnd.WossProvider.WStoreException: GetBlobContainerPropertiesAsync failed at Microsoft.AzureStack.Services.Storage.FrontEnd.WossProvider.WBlobContainer.GetBlobContainerPropertiesAsync(ContainerPropertyNames propertyNames, IContainerCondition conditions, Boolean shouldSkipCacheLookup, Nullable`1 cancelToken) at Microsoft.AzureStack.Services.Storage.FrontEnd.WossProvider.WContainer.GetPropertiesAsync(ContainerPropertyNames propertyNames, IContainerCondition condition, Boolean shouldSkipCacheLookup, Boolean shouldUpdateCacheEntryOnRefresh) at Microsoft.AzureStack.Services.Storage.Util.Await(Task t) at Microsoft.AzureStack.Services.Storage.FrontEnd.WossProvider.WContainer.EndGetProperties(IAsyncResult ar)" [2022-10-21 13:37:10.512] [info ] [tid 119] Info: Contacting XAC Server in order to create container '{0}', p0="secondcontainer" [2022-10-21 13:37:10.512] [info ] [tid 118] [ContainerInterface.cc:20] [CreateBlobContainer] Create container. Name:secondcontainer SvcMetadataSize:16 AppMetadataSize:0 [2022-10-21 13:37:10.523] [info ] [tid 118] Perf: PerfCounters: Account={0} Operation={1} on Container={2} with Status={3} RequestHeaderSize={4} RequestSize={5} ResponseHeaderSize={6} ResponseSize={7} ErrorResponseByte={8} TimeInMs={9} ProcessingTimeInMs={10} UserTimeoutInMs={11} OperationTimeoutInMs={12} MaxAllowedTimeoutInMs={13} SlaUsedInMs={14} ReadLatencyInMs={15} WriteLatencyInMs={16} ClientIP={17} UserAgent='{18}' RequestVersion='{19}' ProcessorVersionUsed='{20}' RequestUrl='{21}' ClientRequestId='{22}' MeasurementStatus={23} HttpStatusCode={24} TotalFeTimeInMs={25} TotalTableServerTimeInMs={26} TotalTableServerRoundTripCount={27} TotalPartitionWaitTimeInMs={28} TotalXStreamTimeInMs={29} TotalXStreamRoundTripCount={30} SmbOpLockBreakLatency={31} LastTableServerInstanceName={32} LastTableServerErrorCode={33} TotalAccountCacheWaitTimeInMs={34} TotalContainerCacheWaitTimeInMs={35} InternalStatus={36} RequestContentType='{37}' ResponseContentType='{38}' PartitionKey='{39}' ItemsReturned='{40}' BatchOperationCount='{41}' LastXStreamErrorCode={42} AuthenticationType='{43}' AccountConcurrentReq='{44}' OverallConcurrentReq='{45}' Range='{46}' EntityType='{47}' {48} LastTSPartition={49} TotalXCacheTimeInMs={50} TotalXCacheRoundTripCount={51} TotalTableServerOnlyTimeInMicroSeconds={52} TotalAuthTimeInMs={53} AuthenticationTimeInMs={54} AuthorizationTimeInMs={55} GetAuthenticationDataTimeInMs={56} GetAuthorizationDataTimeInMs={57} VnetPolicyCheckTimeInMs={58} PerfFeatureFlags={59}, p0="devstoreaccount2", p1="CreateContainer", p2="secondcontainer", p3="Success", p4="502", p5="0", p6="214", p7="0", p8="0", p9="43.8158", p10="43.8158", p11="922337203685477", p12="30000", p13="30000", p14="0", p15="0", p16="0", p17="172.31.128.1:64219", p18="Microsoft Azure Storage Explorer/1.26.1 (win32) azsdk-js-storageblob/12.11.0 (NODE-VERSION v16.14.2; Windows_NT 10.0.19044)", p19="2021-08-06", p20="2021-08-06", p21="http://172.31.130.191:11003/devstoreaccount2/secondcontainer?restype=container", p22="5d00617a-7b0b-4097-a851-d14c5f7a9cf1", p23="Success", p24="201", p25="43.815", p26="0", p27="0", p28="0", p29="0", p30="0", p31="0", p32="", p33="0", p34="0", p35="0", p36="ExpectedSuccess", p37="", p38="", p39="", p40="0", p41="0", p42="0", p43="NA", p44="", p45="1", p46="", p47="", p48="", p49="", p50="0", p51="0", p52="0", p53="1.279", p54="1.238", p55="0.041", p56="0", p57="0", p58="0", p59="null" [2022-10-21 13:37:10.573] [info ] [tid 56] Info: Accepting {0} request for '{1}'. RemoteEndPoint='{2}', Via='{3}', Expect='{4}', Connection='{5}', Version='{6}', ClientRequestId='{7}', UserAgent='{8}' DurationStayedInQueueInMs='{9}', RemainingRequestsInQueueAtEnqueue='{10}', RemainingRequestsInQueueAtDequeue='{11}', WasInHighPriorityQueue='{12}', ToSetKeepAliveToFalse='{13}', ActiveWorkerThreads='{14}', ActiveCompletionThreads='{15}' PassedInActivityId={16}, EnqueueTime={17}, DequeueTime={18}, RequestTraceActvityId = '{19}', p0="GET", p1="http://172.31.130.191:11002/devstoreaccount2/secondcontainer?comp=properties&restype=account", p2="172.31.128.1:64222", p3="", p4="", p5="keep-alive", p6="2021-08-06", p7="08c6dc10-2861-474d-ace6-a5b5d4aad73b", p8="Microsoft Azure Storage Explorer", p9="0.0247", p10="0", p11="0", p12="False", p13="False", p14="3", p15="0", p16="null", p17="2022-10-21T13:37:10.5738375Z", p18="2022-10-21T13:37:10.5738584Z", p19="11c5b114-a0f8-4b68-8b65-efde71324988" [2022-10-21 13:37:10.575] [info ] [tid 58] Info: Accepting {0} request for '{1}'. RemoteEndPoint='{2}', Via='{3}', Expect='{4}', Connection='{5}', Version='{6}', ClientRequestId='{7}', UserAgent='{8}' DurationStayedInQueueInMs='{9}', RemainingRequestsInQueueAtEnqueue='{10}', RemainingRequestsInQueueAtDequeue='{11}', WasInHighPriorityQueue='{12}', ToSetKeepAliveToFalse='{13}', ActiveWorkerThreads='{14}', ActiveCompletionThreads='{15}' PassedInActivityId={16}, EnqueueTime={17}, DequeueTime={18}, RequestTraceActvityId = '{19}', p0="GET", p1="http://172.31.130.191:11002/devstoreaccount2/secondcontainer?restype=container", p2="172.31.128.1:64221", p3="", p4="", p5="keep-alive", p6="2021-08-06", p7="403e7a96-6618-4afe-8fa5-277a6cc79c19", p8="Microsoft Azure Storage Explorer", p9="0.0188", p10="0", p11="0", p12="False", p13="False", p14="3", p15="0", p16="null", p17="2022-10-21T13:37:10.5751514Z", p18="2022-10-21T13:37:10.5751686Z", p19="d45aed80-b7d7-493e-b002-f9a409421e00" [2022-10-21 13:37:10.576] [info ] [tid 120] [ContainerInterface.cc:62] [GetBlobContainerProperties] Get container properties. Name:secondcontainer [2022-10-21 13:37:10.579] [info ] [tid 119] Info: Processing exception: {0}, p0="System.NotImplementedException: Get Account Information Api not available. at Microsoft.Cis.Services.Nephos.Storage.Service.Protocols.Rest.HttpRestProcessor.ChooseRestMethodHandler(RestMethod method) at Microsoft.Cis.Services.Nephos.Common.Protocols.Rest.BasicHttpProcessorWithAuthAndAccountContainer`1.ProcessImpl(AsyncIteratorContext`1 async)+MoveNext()" [2022-10-21 13:37:10.581] [info ] [tid 118] Perf: PerfCounters: Account={0} Operation={1} on Container={2} with Status={3} RequestHeaderSize={4} RequestSize={5} ResponseHeaderSize={6} ResponseSize={7} ErrorResponseByte={8} TimeInMs={9} ProcessingTimeInMs={10} UserTimeoutInMs={11} OperationTimeoutInMs={12} MaxAllowedTimeoutInMs={13} SlaUsedInMs={14} ReadLatencyInMs={15} WriteLatencyInMs={16} ClientIP={17} UserAgent='{18}' RequestVersion='{19}' ProcessorVersionUsed='{20}' RequestUrl='{21}' ClientRequestId='{22}' MeasurementStatus={23} HttpStatusCode={24} TotalFeTimeInMs={25} TotalTableServerTimeInMs={26} TotalTableServerRoundTripCount={27} TotalPartitionWaitTimeInMs={28} TotalXStreamTimeInMs={29} TotalXStreamRoundTripCount={30} SmbOpLockBreakLatency={31} LastTableServerInstanceName={32} LastTableServerErrorCode={33} TotalAccountCacheWaitTimeInMs={34} TotalContainerCacheWaitTimeInMs={35} InternalStatus={36} RequestContentType='{37}' ResponseContentType='{38}' PartitionKey='{39}' ItemsReturned='{40}' BatchOperationCount='{41}' LastXStreamErrorCode={42} AuthenticationType='{43}' AccountConcurrentReq='{44}' OverallConcurrentReq='{45}' Range='{46}' EntityType='{47}' {48} LastTSPartition={49} TotalXCacheTimeInMs={50} TotalXCacheRoundTripCount={51} TotalTableServerOnlyTimeInMicroSeconds={52} TotalAuthTimeInMs={53} AuthenticationTimeInMs={54} AuthorizationTimeInMs={55} GetAuthenticationDataTimeInMs={56} GetAuthorizationDataTimeInMs={57} VnetPolicyCheckTimeInMs={58} PerfFeatureFlags={59}, p0="devstoreaccount2", p1="GetContainerProperties", p2="secondcontainer", p3="Success", p4="487", p5="0", p6="363", p7="0", p8="0", p9="5.4124", p10="5.4124", p11="922337203685477", p12="30000", p13="30000", p14="0", p15="0", p16="0", p17="172.31.128.1:64221", p18="Microsoft Azure Storage Explorer/1.26.1 (win32) azsdk-js-storageblob/12.11.0 (NODE-VERSION v16.14.2; Windows_NT 10.0.19044)", p19="2021-08-06", p20="2021-08-06", p21="http://172.31.130.191:11003/devstoreaccount2/secondcontainer?restype=container", p22="403e7a96-6618-4afe-8fa5-277a6cc79c19", p23="Success", p24="200", p25="5.412", p26="0", p27="0", p28="0", p29="0", p30="0", p31="0", p32="", p33="0", p34="0", p35="0", p36="ExpectedSuccess", p37="", p38="", p39="", p40="0", p41="0", p42="0", p43="NA", p44="", p45="2", p46="", p47="", p48="", p49="", p50="0", p51="0", p52="0", p53="0.125", p54="0.062", p55="0.063", p56="0", p57="0", p58="0", p59="null" [2022-10-21 13:37:10.584] [error ] [tid 119] Error: {0}: {1}, p0="[FEUnhandledException] An unexpected non-fatal exception was encountered", p1="System.NotImplementedException: Get Account Information Api not available. at Microsoft.Cis.Services.Nephos.Storage.Service.Protocols.Rest.HttpRestProcessor.ChooseRestMethodHandler(RestMethod method) at Microsoft.Cis.Services.Nephos.Common.Protocols.Rest.BasicHttpProcessorWithAuthAndAccountContainer`1.ProcessImpl(AsyncIteratorContext`1 async)+MoveNext()" [2022-10-21 13:37:10.584] [info ] [tid 119] Info: Setting status description as "{0}", p0="Server encountered an internal error. Please try again after some time." [2022-10-21 13:37:10.592] [info ] [tid 119] Perf: PerfCounters: Account={0} Operation={1} on Container={2} with Status={3} RequestHeaderSize={4} RequestSize={5} ResponseHeaderSize={6} ResponseSize={7} ErrorResponseByte={8} TimeInMs={9} ProcessingTimeInMs={10} UserTimeoutInMs={11} OperationTimeoutInMs={12} MaxAllowedTimeoutInMs={13} SlaUsedInMs={14} ReadLatencyInMs={15} WriteLatencyInMs={16} ClientIP={17} UserAgent='{18}' RequestVersion='{19}' ProcessorVersionUsed='{20}' RequestUrl='{21}' ClientRequestId='{22}' MeasurementStatus={23} HttpStatusCode={24} TotalFeTimeInMs={25} TotalTableServerTimeInMs={26} TotalTableServerRoundTripCount={27} TotalPartitionWaitTimeInMs={28} TotalXStreamTimeInMs={29} TotalXStreamRoundTripCount={30} SmbOpLockBreakLatency={31} LastTableServerInstanceName={32} LastTableServerErrorCode={33} TotalAccountCacheWaitTimeInMs={34} TotalContainerCacheWaitTimeInMs={35} InternalStatus={36} RequestContentType='{37}' ResponseContentType='{38}' PartitionKey='{39}' ItemsReturned='{40}' BatchOperationCount='{41}' LastXStreamErrorCode={42} AuthenticationType='{43}' AccountConcurrentReq='{44}' OverallConcurrentReq='{45}' Range='{46}' EntityType='{47}' {48} LastTSPartition={49} TotalXCacheTimeInMs={50} TotalXCacheRoundTripCount={51} TotalTableServerOnlyTimeInMicroSeconds={52} TotalAuthTimeInMs={53} AuthenticationTimeInMs={54} AuthorizationTimeInMs={55} GetAuthenticationDataTimeInMs={56} GetAuthorizationDataTimeInMs={57} VnetPolicyCheckTimeInMs={58} PerfFeatureFlags={59}, p0="devstoreaccount2", p1="Unknown", p2="null", p3="InternalError", p4="501", p5="0", p6="198", p7="0", p8="0", p9="NA", p10="NA", p11="NA", p12="NA", p13="NA", p14="NA", p15="NA", p16="NA", p17="172.31.128.1:64222", p18="Microsoft Azure Storage Explorer/1.26.1 (win32) azsdk-js-storageblob/12.11.0 (NODE-VERSION v16.14.2; Windows_NT 10.0.19044)", p19="2021-08-06", p20="2021-08-06", p21="http://172.31.130.191:11003/devstoreaccount2/secondcontainer?comp=properties&restype=account", p22="08c6dc10-2861-474d-ace6-a5b5d4aad73b", p23="UnknownFailure", p24="500", p25="NA", p26="NA", p27="NA", p28="NA", p29="NA", p30="NA", p31="NA", p32="NA", p33="NA", p34="0", p35="0", p36="ServerOtherError", p37="", p38="application/xml", p39="", p40="0", p41="0", p42="NA", p43="NA", p44="", p45="1", p46="NA", p47="", p48="", p49="NA", p50="NA", p51="NA", p52="0", p53="0.126", p54="0.126", p55="0", p56="0", p57="0", p58="NA", p59="null" [2022-10-21 13:37:10.597] [info ] [tid 56] Info: Accepting {0} request for '{1}'. RemoteEndPoint='{2}', Via='{3}', Expect='{4}', Connection='{5}', Version='{6}', ClientRequestId='{7}', UserAgent='{8}' DurationStayedInQueueInMs='{9}', RemainingRequestsInQueueAtEnqueue='{10}', RemainingRequestsInQueueAtDequeue='{11}', WasInHighPriorityQueue='{12}', ToSetKeepAliveToFalse='{13}', ActiveWorkerThreads='{14}', ActiveCompletionThreads='{15}' PassedInActivityId={16}, EnqueueTime={17}, DequeueTime={18}, RequestTraceActvityId = '{19}', p0="GET", p1="http://172.31.130.191:11002/devstoreaccount2/secondcontainer?comp=properties&restype=account", p2="172.31.128.1:64223", p3="", p4="", p5="keep-alive", p6="2021-08-06", p7="08c6dc10-2861-474d-ace6-a5b5d4aad73b", p8="Microsoft Azure Storage Explorer", p9="0.0182", p10="0", p11="0", p12="False", p13="False", p14="1", p15="0", p16="null", p17="2022-10-21T13:37:10.5977871Z", p18="2022-10-21T13:37:10.5978024Z", p19="b0678a87-0ac3-439a-b3b3-99dcc006b2d6" [2022-10-21 13:37:10.598] [info ] [tid 120] Info: Processing exception: {0}, p0="System.NotImplementedException: Get Account Information Api not available. at Microsoft.Cis.Services.Nephos.Storage.Service.Protocols.Rest.HttpRestProcessor.ChooseRestMethodHandler(RestMethod method) at Microsoft.Cis.Services.Nephos.Common.Protocols.Rest.BasicHttpProcessorWithAuthAndAccountContainer`1.ProcessImpl(AsyncIteratorContext`1 async)+MoveNext()" [2022-10-21 13:37:10.599] [error ] [tid 120] Error: {0}: {1}, p0="[FEUnhandledException] An unexpected non-fatal exception was encountered", p1="System.NotImplementedException: Get Account Information Api not available. at Microsoft.Cis.Services.Nephos.Storage.Service.Protocols.Rest.HttpRestProcessor.ChooseRestMethodHandler(RestMethod method) at Microsoft.Cis.Services.Nephos.Common.Protocols.Rest.BasicHttpProcessorWithAuthAndAccountContainer`1.ProcessImpl(AsyncIteratorContext`1 async)+MoveNext()" [2022-10-21 13:37:10.599] [info ] [tid 120] Info: Setting status description as "{0}", p0="Server encountered an internal error. Please try again after some time." [2022-10-21 13:37:10.600] [info ] [tid 120] Perf: PerfCounters: Account={0} Operation={1} on Container={2} with Status={3} RequestHeaderSize={4} RequestSize={5} ResponseHeaderSize={6} ResponseSize={7} ErrorResponseByte={8} TimeInMs={9} ProcessingTimeInMs={10} UserTimeoutInMs={11} OperationTimeoutInMs={12} MaxAllowedTimeoutInMs={13} SlaUsedInMs={14} ReadLatencyInMs={15} WriteLatencyInMs={16} ClientIP={17} UserAgent='{18}' RequestVersion='{19}' ProcessorVersionUsed='{20}' RequestUrl='{21}' ClientRequestId='{22}' MeasurementStatus={23} HttpStatusCode={24} TotalFeTimeInMs={25} TotalTableServerTimeInMs={26} TotalTableServerRoundTripCount={27} TotalPartitionWaitTimeInMs={28} TotalXStreamTimeInMs={29} TotalXStreamRoundTripCount={30} SmbOpLockBreakLatency={31} LastTableServerInstanceName={32} LastTableServerErrorCode={33} TotalAccountCacheWaitTimeInMs={34} TotalContainerCacheWaitTimeInMs={35} InternalStatus={36} RequestContentType='{37}' ResponseContentType='{38}' PartitionKey='{39}' ItemsReturned='{40}' BatchOperationCount='{41}' LastXStreamErrorCode={42} AuthenticationType='{43}' AccountConcurrentReq='{44}' OverallConcurrentReq='{45}' Range='{46}' EntityType='{47}' {48} LastTSPartition={49} TotalXCacheTimeInMs={50} TotalXCacheRoundTripCount={51} TotalTableServerOnlyTimeInMicroSeconds={52} TotalAuthTimeInMs={53} AuthenticationTimeInMs={54} AuthorizationTimeInMs={55} GetAuthenticationDataTimeInMs={56} GetAuthorizationDataTimeInMs={57} VnetPolicyCheckTimeInMs={58} PerfFeatureFlags={59}, p0="devstoreaccount2", p1="Unknown", p2="null", p3="InternalError", p4="501", p5="0", p6="198", p7="0", p8="0", p9="NA", p10="NA", p11="NA", p12="NA", p13="NA", p14="NA", p15="NA", p16="NA", p17="172.31.128.1:64223", p18="Microsoft Azure Storage Explorer/1.26.1 (win32) azsdk-js-storageblob/12.11.0 (NODE-VERSION v16.14.2; Windows_NT 10.0.19044)", p19="2021-08-06", p20="2021-08-06", p21="http://172.31.130.191:11003/devstoreaccount2/secondcontainer?comp=properties&restype=account", p22="08c6dc10-2861-474d-ace6-a5b5d4aad73b", p23="UnknownFailure", p24="500", p25="NA", p26="NA", p27="NA", p28="NA", p29="NA", p30="NA", p31="NA", p32="NA", p33="NA", p34="0", p35="0", p36="ServerOtherError", p37="", p38="application/xml", p39="", p40="0", p41="0", p42="NA", p43="NA", p44="", p45="1", p46="NA", p47="", p48="", p49="NA", p50="NA", p51="NA", p52="0", p53="0.154", p54="0.154", p55="0", p56="0", p57="0", p58="NA", p59="null"