Test case details
Test name:
OfficeDevPnP.Core.Tests.Framework.Functional.ContentTypeTests.SiteCollectionContentTypeAddingTest
Outcome:
Run at:
11/7/2019 7:41:50 PM
Duration:
00:00:16
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_5bfd9143-3e20-4059-a007-55a495e70153" 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 = 0f99159f-f6f5-50b3-6c0f-d9fa0611d3d4
Message = The content type "CT_10" at "/sites/TestPnPSC_12345_5bfd9143-3e20-4059-a007-55a495e70153" is read only.
Source = OfficeDevPnP.Core
ServerStackTrace = 
ServerErrorCode = -2146232832
ServerErrorTypeName = Microsoft.SharePoint.SPContentTypeReadOnlyException
ServerErrorTraceCorrelationId = 0f99159f-f6f5-50b3-6c0f-d9fa0611d3d4
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-07 19:41:50.1608	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2019.pnp.com/sites/tenantadmin,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:0d136bf4-ab18-488b-8808-84d1818dfad5,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:41:50.2588	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 11/8/2019 3:41:50 AM	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:41:50.2588	[OfficeDevPnP.Core]	[0]	[Debug]	Site search ''	0ms	
vstest.console.exe Error: 0 : 2019-11-07 19:41:50.3418	[OfficeDevPnP.Core]	[0]	[Error]	Site search error. Error = Search has encountered a problem that prevents results from being returned.  If the issue persists, please contact your administrator.	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:41:50.3498	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2019.pnp.com/sites/pnptest,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:0d136bf4-ab18-488b-8808-84d1818dfad5,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:41:51.2658	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 11/8/2019 3:41:50 AM	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:35.3461	[OfficeDevPnP.Core]	[0]	[Information]	Creating web 'sub' with template ''.	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.0822	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2019.pnp.com/sites/TestPnPSC_12345_5bfd9143-3e20-4059-a007-55a495e70153,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:0d136bf4-ab18-488b-8808-84d1818dfad5,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.1942	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 11/8/2019 3:42:40 AM	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.1952	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_files.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.3282	[Provisioning]	[449]	[Debug]	Code execution scope started	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.3282	[Provisioning]	[449]	[Information]	ProgressDelegate registered	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.4062	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.4062	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.4062	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.4062	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.4072	[Files]	[449]	[Debug]	Code execution scope started	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.5222	[OfficeDevPnP.Core]	[0]	[Information]	File ct1document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.5222	[Files]	[449]	[Debug]	Uploading file ct1document.docx	115ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.5232	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'ct1document.docx'	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.8613	[OfficeDevPnP.Core]	[0]	[Information]	File ct3document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.8623	[Files]	[449]	[Debug]	Uploading file ct3document.docx	454ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:40.8623	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'ct3document.docx'	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.1803	[OfficeDevPnP.Core]	[0]	[Information]	File CT3DisplayForm.aspx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.1803	[Files]	[449]	[Debug]	Uploading file CT3DisplayForm.aspx	773ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.1813	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'CT3DisplayForm.aspx'	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.4683	[OfficeDevPnP.Core]	[0]	[Information]	File CT3EditForm.aspx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.4683	[Files]	[449]	[Debug]	Uploading file CT3EditForm.aspx	1061ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.4683	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'CT3EditForm.aspx'	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.6743	[Files]	[449]	[Debug]	Code execution scope ended	1267ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.6743	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.6743	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.6753	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.6753	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.6753	[Persist Template Info]	[449]	[Debug]	Code execution scope started	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.8533	[Persist Template Info]	[449]	[Debug]	Code execution scope ended	177ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.8533	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.8543	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.8703	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.8713	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:41.8713	[Provisioning]	[449]	[Debug]	Code execution scope ended	1543ms	7c8d1c07-a0c9-4494-ae02-87c40fc7d98f
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.0713	[Extraction]	[449]	[Debug]	Code execution scope started	0ms	2f221226-e447-471a-a515-8ca9b11d0927
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.0713	[Extraction]	[449]	[Debug]	Base template available: STS0template	0ms	2f221226-e447-471a-a515-8ca9b11d0927
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.0713	[Extraction]	[449]	[Debug]	ProgressDelegate registered	0ms	2f221226-e447-471a-a515-8ca9b11d0927
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.0723	[Retrieve Template Info]	[449]	[Debug]	Code execution scope started	0ms	2f221226-e447-471a-a515-8ca9b11d0927
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.1553	[Retrieve Template Info]	[449]	[Debug]	Code execution scope ended	83ms	2f221226-e447-471a-a515-8ca9b11d0927
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.1553	[Extraction]	[449]	[Debug]	Code execution scope ended	84ms	2f221226-e447-471a-a515-8ca9b11d0927
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.3213	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_add.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.3803	[Provisioning]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.3813	[Provisioning]	[449]	[Information]	ProgressDelegate registered	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.4183	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.4193	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.4193	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.4193	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.4193	[Fields (ListAndStandardFields)]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.5563	[Fields (ListAndStandardFields)]	[449]	[Debug]	Adding field {92BC6A41-D501-4FE2-938E-17FBF574A7CB} to site	136ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.6813	[Fields (ListAndStandardFields)]	[449]	[Debug]	Adding field {56407FDD-C7FA-4321-8FA5-06B7AF970519} to site	261ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.7923	[Fields (ListAndStandardFields)]	[449]	[Debug]	Adding field {B46D91E2-C755-4C3A-AC72-7FD3E4853476} to site	372ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:42.9043	[Fields (ListAndStandardFields)]	[449]	[Debug]	Adding field {B2C51364-8C48-4779-8265-1169B81CE5A0} to site	485ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:43.0193	[Fields (ListAndStandardFields)]	[449]	[Debug]	Code execution scope ended	599ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:43.0203	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:43.0203	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:43.0203	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:43.0203	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:43.0213	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:43.7724	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Creating new Content Type: 0x010002256D58F4CF427DA2AAA876B1DCF366 - CT_12	751ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:43.7724	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_12' (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:44.0413	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:44.3363	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:44.5953	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:44.8433	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:45.1103	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Creating new Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	2093ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:45.1103	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_10' (0x010076029D9059824413B137EA0A9B5FAAA0).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:45.3783	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x010076029D9059824413B137EA0A9B5FAAA0).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:45.6123	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Creating new Content Type: 0x0100B1459203A48B4E878238B723CD10EECA - CT_11	2591ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:45.6123	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_11' (0x0100B1459203A48B4E878238B723CD10EECA).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:45.9043	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Creating new Content Type: 0x0101001AF9DBB0E32F47A1A0BA519392153128 - CT_3	2883ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:45.9043	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_3' (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:46.2014	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:46.5054	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:46.7574	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:47.0184	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Error: 0 : 2019-11-07 19:42:47.2064	[OfficeDevPnP.Core]	[0]	[Error]	File _cts/CT_3//sites/TestPnPSC_12345_5bfd9143-3e20-4059-a007-55a495e70153/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_5bfd9143-3e20-4059-a007-55a495e70153\siteassets\ct3document.docx'.	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:47.3424	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Creating new Content Type: 0x0101005D4F34E4BE7F4B6892AEBE088EDD215E - CT_1	4321ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:47.3434	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_1' (0x0101005D4F34E4BE7F4B6892AEBE088EDD215E).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:47.6274	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0101005D4F34E4BE7F4B6892AEBE088EDD215E).	0ms	
vstest.console.exe Error: 0 : 2019-11-07 19:42:47.7634	[OfficeDevPnP.Core]	[0]	[Error]	File _cts/CT_1//sites/TestPnPSC_12345_5bfd9143-3e20-4059-a007-55a495e70153/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_5bfd9143-3e20-4059-a007-55a495e70153\siteassets\ct1document.docx'.	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:47.8764	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Creating new Content Type: 0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41 - CT_2	4855ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:47.8764	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_2' (0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:48.1194	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Creating new Content Type: 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 - CT_20	5098ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:48.1194	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_20' (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:48.4524	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:48.7634	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:49.0935	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:49.4595	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:49.8965	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT20Document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:49.9055	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT20Document0101.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:50.3556	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Creating new Content Type: 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA - CT_22	7334ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:50.3565	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_22' (0x0120D520006F71536046A14A71A827ECCAE8D5B1AA).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:50.6875	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D520006F71536046A14A71A827ECCAE8D5B1AA).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:51.0755	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Creating new Content Type: 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 - CT_21	8054ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:51.0767	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_21' (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:51.3926	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:51.6456	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:51.9246	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT21Document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2196	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Code execution scope ended	9197ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2196	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2196	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2206	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2206	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2216	[Fields (LookupFields)]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2996	[Fields (LookupFields)]	[449]	[Debug]	Code execution scope ended	79ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2996	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2996	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2996	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2996	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:52.2996	[Content Types (LookupFields)]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.1157	[Content Types (LookupFields)]	[449]	[Debug]	Updating existing Content Type: 0x010002256D58F4CF427DA2AAA876B1DCF366 - CT_12	813ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.1176	[Content Types (LookupFields)]	[449]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	815ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.1186	[Content Types (LookupFields)]	[449]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	816ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.1196	[Content Types (LookupFields)]	[449]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	817ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.1206	[Content Types (LookupFields)]	[449]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	818ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.1216	[Content Types (LookupFields)]	[449]	[Debug]	Update child Content Types: True	819ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2036	[Content Types (LookupFields)]	[449]	[Debug]	Updating existing Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	902ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2056	[Content Types (LookupFields)]	[449]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	903ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2056	[Content Types (LookupFields)]	[449]	[Debug]	Update child Content Types: True	903ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2726	[Content Types (LookupFields)]	[449]	[Debug]	Updating existing Content Type: 0x0100B1459203A48B4E878238B723CD10EECA - CT_11	971ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2737	[Content Types (LookupFields)]	[449]	[Debug]	Updating existing Content Type: 0x0101001AF9DBB0E32F47A1A0BA519392153128 - CT_3	971ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2757	[Content Types (LookupFields)]	[449]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	973ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2767	[Content Types (LookupFields)]	[449]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	974ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2777	[Content Types (LookupFields)]	[449]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	975ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2786	[Content Types (LookupFields)]	[449]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	976ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.2786	[Content Types (LookupFields)]	[449]	[Debug]	Update child Content Types: True	977ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.3806	[Content Types (LookupFields)]	[449]	[Debug]	Updating existing Content Type: 0x0101005D4F34E4BE7F4B6892AEBE088EDD215E - CT_1	1078ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.3826	[Content Types (LookupFields)]	[449]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1080ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.3826	[Content Types (LookupFields)]	[449]	[Debug]	Update child Content Types: True	1080ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.4586	[Content Types (LookupFields)]	[449]	[Debug]	Updating existing Content Type: 0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41 - CT_2	1156ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.4597	[Content Types (LookupFields)]	[449]	[Debug]	Updating existing Content Type: 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 - CT_20	1157ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.4606	[Content Types (LookupFields)]	[449]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1159ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.4626	[Content Types (LookupFields)]	[449]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	1160ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.4636	[Content Types (LookupFields)]	[449]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	1161ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.4646	[Content Types (LookupFields)]	[449]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	1162ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Error: 0 : 2019-11-07 19:42:53.4656	[Content Types (LookupFields)]	[449]	[Error]	Content Type 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 with ID CT_20 cannot be transformed into a DocumentSet	1163ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.4656	[Content Types (LookupFields)]	[449]	[Debug]	Update child Content Types: True	1163ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.5596	[Content Types (LookupFields)]	[449]	[Debug]	Updating existing Content Type: 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA - CT_22	1257ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.5617	[Content Types (LookupFields)]	[449]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1259ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Error: 0 : 2019-11-07 19:42:53.5617	[Content Types (LookupFields)]	[449]	[Error]	Content Type 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA with ID CT_22 cannot be transformed into a DocumentSet	1259ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.5617	[Content Types (LookupFields)]	[449]	[Debug]	Update child Content Types: True	1259ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.6416	[Content Types (LookupFields)]	[449]	[Debug]	Updating existing Content Type: 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 - CT_21	1339ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.6436	[Content Types (LookupFields)]	[449]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1341ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.6446	[Content Types (LookupFields)]	[449]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	1342ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Error: 0 : 2019-11-07 19:42:53.6456	[Content Types (LookupFields)]	[449]	[Error]	Content Type 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 with ID CT_21 cannot be transformed into a DocumentSet	1343ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.6456	[Content Types (LookupFields)]	[449]	[Debug]	Update child Content Types: True	1343ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.7326	[Content Types (LookupFields)]	[449]	[Debug]	Code execution scope ended	1430ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.7336	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.7336	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.7336	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.7336	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.7336	[Persist Template Info]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.8897	[Persist Template Info]	[449]	[Debug]	Code execution scope ended	155ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.8907	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.8907	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.8907	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.8907	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:53.8917	[Provisioning]	[449]	[Debug]	Code execution scope ended	11510ms	926f46e0-e3b6-4271-9fc7-2c2c864524d0
vstest.console.exe Information: 0 : 2019-11-07 19:42:54.0987	[Extraction]	[449]	[Debug]	Code execution scope started	0ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:54.0997	[Extraction]	[449]	[Debug]	Base template available: STS0template	0ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:54.0997	[Extraction]	[449]	[Debug]	ProgressDelegate registered	0ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:54.0997	[Fields (Export)]	[449]	[Debug]	Code execution scope started	0ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:54.4477	[Fields (Export)]	[449]	[Debug]	Code execution scope ended	347ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:54.4477	[Content Types (Export)]	[449]	[Debug]	Code execution scope started	0ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.2457	[Content Types (Export)]	[449]	[Debug]	Code execution scope ended	797ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.2467	[Retrieve Template Info]	[449]	[Debug]	Code execution scope started	0ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.3398	[Retrieve Template Info]	[449]	[Debug]	Code execution scope ended	93ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.3407	[Extraction]	[449]	[Debug]	Code execution scope ended	1241ms	06b7a560-b3c2-4cde-a3a7-eece2a106fa5
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.4447	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_delta_1.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.4747	[Provisioning]	[449]	[Debug]	Code execution scope started	0ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.4747	[Provisioning]	[449]	[Information]	ProgressDelegate registered	0ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.5037	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.5037	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.5037	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.5047	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:55.5047	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Code execution scope started	0ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:56.2763	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Updating existing Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	774ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:56.2763	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Updating property ReadOnly	775ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:56.3497	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	845ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:56.3507	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Update child Content Types: True	845ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:56.4077	[Content Types (ListAndStandardFields)]	[449]	[Debug]	Code execution scope ended	902ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:56.4077	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope started	0ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:56.4077	[ProvisioningTemplate WebHook Call]	[449]	[Debug]	Code execution scope ended	0ms	844770ac-3c7f-44ad-a968-56855ed30cc3
vstest.console.exe Information: 0 : 2019-11-07 19:42:56.4087	[Provisioning]	[449]	[Debug]	Code execution scope ended	933ms	844770ac-3c7f-44ad-a968-56855ed30cc3