Test case details
Test name:
OfficeDevPnP.Core.Tests.Framework.Functional.TermGroupTests.SiteCollectionTermGroupTest
Outcome:
Run at:
4/13/2019 10:18:27 PM
Duration:
00:01:39
Error message:
Assert.IsTrue failed.
Stacktrace:
at at OfficeDevPnP.Core.Tests.Framework.Functional.Implementation.TermGroupImplementation.SiteCollectionTermGroup(String url) in c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\Implementation\TermGroupImplementation.cs:line 34 at OfficeDevPnP.Core.Tests.Framework.Functional.TermGroupTests.SiteCollectionTermGroupTest() in c:\pnpbuild\Core\OfficeDevPnP.Core.Tests\Framework\Functional\TermGroupTests.cs:line 67
Console output:
    Applying template - 1/2 - Initializing engine
Applying template - 2/2 - Term Groups
Getting template - 1/1 - Term Groups
-- Term group validation True
Applying template - 1/2 - Initializing engine
Applying template - 2/2 - Term Groups
Getting template - 1/1 - Term Groups
Source XML:<pnp:TermGroup Name="TG_2" xmlns:pnp="http://schemas.dev.office.com/PnP/2016/05/ProvisioningSchema">
  <pnp:TermSets>
    <pnp:TermSet Name="TS_2_3" ID="3668c3fc-c35f-48ab-98f2-6c88825cffcb">
      <pnp:Terms>
        <pnp:Term Name="TS_2_3_1" ID="1aa118da-b483-4b00-b046-22a1a66d7259" />
        <pnp:Term Name="TS_2_3_2" ID="73690da5-2aa1-4b93-bf96-f0173fb339ab" />
      </pnp:Terms>
    </pnp:TermSet>
    <pnp:TermSet Name="TS_2_2" ID="681cf986-4143-4bea-b242-65a219d69dc1" Description="TS_2_2 description" IsOpenForTermCreation="true">
      <pnp:CustomProperties>
        <pnp:Property Key="TS_2_2_P1" Value="TS_2_1" />
        <pnp:Property Key="TS_2_2_P2" Value="TS_2_2" />
      </pnp:CustomProperties>
      <pnp:Terms>
        <pnp:Term Name="TS_2_2_6" ID="a7228335-8975-4117-ba35-8620ee721377">
          <pnp:Terms>
            <pnp:Term Name="TS_2_2_6_1" ID="dbf832d7-61eb-4329-a08b-8cc605a2a612" CustomSortOrder="1" />
            <pnp:Term Name="TS_2_2_6_2" ID="03ef8d6d-747e-4be1-b5f2-51eb6e99d316" CustomSortOrder="2" />
            <pnp:Term Name="TS_2_2_6_3" ID="b7559375-ece9-4e78-84b0-52c01fe6f5be" CustomSortOrder="3" />
          </pnp:Terms>
        </pnp:Term>
        <pnp:Term Name="TS_2_2_7" ID="9d90abc9-659d-4d85-8597-6cb332f8dca0" IsReused="true" SourceTermId="9d90abc9-659d-4d85-8597-6cb332f8dca0">
          <pnp:Labels>
            <pnp:Label Language="1033" Value="TS_2_2_7_Label_1" />
            <pnp:Label Language="1033" Value="TS_2_2_7_Label_2" />
          </pnp:Labels>
          <pnp:CustomProperties>
            <pnp:Property Key="test_shared_1" Value="value_1" />
          </pnp:CustomProperties>
          <pnp:LocalCustomProperties>
            <pnp:Property Key="test_local_1" Value="value_1" />
            <pnp:Property Key="test_local_2" Value="value_2" />
          </pnp:LocalCustomProperties>
        </pnp:Term>
        <pnp:Term Name="TS_2_2_8" ID="c4a1ec3e-2da4-4d90-990c-12ea9842f77e" IsDeprecated="true" />
      </pnp:Terms>
    </pnp:TermSet>
    <pnp:TermSet Name="TS_2_4" ID="b279d248-73a6-42ad-9af4-a6d5a19db750">
      <pnp:Terms>
        <pnp:Term Name="TS_2_2_7" IsReused="true" IsSourceTerm="false" SourceTermId="9d90abc9-659d-4d85-8597-6cb332f8dca0">
          <pnp:LocalCustomProperties>
            <pnp:Property Key="test_local_3" Value="value_3" />
            <pnp:Property Key="test_local_4" Value="value_4" />
          </pnp:LocalCustomProperties>
        </pnp:Term>
      </pnp:Terms>
    </pnp:TermSet>
  </pnp:TermSets>
  <pnp:Contributors />
  <pnp:Managers />
</pnp:TermGroup>
Target XML:<pnp:TermGroup Name="TG_2" xmlns:pnp="http://schemas.dev.office.com/PnP/2016/05/ProvisioningSchema">
  <pnp:TermSets>
    <pnp:TermSet Name="TS_2_2" ID="681cf986-4143-4bea-b242-65a219d69dc1" Description="TS_2_2 description" IsOpenForTermCreation="true">
      <pnp:CustomProperties>
        <pnp:Property Key="TS_2_2_P1" Value="TS_2_1" />
        <pnp:Property Key="TS_2_2_P2" Value="TS_2_2" />
      </pnp:CustomProperties>
      <pnp:Terms>
        <pnp:Term Name="TS_2_2_6" ID="a7228335-8975-4117-ba35-8620ee721377">
          <pnp:Terms>
            <pnp:Term Name="TS_2_2_6_1" ID="dbf832d7-61eb-4329-a08b-8cc605a2a612" CustomSortOrder="1" />
            <pnp:Term Name="TS_2_2_6_2" ID="03ef8d6d-747e-4be1-b5f2-51eb6e99d316" CustomSortOrder="2" />
            <pnp:Term Name="TS_2_2_6_3" ID="b7559375-ece9-4e78-84b0-52c01fe6f5be" CustomSortOrder="3" />
          </pnp:Terms>
        </pnp:Term>
        <pnp:Term Name="TS_2_2_7" ID="9d90abc9-659d-4d85-8597-6cb332f8dca0" SourceTermId="9d90abc9-659d-4d85-8597-6cb332f8dca0">
          <pnp:Labels>
            <pnp:Label Language="1033" Value="TS_2_2_7_Label_1" />
            <pnp:Label Language="1033" Value="TS_2_2_7_Label_2" />
          </pnp:Labels>
          <pnp:CustomProperties>
            <pnp:Property Key="test_shared_1" Value="value_1" />
          </pnp:CustomProperties>
          <pnp:LocalCustomProperties>
            <pnp:Property Key="test_local_1" Value="value_1" />
            <pnp:Property Key="test_local_2" Value="value_2" />
          </pnp:LocalCustomProperties>
        </pnp:Term>
        <pnp:Term Name="TS_2_2_8" ID="c4a1ec3e-2da4-4d90-990c-12ea9842f77e" IsDeprecated="true" />
      </pnp:Terms>
    </pnp:TermSet>
    <pnp:TermSet Name="TS_2_3" ID="3668c3fc-c35f-48ab-98f2-6c88825cffcb">
      <pnp:Terms>
        <pnp:Term Name="TS_2_3_1" ID="1aa118da-b483-4b00-b046-22a1a66d7259" />
        <pnp:Term Name="TS_2_3_2" ID="73690da5-2aa1-4b93-bf96-f0173fb339ab" />
      </pnp:Terms>
    </pnp:TermSet>
    <pnp:TermSet Name="TS_2_4" ID="b279d248-73a6-42ad-9af4-a6d5a19db750" />
  </pnp:TermSets>
  <pnp:Contributors />
  <pnp:Managers />
</pnp:TermGroup>
-- Term group validation False



Debug Trace:
vstest.console.exe Information: 0 : 2019-04-13 22:18:28.6740	[SetSiteLockState: Current: {0} Target: {1}]	[0]	[Information]	Unlock	0ms	
vstest.console.exe Information: 0 : 2019-04-13 22:21:12.4844	[OfficeDevPnP.Core]	[0]	[Information]	Creating web 'sub' with template ''.	0ms	
vstest.console.exe Information: 0 : 2019-04-13 22:21:33.2708	[OfficeDevPnP.Core]	[0]	[Information]	File termgroup_add.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-04-13 22:21:36.8544	[Provisioning]	[16]	[Debug]	Code execution scope started	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:36.8544	[Provisioning]	[16]	[Information]	ProgressDelegate registered	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:39.6523	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:39.6523	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:39.6523	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:39.6523	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:39.6523	[Term Groups]	[16]	[Debug]	Code execution scope started	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.1819	[Term Groups]	[16]	[Debug]	Code execution scope ended	10528ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.1819	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.1819	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.1819	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.1819	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.1819	[Persist Template Info]	[16]	[Debug]	Code execution scope started	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6193	[Persist Template Info]	[16]	[Debug]	Code execution scope ended	438ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6193	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6193	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6819	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6819	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6819	[Provisioning]	[16]	[Debug]	Code execution scope ended	13820ms	e98b4c8f-9f3b-420a-9086-47cb7aa1feb5
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6819	[Extraction]	[16]	[Debug]	Code execution scope started	0ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6819	[Extraction]	[16]	[Debug]	Base template available: STS0template	0ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6819	[Extraction]	[16]	[Debug]	ProgressDelegate registered	0ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6819	[Extraction]	[16]	[Debug]	IncludeAllTermGroups is set to true	0ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6819	[Extraction]	[16]	[Debug]	IncludeSiteCollectionTermGroup is set to true	1ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:21:50.6819	[Term Groups]	[16]	[Debug]	Code execution scope started	0ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:22:12.1037	[Term Groups]	[16]	[Debug]	Code execution scope ended	21425ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:22:12.1037	[Retrieve Template Info]	[16]	[Debug]	Code execution scope started	0ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:22:12.3693	[Retrieve Template Info]	[16]	[Debug]	Code execution scope ended	252ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:22:12.3693	[Extraction]	[16]	[Debug]	Code execution scope ended	21681ms	15604098-e074-4c09-956d-bc90a060c25a
vstest.console.exe Information: 0 : 2019-04-13 22:22:19.5273	[OfficeDevPnP.Core]	[0]	[Information]	File termgroup_delta_1605.xml retrieved from folder Templates	0ms	
vstest.console.exe Information: 0 : 2019-04-13 22:22:22.6297	[Provisioning]	[16]	[Debug]	Code execution scope started	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:22.6297	[Provisioning]	[16]	[Information]	ProgressDelegate registered	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:25.5623	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:25.5623	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:25.5623	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:25.5623	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:25.5623	[Term Groups]	[16]	[Debug]	Code execution scope started	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.4486	[Term Groups]	[16]	[Debug]	Code execution scope ended	7895ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.4486	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.4486	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.4486	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.4486	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.4486	[Persist Template Info]	[16]	[Debug]	Code execution scope started	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9397	[Persist Template Info]	[16]	[Debug]	Code execution scope ended	491ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9397	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9397	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9553	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope started	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9553	[ProvisioningTemplate WebHook Call]	[16]	[Debug]	Code execution scope ended	0ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9553	[Provisioning]	[16]	[Debug]	Code execution scope ended	11317ms	dd2f00e1-150e-496f-a52d-ded39eff84f3
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9553	[Extraction]	[16]	[Debug]	Code execution scope started	0ms	4ccb8cae-25e5-435c-bddc-3341ae789e83
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9553	[Extraction]	[16]	[Debug]	Base template available: STS0template	0ms	4ccb8cae-25e5-435c-bddc-3341ae789e83
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9553	[Extraction]	[16]	[Debug]	ProgressDelegate registered	0ms	4ccb8cae-25e5-435c-bddc-3341ae789e83
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9553	[Extraction]	[16]	[Debug]	IncludeAllTermGroups is set to true	0ms	4ccb8cae-25e5-435c-bddc-3341ae789e83
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9553	[Extraction]	[16]	[Debug]	IncludeSiteCollectionTermGroup is set to true	0ms	4ccb8cae-25e5-435c-bddc-3341ae789e83
vstest.console.exe Information: 0 : 2019-04-13 22:22:33.9553	[Term Groups]	[16]	[Debug]	Code execution scope started	0ms	4ccb8cae-25e5-435c-bddc-3341ae789e83
vstest.console.exe Information: 0 : 2019-04-13 22:22:50.4275	[Term Groups]	[16]	[Debug]	Code execution scope ended	16479ms	4ccb8cae-25e5-435c-bddc-3341ae789e83
vstest.console.exe Information: 0 : 2019-04-13 22:22:50.4275	[Retrieve Template Info]	[16]	[Debug]	Code execution scope started	0ms	4ccb8cae-25e5-435c-bddc-3341ae789e83
vstest.console.exe Information: 0 : 2019-04-13 22:22:50.7400	[Retrieve Template Info]	[16]	[Debug]	Code execution scope ended	303ms	4ccb8cae-25e5-435c-bddc-3341ae789e83
vstest.console.exe Information: 0 : 2019-04-13 22:22:50.7400	[Extraction]	[16]	[Debug]	Code execution scope ended	16785ms	4ccb8cae-25e5-435c-bddc-3341ae789e83