Test case details
Test name:
OfficeDevPnP.Core.Tests.Framework.Functional.ContentTypeTests.SiteCollectionContentTypeAddingTest
Outcome:
Run at:
12/1/2019 7:51:37 PM
Duration:
00:00:18
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_d9eb5f44-73eb-4541-9d61-f75215567689" 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 = 29531d9f-3752-8012-70d0-2eaada7dd705
Message = The content type "CT_10" at "/sites/TestPnPSC_12345_d9eb5f44-73eb-4541-9d61-f75215567689" is read only.
Source = OfficeDevPnP.Core
ServerStackTrace = 
ServerErrorCode = -2146232832
ServerErrorTypeName = Microsoft.SharePoint.SPContentTypeReadOnlyException
ServerErrorTraceCorrelationId = 29531d9f-3752-8012-70d0-2eaada7dd705
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-01 19:51:37.9599	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2016.pnp.com/sites/tenantadmin,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:9ff790d6-1175-4abc-9891-8ed32d12b06a,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:51:38.0549	[OfficeDevPnP.Core]	[0]	[Debug]	Site search ''	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:51:38.0549	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 12/2/2019 3:51:38 AM	0ms	
vstest.console.exe Error: 0 : 2019-12-01 19:51:38.1339	[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-12-01 19:51:38.1399	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2016.pnp.com/sites/pnptest,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:9ff790d6-1175-4abc-9891-8ed32d12b06a,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:51:39.0489	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 12/2/2019 3:51:38 AM	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:20.1331	[OfficeDevPnP.Core]	[0]	[Information]	Creating web 'sub' with template ''.	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.3675	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2016.pnp.com/sites/TestPnPSC_12345_d9eb5f44-73eb-4541-9d61-f75215567689,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:9ff790d6-1175-4abc-9891-8ed32d12b06a,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.4709	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 12/2/2019 3:52:25 AM	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.4709	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_files.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.5989	[Provisioning]	[438]	[Debug]	Code execution scope started	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.5999	[Provisioning]	[438]	[Information]	ProgressDelegate registered	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.6549	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.6549	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.6559	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.6559	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.6559	[Files]	[438]	[Debug]	Code execution scope started	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.7699	[OfficeDevPnP.Core]	[0]	[Information]	File ct1document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.7699	[Files]	[438]	[Debug]	Uploading file ct1document.docx	113ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:25.7699	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'ct1document.docx'	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.1279	[OfficeDevPnP.Core]	[0]	[Information]	File ct3document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.1289	[Files]	[438]	[Debug]	Uploading file ct3document.docx	472ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.1289	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'ct3document.docx'	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.5049	[OfficeDevPnP.Core]	[0]	[Information]	File CT3DisplayForm.aspx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.5049	[Files]	[438]	[Debug]	Uploading file CT3DisplayForm.aspx	848ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.5049	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'CT3DisplayForm.aspx'	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.7639	[OfficeDevPnP.Core]	[0]	[Information]	File CT3EditForm.aspx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.7639	[Files]	[438]	[Debug]	Uploading file CT3EditForm.aspx	1107ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.7639	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'CT3EditForm.aspx'	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.9250	[Files]	[438]	[Debug]	Code execution scope ended	1268ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.9250	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.9259	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.9259	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.9259	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:26.9259	[Persist Template Info]	[438]	[Debug]	Code execution scope started	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.0840	[Persist Template Info]	[438]	[Debug]	Code execution scope ended	157ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.0840	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.0849	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.1010	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.1010	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.1010	[Provisioning]	[438]	[Debug]	Code execution scope ended	1501ms	2f190eb2-0572-4367-93b5-be47022a0951
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.3859	[Extraction]	[438]	[Debug]	Code execution scope started	0ms	0637e3b5-9f16-4542-bd7b-d3f0b3742526
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.3859	[Extraction]	[438]	[Debug]	Base template available: STS0template	0ms	0637e3b5-9f16-4542-bd7b-d3f0b3742526
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.3859	[Extraction]	[438]	[Debug]	ProgressDelegate registered	0ms	0637e3b5-9f16-4542-bd7b-d3f0b3742526
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.3869	[Retrieve Template Info]	[438]	[Debug]	Code execution scope started	0ms	0637e3b5-9f16-4542-bd7b-d3f0b3742526
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.4509	[Retrieve Template Info]	[438]	[Debug]	Code execution scope ended	64ms	0637e3b5-9f16-4542-bd7b-d3f0b3742526
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.4509	[Extraction]	[438]	[Debug]	Code execution scope ended	65ms	0637e3b5-9f16-4542-bd7b-d3f0b3742526
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.6510	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_add.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.6989	[Provisioning]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.6989	[Provisioning]	[438]	[Information]	ProgressDelegate registered	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.7349	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.7349	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.7359	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.7359	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.7359	[Fields (ListAndStandardFields)]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:27.9169	[Fields (ListAndStandardFields)]	[438]	[Debug]	Adding field {92BC6A41-D501-4FE2-938E-17FBF574A7CB} to site	181ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:28.0649	[Fields (ListAndStandardFields)]	[438]	[Debug]	Adding field {56407FDD-C7FA-4321-8FA5-06B7AF970519} to site	329ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:28.2019	[Fields (ListAndStandardFields)]	[438]	[Debug]	Adding field {B46D91E2-C755-4C3A-AC72-7FD3E4853476} to site	465ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:28.4059	[Fields (ListAndStandardFields)]	[438]	[Debug]	Adding field {B2C51364-8C48-4779-8265-1169B81CE5A0} to site	670ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:28.5480	[Fields (ListAndStandardFields)]	[438]	[Debug]	Code execution scope ended	812ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:28.5480	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:28.5490	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:28.5490	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:28.5490	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:28.5490	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:29.3900	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Creating new Content Type: 0x010002256D58F4CF427DA2AAA876B1DCF366 - CT_12	840ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:29.3900	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_12' (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:29.7840	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:30.2190	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:30.6160	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:30.9100	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x010002256D58F4CF427DA2AAA876B1DCF366).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:31.1890	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Creating new Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	2639ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:31.1890	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_10' (0x010076029D9059824413B137EA0A9B5FAAA0).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:31.4900	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x010076029D9059824413B137EA0A9B5FAAA0).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:31.7311	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Creating new Content Type: 0x0100B1459203A48B4E878238B723CD10EECA - CT_11	3182ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:31.7320	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_11' (0x0100B1459203A48B4E878238B723CD10EECA).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:31.9720	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Creating new Content Type: 0x0101001AF9DBB0E32F47A1A0BA519392153128 - CT_3	3423ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:31.9730	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_3' (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:32.2820	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:32.7240	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:33.0260	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:33.3200	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x0101001AF9DBB0E32F47A1A0BA519392153128).	0ms	
vstest.console.exe Error: 0 : 2019-12-01 19:52:33.4990	[OfficeDevPnP.Core]	[0]	[Error]	File _cts/CT_3//sites/TestPnPSC_12345_d9eb5f44-73eb-4541-9d61-f75215567689/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_d9eb5f44-73eb-4541-9d61-f75215567689\siteassets\ct3document.docx'.	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:33.6180	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Creating new Content Type: 0x0101005D4F34E4BE7F4B6892AEBE088EDD215E - CT_1	5068ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:33.6180	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_1' (0x0101005D4F34E4BE7F4B6892AEBE088EDD215E).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:33.9400	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0101005D4F34E4BE7F4B6892AEBE088EDD215E).	0ms	
vstest.console.exe Error: 0 : 2019-12-01 19:52:34.1080	[OfficeDevPnP.Core]	[0]	[Error]	File _cts/CT_1//sites/TestPnPSC_12345_d9eb5f44-73eb-4541-9d61-f75215567689/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_d9eb5f44-73eb-4541-9d61-f75215567689\siteassets\ct1document.docx'.	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:34.2010	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Creating new Content Type: 0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41 - CT_2	5651ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:34.2010	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_2' (0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:34.4720	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Creating new Content Type: 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 - CT_20	5922ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:34.4720	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_20' (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:34.8460	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:35.1890	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:35.5450	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b46d91e2-c755-4c3a-ac72-7fd3e4853476) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:35.9350	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (b2c51364-8c48-4779-8265-1169b81ce5a0) to content type (0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:36.3450	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT20Document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:36.3460	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT20Document0101.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:36.7310	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Creating new Content Type: 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA - CT_22	8181ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:36.7310	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_22' (0x0120D520006F71536046A14A71A827ECCAE8D5B1AA).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:37.1316	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D520006F71536046A14A71A827ECCAE8D5B1AA).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:37.5176	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Creating new Content Type: 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 - CT_21	8968ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:37.5186	[OfficeDevPnP.Core]	[0]	[Information]	Creating content type 'CT_21' (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:37.8596	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (92bc6a41-d501-4fe2-938e-17fbf574a7cb) to content type (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.1526	[OfficeDevPnP.Core]	[0]	[Information]	Adding field (56407fdd-c7fa-4321-8fa5-06b7af970519) to content type (0x0120D52000E5DBFFDBB86B454096672F072D473FC8).	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.4326	[OfficeDevPnP.Core]	[0]	[Information]	File ./CT21Document.docx retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.7106	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Code execution scope ended	10161ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.7106	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.7116	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.7116	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.7116	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.7116	[Fields (LookupFields)]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.8526	[Fields (LookupFields)]	[438]	[Debug]	Code execution scope ended	140ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.8536	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.8536	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.8536	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.8536	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:38.8536	[Content Types (LookupFields)]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.7366	[Content Types (LookupFields)]	[438]	[Debug]	Updating existing Content Type: 0x010002256D58F4CF427DA2AAA876B1DCF366 - CT_12	882ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.7386	[Content Types (LookupFields)]	[438]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	884ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.7396	[Content Types (LookupFields)]	[438]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	885ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.7416	[Content Types (LookupFields)]	[438]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	887ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.7426	[Content Types (LookupFields)]	[438]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	888ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.7426	[Content Types (LookupFields)]	[438]	[Debug]	Update child Content Types: True	888ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8156	[Content Types (LookupFields)]	[438]	[Debug]	Updating existing Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	961ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8176	[Content Types (LookupFields)]	[438]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	963ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8176	[Content Types (LookupFields)]	[438]	[Debug]	Update child Content Types: True	963ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8768	[Content Types (LookupFields)]	[438]	[Debug]	Updating existing Content Type: 0x0100B1459203A48B4E878238B723CD10EECA - CT_11	1022ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8768	[Content Types (LookupFields)]	[438]	[Debug]	Updating existing Content Type: 0x0101001AF9DBB0E32F47A1A0BA519392153128 - CT_3	1022ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8786	[Content Types (LookupFields)]	[438]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1024ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8796	[Content Types (LookupFields)]	[438]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	1025ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8806	[Content Types (LookupFields)]	[438]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	1026ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8816	[Content Types (LookupFields)]	[438]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	1028ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.8826	[Content Types (LookupFields)]	[438]	[Debug]	Update child Content Types: True	1028ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.9616	[Content Types (LookupFields)]	[438]	[Debug]	Updating existing Content Type: 0x0101005D4F34E4BE7F4B6892AEBE088EDD215E - CT_1	1107ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.9686	[Content Types (LookupFields)]	[438]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1114ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:39.9696	[Content Types (LookupFields)]	[438]	[Debug]	Update child Content Types: True	1115ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.0386	[Content Types (LookupFields)]	[438]	[Debug]	Updating existing Content Type: 0x0101008C05EC4BEB1F4DFE9D8828D2DA449D41 - CT_2	1184ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.0396	[Content Types (LookupFields)]	[438]	[Debug]	Updating existing Content Type: 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 - CT_20	1185ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.0406	[Content Types (LookupFields)]	[438]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1186ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.0416	[Content Types (LookupFields)]	[438]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	1187ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.0426	[Content Types (LookupFields)]	[438]	[Debug]	Field b46d91e2-c755-4c3a-ac72-7fd3e4853476 exists in content type	1188ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.0446	[Content Types (LookupFields)]	[438]	[Debug]	Field b2c51364-8c48-4779-8265-1169b81ce5a0 exists in content type	1190ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Error: 0 : 2019-12-01 19:52:40.0456	[Content Types (LookupFields)]	[438]	[Error]	Content Type 0x0120D5200039D83CD2C9BA4A4499AEE6BE3562E023 with ID CT_20 cannot be transformed into a DocumentSet	1191ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.0456	[Content Types (LookupFields)]	[438]	[Debug]	Update child Content Types: True	1191ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.1426	[Content Types (LookupFields)]	[438]	[Debug]	Updating existing Content Type: 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA - CT_22	1288ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.1446	[Content Types (LookupFields)]	[438]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1290ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Error: 0 : 2019-12-01 19:52:40.1446	[Content Types (LookupFields)]	[438]	[Error]	Content Type 0x0120D520006F71536046A14A71A827ECCAE8D5B1AA with ID CT_22 cannot be transformed into a DocumentSet	1290ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.1446	[Content Types (LookupFields)]	[438]	[Debug]	Update child Content Types: True	1290ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2156	[Content Types (LookupFields)]	[438]	[Debug]	Updating existing Content Type: 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 - CT_21	1361ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2177	[Content Types (LookupFields)]	[438]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1363ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2186	[Content Types (LookupFields)]	[438]	[Debug]	Field 56407fdd-c7fa-4321-8fa5-06b7af970519 exists in content type	1364ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Error: 0 : 2019-12-01 19:52:40.2196	[Content Types (LookupFields)]	[438]	[Error]	Content Type 0x0120D52000E5DBFFDBB86B454096672F072D473FC8 with ID CT_21 cannot be transformed into a DocumentSet	1365ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2196	[Content Types (LookupFields)]	[438]	[Debug]	Update child Content Types: True	1365ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2936	[Content Types (LookupFields)]	[438]	[Debug]	Code execution scope ended	1439ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2936	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2936	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2936	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2936	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.2946	[Persist Template Info]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.4196	[Persist Template Info]	[438]	[Debug]	Code execution scope ended	125ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.4206	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.4206	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.4206	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.4206	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.4206	[Provisioning]	[438]	[Debug]	Code execution scope ended	12721ms	f07ca7db-d7d7-4c8d-b01a-e7f232eb41f8
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.6986	[Extraction]	[438]	[Debug]	Code execution scope started	0ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.6986	[Extraction]	[438]	[Debug]	Base template available: STS0template	0ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.6996	[Extraction]	[438]	[Debug]	ProgressDelegate registered	0ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:40.6996	[Fields (Export)]	[438]	[Debug]	Code execution scope started	0ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:41.3786	[Fields (Export)]	[438]	[Debug]	Code execution scope ended	679ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:41.3796	[Content Types (Export)]	[438]	[Debug]	Code execution scope started	0ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3286	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x01010000DEC92EFE5D445789D9FE4A3225A381 - Translation Status	948ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3286	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x0101002039C03B61C64EC4A04F5361F385106601 - Control Display Template	949ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3286	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x0101002039C03B61C64EC4A04F5361F385106602 - Group Display Template	949ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3296	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x0101002039C03B61C64EC4A04F5361F385106603 - Item Display Template	949ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3296	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x0101002039C03B61C64EC4A04F5361F385106604 - Filter Display Template	950ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3296	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x010100672A3FCA98991645BE083C320B7539B7 - E-mail Submission	950ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3296	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x010100C568DB52D9D0A14D9B2FDCC96666E9F2007948130EC3DB064584E219954237AF3900B46186789C3140CC85BE610336E86BBB - Catalog-Item Reuse	950ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3306	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x010100E4FE8612EC394E3690F102C0A1A07563 - Translation Document	950ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3306	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x010100E8711F0F931646FA949751442A907B22 - Translation Package	950ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3306	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x01080100C9C9515DE4E24001905074F980F93160000EEA96BE7C83464C9211129CD27F0409 - Collect Feedback Workflow Task (en-US)	950ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3306	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x01080100C9C9515DE4E24001905074F980F93160002E9DB43AC527439AB853AE4FC8360409 - Collect Signatures Workflow Task (en-US)	951ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3306	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x01080100C9C9515DE4E24001905074F980F93160003A15057E2AF34B67B32E14B94EB70409 - Approval Workflow Task (en-US)	951ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3306	[Content Types (Export)]	[438]	[Debug]	Adding content type to template: 0x01080100C9C9515DE4E24001905074F980F9316001 - Signatures Workflow Task Deprecated	951ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3316	[Content Types (Export)]	[438]	[Debug]	Code execution scope ended	951ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3316	[Retrieve Template Info]	[438]	[Debug]	Code execution scope started	0ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3986	[Retrieve Template Info]	[438]	[Debug]	Code execution scope ended	66ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.3986	[Extraction]	[438]	[Debug]	Code execution scope ended	1700ms	bc3a3067-4bf2-4cb4-8322-2062e820623a
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.4906	[OfficeDevPnP.Core]	[0]	[Information]	File contenttype_delta_1.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.5276	[Provisioning]	[438]	[Debug]	Code execution scope started	0ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.5276	[Provisioning]	[438]	[Information]	ProgressDelegate registered	0ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.5446	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.5446	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.5446	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.5456	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:42.5456	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Code execution scope started	0ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:43.4916	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Updating existing Content Type: 0x010076029D9059824413B137EA0A9B5FAAA0 - CT_10	946ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:43.4916	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Updating property ReadOnly	946ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:43.5546	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Field 92bc6a41-d501-4fe2-938e-17fbf574a7cb exists in content type	1009ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:43.5546	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Update child Content Types: True	1009ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:43.5906	[Content Types (ListAndStandardFields)]	[438]	[Debug]	Code execution scope ended	1045ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:43.5916	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope started	0ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:43.5916	[ProvisioningTemplate WebHook Call]	[438]	[Debug]	Code execution scope ended	0ms	e3ad6c78-9103-4c75-8f90-864da993106e
vstest.console.exe Information: 0 : 2019-12-01 19:52:43.5916	[Provisioning]	[438]	[Debug]	Code execution scope ended	1064ms	e3ad6c78-9103-4c75-8f90-864da993106e