Test case details
Test name:
OfficeDevPnP.Core.Tests.Framework.Functional.TermGroupTests.WebTermGroupTest
Outcome:
Run at:
9/10/2019 7:43:02 PM
Duration:
00:15:00
Error message:
Test 'WebTermGroupTest' exceeded execution timeout period.
Stacktrace:
N/A
Console output:
    Type = System.Threading.ThreadAbortException
TraceCorrelationId = d5ed029f-954d-4047-f1f8-67a1a7689b4f
Message = Thread was being aborted.
Source = System
TargetSite = Void WriteHeaders(Boolean)
StackTrace =    at System.Net.ConnectStream.WriteHeaders(Boolean async)
   at System.Net.HttpWebRequest.EndSubmitRequest()
   at System.Net.HttpWebRequest.SetRequestSubmitDone(ConnectStream submitStream)
   at System.Net.Connection.CompleteStartRequest(Boolean onSubmitThread, HttpWebRequest request, TriState needReConnect)
   at System.Net.Connection.SubmitRequest(HttpWebRequest request, Boolean forcedsubmit)
   at System.Net.ServicePoint.SubmitRequest(HttpWebRequest request, String connName)
   at System.Net.HttpWebRequest.SubmitRequest(ServicePoint servicePoint)
   at System.Net.HttpWebRequest.GetResponse()
   at Microsoft.SharePoint.Client.SPWebRequestExecutor.Execute()
   at Microsoft.SharePoint.Client.ClientRequest.ExecuteQueryToServer(ChunkStringBuilder sb)
   at Microsoft.SharePoint.Client.ClientRequest.ExecuteQuery()
   at Microsoft.SharePoint.Client.ClientRuntimeContext.ExecuteQuery()
   at Microsoft.SharePoint.Client.ClientContext.ExecuteQuery()
   at Microsoft.SharePoint.Client.ClientContextExtensions.ExecuteQueryImplementation(ClientRuntimeContext clientContext, Int32 retryCount, Int32 delay, String userAgent) in c:\pnpbuild\Core\OfficeDevPnP.Core\Extensions\ClientContextExtensions.cs:line 173
   at Microsoft.SharePoint.Client.ClientContextExtensions.ExecuteQueryRetry(ClientRuntimeContext clientContext, Int32 retryCount, Int32 delay, String userAgent) in c:\pnpbuild\Core\OfficeDevPnP.Core\Extensions\ClientContextExtensions.cs:line 93
   at OfficeDevPnP.Core.Framework.Provisioning.ObjectHandlers.ObjectTermGroups.GetTerms[T](ClientRuntimeContext context, TaxonomyItem parent, Int32 defaultLanguage, Boolean isSiteCollectionTermGroup) in c:\pnpbuild\Core\OfficeDevPnP.Core\Framework\Provisioning\ObjectHandlers\ObjectTermGroups.cs:line 530
   at OfficeDevPnP.Core.Framework.Provisioning.ObjectHandlers.ObjectTermGroups.ExtractObjects(Web web, ProvisioningTemplate template, ProvisioningTemplateCreationInformation creationInfo) in c:\pnpbuild\Core\OfficeDevPnP.Core\Framework\Provisioning\ObjectHandlers\ObjectTermGroups.cs:line 487
   at OfficeDevPnP.Core.Framework.Provisioning.ObjectHandlers.SiteToTemplateConversion.GetRemoteTemplate(Web web, ProvisioningTemplateCreationInformation creationInfo) in c:\pnpbuild\Core\OfficeDevPnP.Core\Framework\Provisioning\ObjectHandlers\SiteToTemplateConversion.cs:line 147
   at Microsoft.SharePoint.Client.WebExtensions.GetProvisioningTemplate(Web web, ProvisioningTemplateCreationInformation creationInfo) in c:\pnpbuild\Core\OfficeDevPnP.Core\Extensions\WebExtensions.cs:line 1199
   at OfficeDevPnP.Core.Tests.Framework.Functional.Implementation.ImplementationBase.TestProvisioningTemplate(ClientContext cc, String templateName, Handlers handlersToProcess, ProvisioningTemplateApplyingInformation ptai, ProvisioningTemplateCreationInformation ptci) in c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\Implementation\ImplementationBase.cs:line 59
HResult = -2146233040
Applying template - 1/2 - Initializing engine
Applying template - 2/2 - Term Groups
Getting template - 1/1 - Term Groups
-- Term group validation True
Applying template - 1/2 - Initializing engine
Applying template - 2/2 - Term Groups
Getting template - 1/1 - Term Groups



Debug Trace:
vstest.console.exe Information: 0 : 2019-09-10 19:43:02.1698	[Term Groups]	[14]	[Debug]	Code execution scope ended	190762ms	ade64414-6d86-48f6-b7fd-da76725ace8b
vstest.console.exe Information: 0 : 2019-09-10 19:43:02.1718	[Extraction]	[14]	[Debug]	Code execution scope ended	190764ms	ade64414-6d86-48f6-b7fd-da76725ace8b
vstest.console.exe Information: 0 : 2019-09-10 19:43:07.2784	[OfficeDevPnP.Core]	[0]	[Information]	File termgroup_add.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-09-10 19:43:07.3564	[Provisioning]	[13]	[Debug]	Code execution scope started	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:07.3574	[Provisioning]	[13]	[Information]	ProgressDelegate registered	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:07.4104	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:07.4104	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:07.4114	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:07.4114	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:07.4114	[Term Groups]	[13]	[Debug]	Code execution scope started	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.2225	[Term Groups]	[13]	[Debug]	Code execution scope ended	7811ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.2235	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.2235	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.2245	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.2245	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.2245	[Persist Template Info]	[13]	[Debug]	Code execution scope started	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.3925	[Persist Template Info]	[13]	[Debug]	Code execution scope ended	168ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.3935	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.3935	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.4115	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.4115	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.4115	[Provisioning]	[13]	[Debug]	Code execution scope ended	8054ms	956f507b-8455-4110-8bd0-6adcd8a228fc
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.4115	[Extraction]	[13]	[Debug]	Code execution scope started	0ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.4125	[Extraction]	[13]	[Debug]	Base template available: STS0template	0ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.4125	[Extraction]	[13]	[Debug]	ProgressDelegate registered	0ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.4125	[Extraction]	[13]	[Debug]	IncludeAllTermGroups is set to true	0ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.4125	[Extraction]	[13]	[Debug]	IncludeSiteCollectionTermGroup is set to true	0ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:43:15.4125	[Term Groups]	[13]	[Debug]	Code execution scope started	0ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:53:26.5483	[Term Groups]	[13]	[Debug]	Code execution scope ended	611134ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:53:26.5483	[Retrieve Template Info]	[13]	[Debug]	Code execution scope started	0ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:53:26.6283	[Retrieve Template Info]	[13]	[Debug]	Code execution scope ended	79ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:53:26.6283	[Extraction]	[13]	[Debug]	Code execution scope ended	611215ms	edd88821-d4d4-4e4c-b469-f27ac9737083
vstest.console.exe Information: 0 : 2019-09-10 19:53:39.3523	[OfficeDevPnP.Core]	[0]	[Information]	File termgroup_delta_1605.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-09-10 19:53:39.4063	[Provisioning]	[13]	[Debug]	Code execution scope started	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:39.4063	[Provisioning]	[13]	[Information]	ProgressDelegate registered	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:39.4523	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:39.4523	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:39.4523	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:39.4523	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:39.4523	[Term Groups]	[13]	[Debug]	Code execution scope started	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.4803	[Term Groups]	[13]	[Debug]	Code execution scope ended	6027ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.4803	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.4803	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.4803	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.4813	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.4813	[Persist Template Info]	[13]	[Debug]	Code execution scope started	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6183	[Persist Template Info]	[13]	[Debug]	Code execution scope ended	137ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6193	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6193	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6193	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope started	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6193	[ProvisioningTemplate WebHook Call]	[13]	[Debug]	Code execution scope ended	0ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6193	[Provisioning]	[13]	[Debug]	Code execution scope ended	6213ms	ade09794-4fac-4be4-a4fd-711690078af9
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6203	[Extraction]	[13]	[Debug]	Code execution scope started	0ms	8d86ff81-ac6b-410d-8626-f81b36a002ed
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6203	[Extraction]	[13]	[Debug]	Base template available: STS0template	0ms	8d86ff81-ac6b-410d-8626-f81b36a002ed
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6203	[Extraction]	[13]	[Debug]	ProgressDelegate registered	0ms	8d86ff81-ac6b-410d-8626-f81b36a002ed
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6203	[Extraction]	[13]	[Debug]	IncludeAllTermGroups is set to true	0ms	8d86ff81-ac6b-410d-8626-f81b36a002ed
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6213	[Extraction]	[13]	[Debug]	IncludeSiteCollectionTermGroup is set to true	0ms	8d86ff81-ac6b-410d-8626-f81b36a002ed
vstest.console.exe Information: 0 : 2019-09-10 19:53:45.6213	[Term Groups]	[13]	[Debug]	Code execution scope started	0ms	8d86ff81-ac6b-410d-8626-f81b36a002ed