Test case details
Test name:
OfficeDevPnP.Core.Tests.Framework.Functional.ContentTypeTests.SiteCollectionContentTypeAddingTest
Outcome:
Run at:
11/6/2019 8:50:27 PM
Duration:
00:00:12
Error message:
Test method OfficeDevPnP.Core.Tests.Framework.Functional.ContentTypeTests.SiteCollectionContentTypeAddingTest threw exception: Microsoft.SharePoint.Client.ServerException: The content type "CT_10" at "/sites/TestPnPSC_12345_c0f47e67-bae9-41eb-9da2-8a3f4519f486" is read only.
Stacktrace:
at at OfficeDevPnP.Core.Framework.Provisioning.ObjectHandlers.SiteToTemplateConversion.ApplyRemoteTemplate(Web web, ProvisioningTemplate template, ProvisioningTemplateApplyingInformation provisioningInfo, Boolean calledFromHierarchy, TokenParser tokenParser) in c:\pnpbuild\Core\OfficeDevPnP.Core\Framework\Provisioning\ObjectHandlers\SiteToTemplateConversion.cs:line 485 at Microsoft.SharePoint.Client.WebExtensions.ApplyProvisioningTemplate(Web web, ProvisioningTemplate template, ProvisioningTemplateApplyingInformation applyingInformation) in c:\pnpbuild\Core\OfficeDevPnP.Core\Extensions\WebExtensions.cs:line 1174 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 72 at OfficeDevPnP.Core.Tests.Framework.Functional.Implementation.ContentTypeImplementation.SiteCollectionContentTypeAdding(String url) in c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\Implementation\ContentTypeImplementation.cs:line 33 at OfficeDevPnP.Core.Tests.Framework.Functional.ContentTypeTests.SiteCollectionContentTypeAddingTest() in c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\ContentTypeTests.cs:line 42
Console output:
    Applying template - 1/2 - Initializing engine
Applying template - 2/2 - Files
Applying template - 1/5 - Initializing engine
Applying template - 2/5 - Fields (ListAndStandardFields)
Applying template - 3/5 - Content Types (ListAndStandardFields)
Applying template - 4/5 - Fields (LookupFields)
Applying template - 5/5 - Content Types (LookupFields)
Getting template - 1/2 - Fields (Export)
Getting template - 2/2 - Content Types (Export)
-- Content type validation True
Applying template - 1/3 - Initializing engine
Applying template - 2/3 - Content Types (ListAndStandardFields)
Type = Microsoft.SharePoint.Client.ServerException
TraceCorrelationId = 954a159f-8502-4047-f1f8-6a08e7948108
Message = The content type "CT_10" at "/sites/TestPnPSC_12345_c0f47e67-bae9-41eb-9da2-8a3f4519f486" is read only.
Source = OfficeDevPnP.Core
ServerStackTrace = 
ServerErrorCode = -2146232832
ServerErrorTypeName = Microsoft.SharePoint.SPContentTypeReadOnlyException
ServerErrorTraceCorrelationId = 954a159f-8502-4047-f1f8-6a08e7948108
TargetSite = Void ApplyRemoteTemplate(Microsoft.SharePoint.Client.Web, OfficeDevPnP.Core.Framework.Provisioning.Model.ProvisioningTemplate, OfficeDevPnP.Core.Framework.Provisioning.ObjectHandlers.ProvisioningTemplateApplyingInformation, Boolean, OfficeDevPnP.Core.Framework.Provisioning.ObjectHandlers.TokenParser)
StackTrace =    at OfficeDevPnP.Core.Framework.Provisioning.ObjectHandlers.SiteToTemplateConversion.ApplyRemoteTemplate(Web web, ProvisioningTemplate template, ProvisioningTemplateApplyingInformation provisioningInfo, Boolean calledFromHierarchy, TokenParser tokenParser) in c:\pnpbuild\Core\OfficeDevPnP.Core\Framework\Provisioning\ObjectHandlers\SiteToTemplateConversion.cs:line 485
   at Microsoft.SharePoint.Client.WebExtensions.ApplyProvisioningTemplate(Web web, ProvisioningTemplate template, ProvisioningTemplateApplyingInformation applyingInformation) in c:\pnpbuild\Core\OfficeDevPnP.Core\Extensions\WebExtensions.cs:line 1174
   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 42
HResult = -2146233088



Debug Trace:
vstest.console.exe Information: 0 : 2019-11-06 20:50:27.0770	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2013.pnp.com/sites/tenantadmin,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:a7ec4f8f-275b-4ea6-be14-0ae5330128a2,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:50:27.1940	[OfficeDevPnP.Core]	[0]	[Debug]	Site search ''	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:50:27.1940	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 11/7/2019 4:50:27 AM	0ms	
vstest.console.exe Error: 0 : 2019-11-06 20:50:27.2490	[OfficeDevPnP.Core]	[0]	[Error]	Site search error. Error = The server was unable to process the request due to an internal error.  For more information about the error, either turn on IncludeExceptionDetailInFaults (either from ServiceBehaviorAttribute or from the <serviceDebug> configuration behavior) on the server in order to send the exception information back to the client, or turn on tracing as per the Microsoft .NET Framework SDK documentation and inspect the server trace logs.	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:50:27.2530	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2013.pnp.com/sites/pnptest2,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:a7ec4f8f-275b-4ea6-be14-0ae5330128a2,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:50:28.0190	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 11/7/2019 4:50:27 AM	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:06.9104	[OfficeDevPnP.Core]	[0]	[Information]	Creating web 'sub' with template ''.	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.5715	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2013.pnp.com/sites/TestPnPSC_12345_c0f47e67-bae9-41eb-9da2-8a3f4519f486,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:a7ec4f8f-275b-4ea6-be14-0ae5330128a2,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.6685	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 11/7/2019 4:51:11 AM	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.6695	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_files.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.7825	[Provisioning]	[450]	[Debug]	Code execution scope started	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.7825	[Provisioning]	[450]	[Information]	ProgressDelegate registered	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.8155	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.8165	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.8165	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.8165	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.8165	[Files]	[450]	[Debug]	Code execution scope started	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.9405	[OfficeDevPnP.Core]	[0]	[Information]	File ct1document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.9405	[Files]	[450]	[Debug]	Uploading file ct1document.docx	123ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:11.9405	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'ct1document.docx'	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.2075	[OfficeDevPnP.Core]	[0]	[Information]	File ct3document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.2075	[Files]	[450]	[Debug]	Uploading file ct3document.docx	390ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.2075	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'ct3document.docx'	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.4575	[OfficeDevPnP.Core]	[0]	[Information]	File CT3DisplayForm.aspx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.4575	[Files]	[450]	[Debug]	Uploading file CT3DisplayForm.aspx	640ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.4575	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'CT3DisplayForm.aspx'	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.6851	[OfficeDevPnP.Core]	[0]	[Information]	File CT3EditForm.aspx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.6861	[Files]	[450]	[Debug]	Uploading file CT3EditForm.aspx	868ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.6861	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'CT3EditForm.aspx'	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.8151	[Files]	[450]	[Debug]	Code execution scope ended	998ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.8151	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.8161	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.8161	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.8161	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.8161	[Persist Template Info]	[450]	[Debug]	Code execution scope started	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.9521	[Persist Template Info]	[450]	[Debug]	Code execution scope ended	135ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.9521	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.9521	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.9651	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.9661	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:12.9661	[Provisioning]	[450]	[Debug]	Code execution scope ended	1183ms	1d0cabd8-5242-4448-bb48-c8db47a27966
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.1261	[Extraction]	[450]	[Debug]	Code execution scope started	0ms	9d77b29a-2f4f-43ca-86d9-4413e8b4e838
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.1261	[Extraction]	[450]	[Debug]	Base template available: STS0template	0ms	9d77b29a-2f4f-43ca-86d9-4413e8b4e838
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.1271	[Extraction]	[450]	[Debug]	ProgressDelegate registered	0ms	9d77b29a-2f4f-43ca-86d9-4413e8b4e838
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.1271	[Retrieve Template Info]	[450]	[Debug]	Code execution scope started	0ms	9d77b29a-2f4f-43ca-86d9-4413e8b4e838
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.1831	[Retrieve Template Info]	[450]	[Debug]	Code execution scope ended	55ms	9d77b29a-2f4f-43ca-86d9-4413e8b4e838
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.1831	[Extraction]	[450]	[Debug]	Code execution scope ended	56ms	9d77b29a-2f4f-43ca-86d9-4413e8b4e838
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.3021	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_add.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.3471	[Provisioning]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.3471	[Provisioning]	[450]	[Information]	ProgressDelegate registered	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.3791	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.3801	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.3801	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.3801	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.3801	[Fields (ListAndStandardFields)]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.4721	[Fields (ListAndStandardFields)]	[450]	[Debug]	Adding field {92BC6A41-D501-4FE2-938E-17FBF574A7CB} to site	91ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.5341	[Fields (ListAndStandardFields)]	[450]	[Debug]	Adding field {56407FDD-C7FA-4321-8FA5-06B7AF970519} to site	154ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.6011	[Fields (ListAndStandardFields)]	[450]	[Debug]	Adding field {B46D91E2-C755-4C3A-AC72-7FD3E4853476} to site	220ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.6721	[Fields (ListAndStandardFields)]	[450]	[Debug]	Adding field {B2C51364-8C48-4779-8265-1169B81CE5A0} to site	291ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.7461	[Fields (ListAndStandardFields)]	[450]	[Debug]	Code execution scope ended	366ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.7471	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.7471	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.7471	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.7471	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:13.7471	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:14.2961	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Creating new Content Type: 0x010002256D58F4CF427DA2AAA876B1DCF366 - CT_12	548ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:14.2971	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_12' (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:14.5281	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:14.7781	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:14.9861	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:15.2121	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:15.4391	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Creating new Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	1691ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:15.4391	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_10' (0x010076029D9059824413B137EA0A9B5FAAA0).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:15.6071	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x010076029D9059824413B137EA0A9B5FAAA0).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:15.7991	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Creating new Content Type: 0x0100B1459203A48B4E878238B723CD10EECA - CT_11	2051ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:15.7991	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_11' (0x0100B1459203A48B4E878238B723CD10EECA).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:15.9991	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Creating new Content Type: 0x0101001AF9DBB0E32F47A1A0BA519392153128 - CT_3	2251ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:15.9991	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_3' (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:16.1751	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:16.3681	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:16.5151	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:16.6701	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Error: 0 : 2019-11-06 20:51:16.8291	[OfficeDevPnP.Core]	[0]	[Error]	File _cts/CT_3//sites/TestPnPSC_12345_c0f47e67-bae9-41eb-9da2-8a3f4519f486/siteassets/ct3document.docx not found in directory Templates. Exception = Could not find a part of the path 'c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\Templates\_cts\CT_3\sites\TestPnPSC_12345_c0f47e67-bae9-41eb-9da2-8a3f4519f486\siteassets\ct3document.docx'.	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:17.0191	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Creating new Content Type: 0x0101005D4F34E4BE7F4B6892AEBE088EDD215E - CT_1	3271ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:17.0201	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_1' (0x0101005D4F34E4BE7F4B6892AEBE088EDD215E).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:17.1911	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0101005D4F34E4BE7F4B6892AEBE088EDD215E).	0ms	
vstest.console.exe Error: 0 : 2019-11-06 20:51:17.3091	[OfficeDevPnP.Core]	[0]	[Error]	File _cts/CT_1//sites/TestPnPSC_12345_c0f47e67-bae9-41eb-9da2-8a3f4519f486/siteassets/ct1document.docx not found in directory Templates. Exception = Could not find a part of the path 'c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\Templates\_cts\CT_1\sites\TestPnPSC_12345_c0f47e67-bae9-41eb-9da2-8a3f4519f486\siteassets\ct1document.docx'.	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:17.3941	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Creating new Content Type: 0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41 - CT_2	3646ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:17.3941	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_2' (0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:17.6071	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Creating new Content Type: 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 - CT_20	3859ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:17.6071	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_20' (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:17.8541	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:18.0471	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:18.2441	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:18.4841	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:18.8091	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT20Document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:18.8111	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT20Document0101.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:19.1291	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Creating new Content Type: 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA - CT_22	5381ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:19.1301	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_22' (0x0120D520006F71536046A14A71A827ECCAE8D5B1AA).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:19.3522	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D520006F71536046A14A71A827ECCAE8D5B1AA).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:19.6781	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Creating new Content Type: 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 - CT_21	5930ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:19.6781	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_21' (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:19.9097	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.0687	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.3117	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT21Document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5227	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Code execution scope ended	6775ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5227	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5227	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5227	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5227	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5247	[Fields (LookupFields)]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5677	[Fields (LookupFields)]	[450]	[Debug]	Code execution scope ended	43ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5687	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5687	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5687	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5687	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:20.5697	[Content Types (LookupFields)]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.1877	[Content Types (LookupFields)]	[450]	[Debug]	Updating existing Content Type: 0x010002256D58F4CF427DA2AAA876B1DCF366 - CT_12	618ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.1907	[Content Types (LookupFields)]	[450]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	620ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.1917	[Content Types (LookupFields)]	[450]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	621ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.1927	[Content Types (LookupFields)]	[450]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	622ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.1937	[Content Types (LookupFields)]	[450]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	624ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.2707	[Content Types (LookupFields)]	[450]	[Debug]	Updating existing Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	700ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.2727	[Content Types (LookupFields)]	[450]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	702ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.3297	[Content Types (LookupFields)]	[450]	[Debug]	Updating existing Content Type: 0x0100B1459203A48B4E878238B723CD10EECA - CT_11	760ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.3307	[Content Types (LookupFields)]	[450]	[Debug]	Updating existing Content Type: 0x0101001AF9DBB0E32F47A1A0BA519392153128 - CT_3	760ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.3317	[Content Types (LookupFields)]	[450]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	762ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.3327	[Content Types (LookupFields)]	[450]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	763ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.3337	[Content Types (LookupFields)]	[450]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	764ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.3357	[Content Types (LookupFields)]	[450]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	765ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.4097	[Content Types (LookupFields)]	[450]	[Debug]	Updating existing Content Type: 0x0101005D4F34E4BE7F4B6892AEBE088EDD215E - CT_1	839ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.4117	[Content Types (LookupFields)]	[450]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	841ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.4787	[Content Types (LookupFields)]	[450]	[Debug]	Updating existing Content Type: 0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41 - CT_2	908ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.4787	[Content Types (LookupFields)]	[450]	[Debug]	Updating existing Content Type: 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 - CT_20	909ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.4807	[Content Types (LookupFields)]	[450]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	910ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.4817	[Content Types (LookupFields)]	[450]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	911ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.4827	[Content Types (LookupFields)]	[450]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	912ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.4837	[Content Types (LookupFields)]	[450]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	913ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Error: 0 : 2019-11-06 20:51:21.4847	[Content Types (LookupFields)]	[450]	[Error]	Content Type 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 with ID CT_20 cannot be transformed into a DocumentSet	914ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.5707	[Content Types (LookupFields)]	[450]	[Debug]	Updating existing Content Type: 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA - CT_22	1001ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.5727	[Content Types (LookupFields)]	[450]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1003ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Error: 0 : 2019-11-06 20:51:21.5737	[Content Types (LookupFields)]	[450]	[Error]	Content Type 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA with ID CT_22 cannot be transformed into a DocumentSet	1003ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.6357	[Content Types (LookupFields)]	[450]	[Debug]	Updating existing Content Type: 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 - CT_21	1066ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.6377	[Content Types (LookupFields)]	[450]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1068ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.6397	[Content Types (LookupFields)]	[450]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	1070ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Error: 0 : 2019-11-06 20:51:21.6397	[Content Types (LookupFields)]	[450]	[Error]	Content Type 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 with ID CT_21 cannot be transformed into a DocumentSet	1070ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.7037	[Content Types (LookupFields)]	[450]	[Debug]	Code execution scope ended	1134ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.7047	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.7047	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.7047	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.7047	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.7047	[Persist Template Info]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.8077	[Persist Template Info]	[450]	[Debug]	Code execution scope ended	102ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.8077	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.8077	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.8077	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.8087	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.8087	[Provisioning]	[450]	[Debug]	Code execution scope ended	8461ms	12636700-9a74-4cb9-a9bb-7e016d06d2c7
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.9667	[Extraction]	[450]	[Debug]	Code execution scope started	0ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.9677	[Extraction]	[450]	[Debug]	Base template available: STS0template	0ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.9677	[Extraction]	[450]	[Debug]	ProgressDelegate registered	0ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:21.9677	[Fields (Export)]	[450]	[Debug]	Code execution scope started	0ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:22.3137	[Fields (Export)]	[450]	[Debug]	Code execution scope ended	345ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:22.3137	[Content Types (Export)]	[450]	[Debug]	Code execution scope started	0ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:22.9547	[Content Types (Export)]	[450]	[Debug]	Code execution scope ended	640ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:22.9557	[Retrieve Template Info]	[450]	[Debug]	Code execution scope started	0ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.0137	[Retrieve Template Info]	[450]	[Debug]	Code execution scope ended	58ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.0137	[Extraction]	[450]	[Debug]	Code execution scope ended	1046ms	dc098fce-7d3b-41a6-b04c-f8a4b16c78f8
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.0987	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_delta_1.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.1287	[Provisioning]	[450]	[Debug]	Code execution scope started	0ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.1287	[Provisioning]	[450]	[Information]	ProgressDelegate registered	0ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.1547	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.1547	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.1557	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.1557	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.1557	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Code execution scope started	0ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.7587	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Updating existing Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	603ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.7597	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Updating property ReadOnly	603ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.8157	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	659ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.8477	[Content Types (ListAndStandardFields)]	[450]	[Debug]	Code execution scope ended	691ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.8477	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.8477	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	9ee4a174-2e9f-4430-b188-32eaea925531
vstest.console.exe Information: 0 : 2019-11-06 20:51:23.8487	[Provisioning]	[450]	[Debug]	Code execution scope ended	719ms	9ee4a174-2e9f-4430-b188-32eaea925531