Test case details
Test name:
OfficeDevPnP.Core.Tests.Framework.Functional.WebSettingsTests.WebWebSettingsTest
Outcome:
Run at:
5/14/2019 7:56:04 PM
Duration:
00:00:02
Error message:
Assert.IsTrue failed.
Stacktrace:
at at OfficeDevPnP.Core.Tests.Framework.Functional.Implementation.WebSettingsImplementation.WebWebSettings(String siteCollectionUrl, String url) in c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\Implementation\WebSettingsImplementation.cs:line 44 at OfficeDevPnP.Core.Tests.Framework.Functional.WebSettingsTests.WebWebSettingsTest() in c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\WebSettingsTests.cs:line 76
Console output:
    Applying template - 1/2 - Initializing engine
Applying template - 2/2 - Files
Applying template - 1/2 - Initializing engine
Applying template - 2/2 - Web Settings
Getting template - 1/1 - Web Settings
Source XML:<pnp:WebSettings RequestAccessEmail="test@pnp.com" WelcomePage="SitePages/Home.aspx" SiteLogo="{sitecollection}/SiteAssets/garagelogo.png" AlternateCSS="{sitecollection}/SiteAssets/garage.css" xmlns:pnp="http://schemas.dev.office.com/PnP/2015/12/ProvisioningSchema" />
Target XML:<pnp:WebSettings RequestAccessEmail="test@pnp.com" WelcomePage="SitePages/Home.aspx" SiteLogo="/sites/TestPnPSC_12345_eb3b6303-838b-4b9d-a928-252abfb3f314/SiteAssets/garagelogo.png" AlternateCSS="/sites/TestPnPSC_12345_eb3b6303-838b-4b9d-a928-252abfb3f314/SiteAssets/garage.css" xmlns:pnp="http://schemas.dev.office.com/PnP/2015/12/ProvisioningSchema" />



Debug Trace:
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.0397	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2016.pnp.com/sites/TestPnPSC_12345_eb3b6303-838b-4b9d-a928-252abfb3f314,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:9ff790d6-1175-4abc-9891-8ed32d12b06a,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.1334	[OfficeDevPnP.Core]	[0]	[Information]	File websettings_files.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.1803	[Provisioning]	[450]	[Debug]	Code execution scope started	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.1803	[Provisioning]	[450]	[Information]	ProgressDelegate registered	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.2115	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.2271	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.2271	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.2271	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.2271	[Files]	[450]	[Debug]	Code execution scope started	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.2897	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 5/15/2019 3:56:04 AM	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.3365	[Files]	[450]	[Debug]	Uploading and overwriting existing file garagelogo.png	114ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.3678	[OfficeDevPnP.Core]	[0]	[Information]	File garagelogo.png retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.3678	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'garagelogo.png'	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.6959	[Files]	[450]	[Debug]	Uploading and overwriting existing file garage.css	472ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.7272	[OfficeDevPnP.Core]	[0]	[Information]	File garage.css retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.7272	[OfficeDevPnP.Core]	[0]	[Debug]	Creating file info with Url 'garage.css'	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.9304	[Files]	[450]	[Debug]	Code execution scope ended	712ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.9304	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.9304	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.9304	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.9304	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:04.9304	[Persist Template Info]	[450]	[Debug]	Code execution scope started	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.0553	[Persist Template Info]	[450]	[Debug]	Code execution scope ended	120ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.0553	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.0553	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.0866	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.0866	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.0866	[Provisioning]	[450]	[Debug]	Code execution scope ended	898ms	2055b568-1f72-4e0c-8b1c-dc2ca3a9d2a6
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.3521	[Extraction]	[450]	[Debug]	Code execution scope started	0ms	cef894ac-567b-4919-8982-f94cf42105ad
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.3521	[Extraction]	[450]	[Debug]	Base template available: STS0template	0ms	cef894ac-567b-4919-8982-f94cf42105ad
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.3521	[Extraction]	[450]	[Debug]	ProgressDelegate registered	0ms	cef894ac-567b-4919-8982-f94cf42105ad
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.3521	[Retrieve Template Info]	[450]	[Debug]	Code execution scope started	0ms	cef894ac-567b-4919-8982-f94cf42105ad
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.4303	[Retrieve Template Info]	[450]	[Debug]	Code execution scope ended	72ms	cef894ac-567b-4919-8982-f94cf42105ad
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.4303	[Extraction]	[450]	[Debug]	Code execution scope ended	73ms	cef894ac-567b-4919-8982-f94cf42105ad
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.4459	[OfficeDevPnP.Core]	[0]	[Debug]	AuthenticationManager:EnsureToken(siteUrl:https://portal2016.pnp.com/sites/TestPnPSC_12345_eb3b6303-838b-4b9d-a928-252abfb3f314/sub,realm:d8623c9e-30c7-473a-83bc-d907df44a26e,appId:9ff790d6-1175-4abc-9891-8ed32d12b06a,appSecret:PRIVATE)	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.5398	[OfficeDevPnP.Core]	[0]	[Debug]	Lease expiration date: 5/15/2019 3:56:05 AM	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.5398	[OfficeDevPnP.Core]	[0]	[Information]	File websettings_add.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.5865	[Provisioning]	[450]	[Debug]	Code execution scope started	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.5865	[Provisioning]	[450]	[Information]	ProgressDelegate registered	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.6178	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.6178	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.6178	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.6178	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.6178	[Web Settings]	[450]	[Debug]	Code execution scope started	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.8522	[Web Settings]	[450]	[Debug]	Code execution scope ended	232ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.8522	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.8522	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.8522	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.8522	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:05.8522	[Persist Template Info]	[450]	[Debug]	Code execution scope started	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.0084	[Persist Template Info]	[450]	[Debug]	Code execution scope ended	146ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.0084	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.0084	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.0084	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope started	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.0084	[ProvisioningTemplate WebHook Call]	[450]	[Debug]	Code execution scope ended	0ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.0084	[Provisioning]	[450]	[Debug]	Code execution scope ended	408ms	35249350-8846-4b7b-bb9a-b40b933d28e5
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.2584	[Extraction]	[450]	[Debug]	Code execution scope started	0ms	f4cd09ee-4e48-4818-9b18-129eb1825d08
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.2584	[Extraction]	[450]	[Debug]	Base template available: STS0template	0ms	f4cd09ee-4e48-4818-9b18-129eb1825d08
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.2584	[Extraction]	[450]	[Debug]	ProgressDelegate registered	0ms	f4cd09ee-4e48-4818-9b18-129eb1825d08
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.2584	[Web Settings]	[450]	[Debug]	Code execution scope started	0ms	f4cd09ee-4e48-4818-9b18-129eb1825d08
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.3053	[Web Settings]	[450]	[Debug]	Code execution scope ended	36ms	f4cd09ee-4e48-4818-9b18-129eb1825d08
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.3053	[Retrieve Template Info]	[450]	[Debug]	Code execution scope started	0ms	f4cd09ee-4e48-4818-9b18-129eb1825d08
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.3678	[Retrieve Template Info]	[450]	[Debug]	Code execution scope ended	72ms	f4cd09ee-4e48-4818-9b18-129eb1825d08
vstest.console.exe Information: 0 : 2019-05-14 19:56:06.3678	[Extraction]	[450]	[Debug]	Code execution scope ended	109ms	f4cd09ee-4e48-4818-9b18-129eb1825d08