Test case details
Test name:
OfficeDevPnP.Core.Tests.Framework.Functional.FieldTests.SiteCollectionFieldAddingTest
Outcome:
Run at:
8/9/2018 11:46:14 PM
Duration:
00:00:54
Error message:
Assert.IsTrue failed.
Stacktrace:
at at OfficeDevPnP.Core.Tests.Framework.Functional.Implementation.FieldImplementation.SiteCollectionFieldAdding(String url) in c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\Implementation\FieldImplementation.cs:line 25 at OfficeDevPnP.Core.Tests.Framework.Functional.FieldTests.SiteCollectionFieldAddingTest() in c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\FieldTests.cs:line 55
Console output:
    Applying template - 1/4 - Initializing engine
Applying template - 2/4 - Term Groups
Applying template - 3/4 - Fields (ListAndStandardFields)
Applying template - 4/4 - Fields (LookupFields)
Getting template - 1/1 - Fields (Export)
-- Field validation True
Applying template - 1/3 - Initializing engine
Applying template - 2/3 - Fields (ListAndStandardFields)
Applying template - 3/3 - Fields (LookupFields)
Getting template - 1/1 - Fields (Export)
Source XML:<Field ID="{3A18FCCE-7EAB-45D7-B6B6-C61CEC868057}" Type="LookupMulti" Name="FLD_60" DisplayName="Fld 60" Group="PnP Demo" Required="FALSE" EnforceUniqueValues="FALSE" List="{25874230-3a9f-476f-9b6a-b0aa2076c5b7}" WebId="5cf76f2d-59e0-4fb4-bc6b-7f066ecb2373" ShowField="Title" Mult="TRUE" Sortable="FALSE" UnlimitedLengthInDocumentLibrary="TRUE" />
Target XML:<Field ID="{3A18FCCE-7EAB-45D7-B6B6-C61CEC868057}" Type="LookupMulti" Name="FLD_60" DisplayName="Fld 60" Group="PnP Demo" Required="FALSE" EnforceUniqueValues="FALSE" List="{2db5033d-934d-434d-9f9b-504e8f3b4381}" WebId="5cf76f2d-59e0-4fb4-bc6b-7f066ecb2373" ShowField="Title" Mult="TRUE" Sortable="FALSE" UnlimitedLengthInDocumentLibrary="TRUE" />
-- Field validation False



Debug Trace:
te.processhost.managed.exe Information: 0 : 2018-08-09 23:46:15.7246	[SetSiteLockState: Current: {0} Target: {1}]	[0]	[Information]	Unlock	0ms	
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:23.5442	[OfficeDevPnP.Core]	[0]	[Information]	Creating web 'sub' with template ''.	0ms	
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:30.0288	[OfficeDevPnP.Core]	[0]	[Information]	File field_add.xml retrieved from folder Templates	0ms	
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:40.4354	[Provisioning]	[12]	[Debug]	Code execution scope started	0ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:40.4354	[Provisioning]	[12]	[Information]	ProgressDelegate registered	0ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:43.7323	[Term Groups]	[12]	[Debug]	Code execution scope started	0ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:45.0449	[Term Groups]	[12]	[Debug]	Code execution scope ended	1318ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:45.0449	[Fields (ListAndStandardFields)]	[12]	[Debug]	Code execution scope started	0ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:46.1230	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {23203E97-3BFE-40CB-AFB4-07AA2B86BF45} to site	1075ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:46.4371	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {B01B3DBC-4630-4ED1-B5BA-321BC7841E3D} to site	1386ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:46.6074	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {D200265D-AF80-4A8E-8595-C7B62316BEFC} to site	1557ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:46.7793	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {a0d442b9-1c9c-4ef5-8841-ffa2713b9a08} to site	1730ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:46.9512	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {F1A1715E-6C52-40DE-8403-E9AAFD0470D0} to site	1905ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:47.1387	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {91E4AC38-4AB8-4CC8-9BA9-6BC4C128603A} to site	2096ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:47.3106	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {54cb62c0-044e-4faf-ba4c-aa1b8d5053b9} to site	2266ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:47.4825	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {A5DE9600-B7A6-42DD-A05E-10D4F1500208} to site	2437ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:47.6700	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {201D924D-FA15-4E6E-86E8-1324F9FA2868} to site	2618ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:47.8419	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {D0EB025B-0334-438A-8880-F0CC654062E3} to site	2798ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:48.0450	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {117a0ff0-c113-442c-b1a1-313085c5203b} to site	2994ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:48.2325	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {ebd16147-9087-4b80-b100-028193ee3d23} to site	3181ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:48.4200	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {f8c799e3-7b90-44e4-bdd3-d27f98878c69} to site	3363ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:48.5762	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {53d1e0bf-6c4d-4ae6-bbaf-56844fabf21c} to site	3530ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:48.7481	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {8c7c395b-fef7-4a74-88a5-9154853a7be2} to site	3693ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:48.9513	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {eead3cf0-7575-4961-b354-e7d7663ccc68} to site	3900ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:49.2328	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {00ecca45-2dc2-447a-b722-633fe69a4c6f} to site	4181ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:49.4827	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {b98e43a4-7038-43a3-8471-d986011a8570} to site	4433ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:49.7013	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {39E95FAA-894F-4FED-879D-A1A6A8381149} to site	4652ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:49.8888	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {35B749BF-0FE3-48F9-A84B-C5EA05246DEB} to site	4839ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:50.4982	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {0F8532DF-F175-48B4-A0BB-648D8577D44C} to site	5451ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:50.6894	[Fields (ListAndStandardFields)]	[12]	[Debug]	Adding field {D582DFF8-CCAB-4C15-AA8E-253D5FC56AC4} to site	5642ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:51.0920	[Fields (ListAndStandardFields)]	[12]	[Debug]	Code execution scope ended	6047ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:51.0920	[Fields (LookupFields)]	[12]	[Debug]	Code execution scope started	0ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:51.9514	[Fields (LookupFields)]	[12]	[Debug]	Adding field {3a18fcce-7eab-45d7-b6b6-c61cec868057} to site	857ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:52.4514	[Fields (LookupFields)]	[12]	[Debug]	Adding field {D4F4C477-ADEE-4F19-B13C-450AE375EDC9} to site	1356ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:52.9983	[Fields (LookupFields)]	[12]	[Debug]	Adding field {ea724dbb-9222-476a-9f5a-3e09e4e62b8d} to site	1902ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:53.2015	[Fields (LookupFields)]	[12]	[Debug]	Adding field {19bac6e3-84b6-4a03-9421-a81ccdef542e} to site	2097ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:53.3733	[Fields (LookupFields)]	[12]	[Debug]	Code execution scope ended	2277ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:53.3733	[Persist Template Info]	[12]	[Debug]	Code execution scope started	0ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:53.8890	[Persist Template Info]	[12]	[Debug]	Code execution scope ended	508ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:53.8890	[Provisioning]	[12]	[Debug]	Code execution scope ended	13453ms	7084b05b-1f0f-4829-af8d-23bab86e7302
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:54.1546	[Extraction]	[12]	[Debug]	Code execution scope started	0ms	ccf96f2b-7815-4ec3-a7c4-08cfd10c9fe0
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:54.1546	[Extraction]	[12]	[Debug]	Base template available: STS0template	0ms	ccf96f2b-7815-4ec3-a7c4-08cfd10c9fe0
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:54.1546	[Extraction]	[12]	[Debug]	ProgressDelegate registered	0ms	ccf96f2b-7815-4ec3-a7c4-08cfd10c9fe0
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:54.1546	[Fields (Export)]	[12]	[Debug]	Code execution scope started	0ms	ccf96f2b-7815-4ec3-a7c4-08cfd10c9fe0
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:55.7953	[Fields (Export)]	[12]	[Debug]	Code execution scope ended	1631ms	ccf96f2b-7815-4ec3-a7c4-08cfd10c9fe0
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:55.7953	[Retrieve Template Info]	[12]	[Debug]	Code execution scope started	0ms	ccf96f2b-7815-4ec3-a7c4-08cfd10c9fe0
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:56.0609	[Retrieve Template Info]	[12]	[Debug]	Code execution scope ended	266ms	ccf96f2b-7815-4ec3-a7c4-08cfd10c9fe0
te.processhost.managed.exe Information: 0 : 2018-08-09 23:48:56.0609	[Extraction]	[12]	[Debug]	Code execution scope ended	1900ms	ccf96f2b-7815-4ec3-a7c4-08cfd10c9fe0
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:05.5925	[OfficeDevPnP.Core]	[0]	[Information]	File field_delta_1.xml retrieved from folder Templates	0ms	
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:08.4989	[Provisioning]	[12]	[Debug]	Code execution scope started	0ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:08.4989	[Provisioning]	[12]	[Information]	ProgressDelegate registered	0ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:11.5313	[Fields (ListAndStandardFields)]	[12]	[Debug]	Code execution scope started	0ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:12.2188	[Fields (ListAndStandardFields)]	[12]	[Debug]	Updating field {23203E97-3BFE-40CB-AFB4-07AA2B86BF45} in site	690ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:12.5477	[Fields (ListAndStandardFields)]	[12]	[Debug]	Updating field {B01B3DBC-4630-4ED1-B5BA-321BC7841E3D} in site	1014ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:12.8282	[Fields (ListAndStandardFields)]	[12]	[Debug]	Updating field {54cb62c0-044e-4faf-ba4c-aa1b8d5053b9} in site	1300ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:13.1564	[Fields (ListAndStandardFields)]	[12]	[Debug]	Updating field {ebd16147-9087-4b80-b100-028193ee3d23} in site	1628ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:13.4220	[Fields (ListAndStandardFields)]	[12]	[Debug]	Updating field {f8c799e3-7b90-44e4-bdd3-d27f98878c69} in site	1901ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:13.7036	[Fields (ListAndStandardFields)]	[12]	[Debug]	Updating field {00ecca45-2dc2-447a-b722-633fe69a4c6f} in site	2173ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:14.0783	[Fields (ListAndStandardFields)]	[12]	[Debug]	Updating field {b98e43a4-7038-43a3-8471-d986011a8570} in site	2554ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:14.4376	[Fields (ListAndStandardFields)]	[12]	[Debug]	Updating field {39E95FAA-894F-4FED-879D-A1A6A8381149} in site	2904ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:14.7189	[Fields (ListAndStandardFields)]	[12]	[Debug]	Updating field {35B749BF-0FE3-48F9-A84B-C5EA05246DEB} in site	3194ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:15.4701	[Fields (ListAndStandardFields)]	[12]	[Debug]	Code execution scope ended	3937ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:15.4701	[Fields (LookupFields)]	[12]	[Debug]	Code execution scope started	0ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:15.9545	[Fields (LookupFields)]	[12]	[Debug]	Updating field {3a18fcce-7eab-45d7-b6b6-c61cec868057} in site	481ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:16.2514	[Fields (LookupFields)]	[12]	[Debug]	Code execution scope ended	783ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:16.2514	[Persist Template Info]	[12]	[Debug]	Code execution scope started	0ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:16.6733	[Persist Template Info]	[12]	[Debug]	Code execution scope ended	421ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:16.6733	[Provisioning]	[12]	[Debug]	Code execution scope ended	8172ms	5c8b3daf-43a1-4dcf-bac1-0f9232eac92c
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:16.9701	[Extraction]	[12]	[Debug]	Code execution scope started	0ms	af699ffe-492d-4407-9cb7-f17447c0fff7
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:16.9701	[Extraction]	[12]	[Debug]	Base template available: STS0template	0ms	af699ffe-492d-4407-9cb7-f17447c0fff7
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:16.9701	[Extraction]	[12]	[Debug]	ProgressDelegate registered	0ms	af699ffe-492d-4407-9cb7-f17447c0fff7
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:16.9858	[Fields (Export)]	[12]	[Debug]	Code execution scope started	0ms	af699ffe-492d-4407-9cb7-f17447c0fff7
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:18.4390	[Fields (Export)]	[12]	[Debug]	Code execution scope ended	1464ms	af699ffe-492d-4407-9cb7-f17447c0fff7
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:18.4390	[Retrieve Template Info]	[12]	[Debug]	Code execution scope started	0ms	af699ffe-492d-4407-9cb7-f17447c0fff7
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:18.7202	[Retrieve Template Info]	[12]	[Debug]	Code execution scope ended	271ms	af699ffe-492d-4407-9cb7-f17447c0fff7
te.processhost.managed.exe Information: 0 : 2018-08-09 23:49:18.7202	[Extraction]	[12]	[Debug]	Code execution scope ended	1739ms	af699ffe-492d-4407-9cb7-f17447c0fff7