Test case details
Test name:
OfficeDevPnP.Core.Tests.Framework.Functional.ContentTypeTests.SiteCollectionContentTypeAddingTest
Outcome:
Run at:
12/2/2019 8:56:24 PM
Duration:
00:00:13
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_7b082849-f626-4c38-ab16-4a0d8497b765" 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 = 42a91d9f-a5a0-4047-f1f8-62e76d7ee3b8
Message = The content type "CT_10" at "/sites/TestPnPSC_12345_7b082849-f626-4c38-ab16-4a0d8497b765" is read only.
Source = OfficeDevPnP.Core
ServerStackTrace = 
ServerErrorCode = -2146232832
ServerErrorTypeName = Microsoft.SharePoint.SPContentTypeReadOnlyException
ServerErrorTraceCorrelationId = 42a91d9f-a5a0-4047-f1f8-62e76d7ee3b8
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-12-02 20:56:24.6597	[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-12-02 20:56:24.7497	[OfficeDevPnP.Core]	[0]	[Debug]	Site search ''	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:56:24.7497	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 12/3/2019 4:56:24 AM	0ms	
vstest.console.exe Error: 0 : 2019-12-02 20:56:24.8127	[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-12-02 20:56:24.8166	[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-12-02 20:56:25.2914	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 12/3/2019 4:56:24 AM	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:06.8204	[OfficeDevPnP.Core]	[0]	[Information]	Creating web 'sub' with template ''.	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.6244	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2013.pnp.com/sites/TestPnPSC_12345_7b082849-f626-4c38-ab16-4a0d8497b765,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:a7ec4f8f-275b-4ea6-be14-0ae5330128a2,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.7294	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 12/3/2019 4:57:11 AM	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.7294	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_files.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.8554	[Provisioning]	[446]	[Debug]	Code execution scope started	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.8554	[Provisioning]	[446]	[Information]	ProgressDelegate registered	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.8884	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.8884	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.8894	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.8894	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:11.8894	[Files]	[446]	[Debug]	Code execution scope started	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.0164	[OfficeDevPnP.Core]	[0]	[Information]	File ct1document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.0164	[Files]	[446]	[Debug]	Uploading file ct1document.docx	127ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.0164	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'ct1document.docx'	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.3214	[OfficeDevPnP.Core]	[0]	[Information]	File ct3document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.3214	[Files]	[446]	[Debug]	Uploading file ct3document.docx	431ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.3214	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'ct3document.docx'	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.6044	[OfficeDevPnP.Core]	[0]	[Information]	File CT3DisplayForm.aspx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.6054	[Files]	[446]	[Debug]	Uploading file CT3DisplayForm.aspx	715ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.6054	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'CT3DisplayForm.aspx'	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.8614	[OfficeDevPnP.Core]	[0]	[Information]	File CT3EditForm.aspx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.8614	[Files]	[446]	[Debug]	Uploading file CT3EditForm.aspx	972ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:12.8624	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'CT3EditForm.aspx'	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.0024	[Files]	[446]	[Debug]	Code execution scope ended	1112ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.0024	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.0034	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.0034	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.0034	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.0034	[Persist Template Info]	[446]	[Debug]	Code execution scope started	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.1754	[Persist Template Info]	[446]	[Debug]	Code execution scope ended	171ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.1754	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.1764	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.1884	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.1884	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.1884	[Provisioning]	[446]	[Debug]	Code execution scope ended	1333ms	2f3049c3-61d8-481c-a81c-e2c5a7011c5d
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.3694	[Extraction]	[446]	[Debug]	Code execution scope started	0ms	bfb96fc3-b94b-490f-8037-d776604c04bf
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.3694	[Extraction]	[446]	[Debug]	Base template available: STS0template	0ms	bfb96fc3-b94b-490f-8037-d776604c04bf
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.3694	[Extraction]	[446]	[Debug]	ProgressDelegate registered	0ms	bfb96fc3-b94b-490f-8037-d776604c04bf
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.3704	[Retrieve Template Info]	[446]	[Debug]	Code execution scope started	0ms	bfb96fc3-b94b-490f-8037-d776604c04bf
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.4254	[Retrieve Template Info]	[446]	[Debug]	Code execution scope ended	54ms	bfb96fc3-b94b-490f-8037-d776604c04bf
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.4254	[Extraction]	[446]	[Debug]	Code execution scope ended	56ms	bfb96fc3-b94b-490f-8037-d776604c04bf
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.5474	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_add.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.6004	[Provisioning]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.6014	[Provisioning]	[446]	[Information]	ProgressDelegate registered	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.6344	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.6354	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.6354	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.6354	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.6354	[Fields (ListAndStandardFields)]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.7354	[Fields (ListAndStandardFields)]	[446]	[Debug]	Adding field {92BC6A41-D501-4FE2-938E-17FBF574A7CB} to site	99ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.8004	[Fields (ListAndStandardFields)]	[446]	[Debug]	Adding field {56407FDD-C7FA-4321-8FA5-06B7AF970519} to site	164ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.8664	[Fields (ListAndStandardFields)]	[446]	[Debug]	Adding field {B46D91E2-C755-4C3A-AC72-7FD3E4853476} to site	230ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:13.9464	[Fields (ListAndStandardFields)]	[446]	[Debug]	Adding field {B2C51364-8C48-4779-8265-1169B81CE5A0} to site	310ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:14.0134	[Fields (ListAndStandardFields)]	[446]	[Debug]	Code execution scope ended	377ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:14.0134	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:14.0134	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:14.0134	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:14.0144	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:14.0144	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:14.6622	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Creating new Content Type: 0x010002256D58F4CF427DA2AAA876B1DCF366 - CT_12	647ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:14.6622	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_12' (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:14.9142	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:15.1712	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:15.3963	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:15.6302	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:15.9152	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Creating new Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	1900ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:15.9152	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_10' (0x010076029D9059824413B137EA0A9B5FAAA0).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:16.0922	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x010076029D9059824413B137EA0A9B5FAAA0).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:16.2852	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Creating new Content Type: 0x0100B1459203A48B4E878238B723CD10EECA - CT_11	2271ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:16.2852	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_11' (0x0100B1459203A48B4E878238B723CD10EECA).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:16.4962	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Creating new Content Type: 0x0101001AF9DBB0E32F47A1A0BA519392153128 - CT_3	2481ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:16.4962	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_3' (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:16.6912	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:16.9312	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:17.0922	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:17.2572	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Error: 0 : 2019-12-02 20:57:17.4072	[OfficeDevPnP.Core]	[0]	[Error]	File _cts/CT_3//sites/TestPnPSC_12345_7b082849-f626-4c38-ab16-4a0d8497b765/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_7b082849-f626-4c38-ab16-4a0d8497b765\siteassets\ct3document.docx'.	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:17.5222	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Creating new Content Type: 0x0101005D4F34E4BE7F4B6892AEBE088EDD215E - CT_1	3508ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:17.5233	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_1' (0x0101005D4F34E4BE7F4B6892AEBE088EDD215E).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:17.7472	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0101005D4F34E4BE7F4B6892AEBE088EDD215E).	0ms	
vstest.console.exe Error: 0 : 2019-12-02 20:57:17.8822	[OfficeDevPnP.Core]	[0]	[Error]	File _cts/CT_1//sites/TestPnPSC_12345_7b082849-f626-4c38-ab16-4a0d8497b765/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_7b082849-f626-4c38-ab16-4a0d8497b765\siteassets\ct1document.docx'.	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:17.9672	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Creating new Content Type: 0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41 - CT_2	3953ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:17.9672	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_2' (0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:18.1982	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Creating new Content Type: 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 - CT_20	4184ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:18.1992	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_20' (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:18.4442	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:18.6632	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:18.8802	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:19.1222	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:19.4623	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT20Document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:19.4642	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT20Document0101.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:19.7762	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Creating new Content Type: 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA - CT_22	5762ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:19.7772	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_22' (0x0120D520006F71536046A14A71A827ECCAE8D5B1AA).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:20.0046	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D520006F71536046A14A71A827ECCAE8D5B1AA).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:20.3322	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Creating new Content Type: 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 - CT_21	6318ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:20.3332	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_21' (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:20.5612	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:20.7142	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:20.9533	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT21Document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.1809	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Code execution scope ended	7166ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.1809	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.1809	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.1819	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.1819	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.1819	[Fields (LookupFields)]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.2289	[Fields (LookupFields)]	[446]	[Debug]	Code execution scope ended	46ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.2289	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.2289	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.2299	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.2299	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.2299	[Content Types (LookupFields)]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.9109	[Content Types (LookupFields)]	[446]	[Debug]	Updating existing Content Type: 0x010002256D58F4CF427DA2AAA876B1DCF366 - CT_12	681ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.9129	[Content Types (LookupFields)]	[446]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	683ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.9149	[Content Types (LookupFields)]	[446]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	684ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.9159	[Content Types (LookupFields)]	[446]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	686ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.9169	[Content Types (LookupFields)]	[446]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	687ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.9179	[Content Types (LookupFields)]	[446]	[Debug]	Update child Content Types: True	687ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.9869	[Content Types (LookupFields)]	[446]	[Debug]	Updating existing Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	756ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.9889	[Content Types (LookupFields)]	[446]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	758ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:21.9889	[Content Types (LookupFields)]	[446]	[Debug]	Update child Content Types: True	759ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.0419	[Content Types (LookupFields)]	[446]	[Debug]	Updating existing Content Type: 0x0100B1459203A48B4E878238B723CD10EECA - CT_11	812ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.0429	[Content Types (LookupFields)]	[446]	[Debug]	Updating existing Content Type: 0x0101001AF9DBB0E32F47A1A0BA519392153128 - CT_3	812ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.0449	[Content Types (LookupFields)]	[446]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	814ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.0459	[Content Types (LookupFields)]	[446]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	815ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.0469	[Content Types (LookupFields)]	[446]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	817ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.0479	[Content Types (LookupFields)]	[446]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	818ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.0489	[Content Types (LookupFields)]	[446]	[Debug]	Update child Content Types: True	818ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.1329	[Content Types (LookupFields)]	[446]	[Debug]	Updating existing Content Type: 0x0101005D4F34E4BE7F4B6892AEBE088EDD215E - CT_1	902ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.1349	[Content Types (LookupFields)]	[446]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	904ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.1349	[Content Types (LookupFields)]	[446]	[Debug]	Update child Content Types: True	905ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.1969	[Content Types (LookupFields)]	[446]	[Debug]	Updating existing Content Type: 0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41 - CT_2	967ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.1979	[Content Types (LookupFields)]	[446]	[Debug]	Updating existing Content Type: 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 - CT_20	967ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.1989	[Content Types (LookupFields)]	[446]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	969ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.2009	[Content Types (LookupFields)]	[446]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	970ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.2019	[Content Types (LookupFields)]	[446]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	972ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.2029	[Content Types (LookupFields)]	[446]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	973ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Error: 0 : 2019-12-02 20:57:22.2039	[Content Types (LookupFields)]	[446]	[Error]	Content Type 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 with ID CT_20 cannot be transformed into a DocumentSet	974ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.2039	[Content Types (LookupFields)]	[446]	[Debug]	Update child Content Types: True	974ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.2809	[Content Types (LookupFields)]	[446]	[Debug]	Updating existing Content Type: 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA - CT_22	1051ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.2829	[Content Types (LookupFields)]	[446]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1052ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Error: 0 : 2019-12-02 20:57:22.2829	[Content Types (LookupFields)]	[446]	[Error]	Content Type 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA with ID CT_22 cannot be transformed into a DocumentSet	1053ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.2829	[Content Types (LookupFields)]	[446]	[Debug]	Update child Content Types: True	1053ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.3419	[Content Types (LookupFields)]	[446]	[Debug]	Updating existing Content Type: 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 - CT_21	1111ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.3439	[Content Types (LookupFields)]	[446]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1113ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.3449	[Content Types (LookupFields)]	[446]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	1114ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Error: 0 : 2019-12-02 20:57:22.3449	[Content Types (LookupFields)]	[446]	[Error]	Content Type 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 with ID CT_21 cannot be transformed into a DocumentSet	1115ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.3449	[Content Types (LookupFields)]	[446]	[Debug]	Update child Content Types: True	1115ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.4109	[Content Types (LookupFields)]	[446]	[Debug]	Code execution scope ended	1180ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.4109	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.4109	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.4109	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.4109	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.4119	[Persist Template Info]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.5189	[Persist Template Info]	[446]	[Debug]	Code execution scope ended	107ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.5199	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.5199	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.5199	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.5199	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.5199	[Provisioning]	[446]	[Debug]	Code execution scope ended	8919ms	44ad9c0e-9f9f-45ee-b894-91a79aa01b99
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.7299	[Extraction]	[446]	[Debug]	Code execution scope started	0ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.7309	[Extraction]	[446]	[Debug]	Base template available: STS0template	0ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.7309	[Extraction]	[446]	[Debug]	ProgressDelegate registered	0ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:22.7309	[Fields (Export)]	[446]	[Debug]	Code execution scope started	0ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:23.1279	[Fields (Export)]	[446]	[Debug]	Code execution scope ended	396ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:23.1289	[Content Types (Export)]	[446]	[Debug]	Code execution scope started	0ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:23.8059	[Content Types (Export)]	[446]	[Debug]	Code execution scope ended	677ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:23.8059	[Retrieve Template Info]	[446]	[Debug]	Code execution scope started	0ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:23.8629	[Retrieve Template Info]	[446]	[Debug]	Code execution scope ended	56ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:23.8629	[Extraction]	[446]	[Debug]	Code execution scope ended	1132ms	cc8391b8-f4e1-41e7-a79b-6c7a58d57095
vstest.console.exe Information: 0 : 2019-12-02 20:57:23.9569	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_delta_1.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-02 20:57:23.9919	[Provisioning]	[446]	[Debug]	Code execution scope started	0ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:23.9919	[Provisioning]	[446]	[Information]	ProgressDelegate registered	0ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.0119	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.0129	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.0129	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.0129	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.0129	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Code execution scope started	0ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.6939	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Updating existing Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	680ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.6949	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Updating property ReadOnly	681ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.7459	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	732ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.7469	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Update child Content Types: True	733ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.7739	[Content Types (ListAndStandardFields)]	[446]	[Debug]	Code execution scope ended	761ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.7749	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope started	0ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.7749	[ProvisioningTemplate WebHook Call]	[446]	[Debug]	Code execution scope ended	0ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac
vstest.console.exe Information: 0 : 2019-12-02 20:57:24.7749	[Provisioning]	[446]	[Debug]	Code execution scope ended	783ms	9922b4b8-bd3f-4563-b1e7-ae92a20bbbac