No Code Coverage results when running coverage in build environment

We are attempting to incorporate code coverage into our build process. We currently use TFS 2010 and test with Visual Studio 2012 against the projects. During the build process, we deploy our product into a deployment environment, mimicking a client install. This means that the compiled DLL’s are all deployed into specific folders. Then to run our remote unit tests, we also deploy the unit test DLL’s to the same folders. Our build script then runs MSTest remotely through a bat file against those test containers (unit test dll’s). We get unit test results just fine doing this method.

Now that we are incorporating code coverage, we are running into an issue when running the command-line console runner for code coverage. Using the Analyse command in an xml file in our deployed environment returns no results. The HTML file is created, but only the root node is displayed. (DotCover runs the unit tests and those results are fine, but doesn’t show any coverage results.) However, when running dotCover on a local developer machine the same way (but obviously pointed to bin\debug folders), it runs fine and returns results for both unit tests and code coverage.
We have tried adding PDB files to our deployed environment and still no code coverage results. Can you help us? Thanks!

3 comments

Hi Sara,

Thank you for contacting us and sorry for the delayed answer.
We need dotCover log file for the case of your deployed environment to investigate this problem. To enable it please add following command line parameters: /LogFile=path_to_the_log_file /CoreLogMask=PdbBridge

0

Sorry for the delay. Again, this works fine on my dev enviroment - I get html coverage results as expected. But when I run this on the deployed machine, an html file is generated, but there are no results.

Here is the log file:

9:52:48 AM.339: Thread:1: JetBrains dotCover Console Runner v2.5.574.60. Copyright (c) 2009–2013 JetBrains s.r.o. All rights reserved.

9:52:48 AM.378: Thread:1: Parsing arguments for 'analyse' command...
9:52:48 AM.445: Thread:1: Parsed parameters:
<AnalyseParams xmlns:i="http://www.w3.org/2001/XMLSchema-instance"><AnalyseTargetArguments i:type="ParameterValueOfboolean"><Origin>default</Origin><Value>true</Value></AnalyseTargetArguments><AttributeFilters i:type="ParameterValueOfAttributeFiltersNcCATIYq"><Origin>default</Origin><Value i:nil="true"/></AttributeFilters><CoreInstructionSet i:type="ParameterValueOfstring"><Origin>default</Origin><Value i:nil="true"/></CoreInstructionSet><CoreLogMask i:type="ParameterValueOfstring"><Origin>default</Origin><Value i:nil="true"/></CoreLogMask><Filters i:type="ParameterValueOfCoverageFiltersNcCATIYq"><Origin>xml</Origin><Value><ExcludeFilters i:nil="true"/><IncludeFilters><FilterEntry><ClassMask>*</ClassMask><FunctionMask>*</FunctionMask><ModuleMask>BCT*</ModuleMask></FilterEntry></IncludeFilters></Value></Filters><IncludeEnvironmentSpecificInfo i:type="ParameterValueOfboolean"><Origin>default</Origin><Value>true</Value></IncludeEnvironmentSpecificInfo><InheritConsole i:type="ParameterValueOfboolean"><Origin>default</Origin><Value>true</Value></InheritConsole><Output i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>D:\TestResults\dotCoverOutput3.html</Value></Output><ReportType i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>HTML</Value></ReportType><SymbolSearchPath i:type="ParameterValueOfstring"><Origin>default</Origin><Value i:nil="true"/></SymbolSearchPath><TargetArguments i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>/testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll</Value></TargetArguments><TargetExecutable i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe</Value></TargetExecutable><TargetWorkingDir i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service</Value></TargetWorkingDir><TempDir i:type="ParameterValueOfstring"><Origin>xml</Origin><Value/></TempDir></AnalyseParams>                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                              
9:52:48 AM.453: Thread:1: Parameters after relative to absolute path conversion:
<AnalyseParams xmlns:i="http://www.w3.org/2001/XMLSchema-instance"><AnalyseTargetArguments i:type="ParameterValueOfboolean"><Origin>default</Origin><Value>true</Value></AnalyseTargetArguments><AttributeFilters i:type="ParameterValueOfAttributeFiltersNcCATIYq"><Origin>default</Origin><Value i:nil="true"/></AttributeFilters><CoreInstructionSet i:type="ParameterValueOfstring"><Origin>default</Origin><Value i:nil="true"/></CoreInstructionSet><CoreLogMask i:type="ParameterValueOfstring"><Origin>default</Origin><Value i:nil="true"/></CoreLogMask><Filters i:type="ParameterValueOfCoverageFiltersNcCATIYq"><Origin>xml</Origin><Value><ExcludeFilters i:nil="true"/><IncludeFilters><FilterEntry><ClassMask>*</ClassMask><FunctionMask>*</FunctionMask><ModuleMask>BCT*</ModuleMask></FilterEntry></IncludeFilters></Value></Filters><IncludeEnvironmentSpecificInfo i:type="ParameterValueOfboolean"><Origin>default</Origin><Value>true</Value></IncludeEnvironmentSpecificInfo><InheritConsole i:type="ParameterValueOfboolean"><Origin>default</Origin><Value>true</Value></InheritConsole><Output i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>D:\TestResults\dotCoverOutput3.html</Value></Output><ReportType i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>HTML</Value></ReportType><SymbolSearchPath i:type="ParameterValueOfstring"><Origin>default</Origin><Value i:nil="true"/></SymbolSearchPath><TargetArguments i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>/testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll</Value></TargetArguments><TargetExecutable i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe</Value></TargetExecutable><TargetWorkingDir i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service</Value></TargetWorkingDir><TempDir i:type="ParameterValueOfstring"><Origin>xml</Origin><Value/></TempDir></AnalyseParams>                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                                      
9:52:48 AM.461: Thread:1: Parsing arguments for 'cover' command...
9:52:48 AM.497: Thread:1: Parsed parameters:
<CoverageParams xmlns:i="http://www.w3.org/2001/XMLSchema-instance"><AnalyseTargetArguments i:type="ParameterValueOfboolean"><Origin>xml</Origin><Value>true</Value></AnalyseTargetArguments><AttributeFilters i:type="ParameterValueOfAttributeFiltersNcCATIYq"><Origin>default</Origin><Value i:nil="true"/></AttributeFilters><CoreInstructionSet i:type="ParameterValueOfstring"><Origin>xml</Origin><Value i:nil="true"/></CoreInstructionSet><CoreLogMask i:type="ParameterValueOfstring"><Origin>cmd</Origin><Value>PdbBridge</Value></CoreLogMask><Filters i:type="ParameterValueOfCoverageFiltersNcCATIYq"><Origin>+:BCT*</Origin><Value><ExcludeFilters/><IncludeFilters><FilterEntry><ClassMask>*</ClassMask><FunctionMask>*</FunctionMask><ModuleMask>BCT*</ModuleMask></FilterEntry></IncludeFilters></Value></Filters><InheritConsole i:type="ParameterValueOfboolean"><Origin>xml</Origin><Value>true</Value></InheritConsole><Output i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>C:\Users\Administrator\AppData\Local\Temp\1\tmpB6C3.tmp</Value></Output><SymbolSearchPath i:type="ParameterValueOfstring"><Origin>xml</Origin><Value i:nil="true"/></SymbolSearchPath><TargetArguments i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>/testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll</Value></TargetArguments><TargetExecutable i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe</Value></TargetExecutable><TargetWorkingDir i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service</Value></TargetWorkingDir><TempDir i:type="ParameterValueOfstring"><Origin>xml</Origin><Value/></TempDir></CoverageParams>                                                                          
9:52:48 AM.498: Thread:1: Parameters after relative to absolute path conversion:
<CoverageParams xmlns:i="http://www.w3.org/2001/XMLSchema-instance"><AnalyseTargetArguments i:type="ParameterValueOfboolean"><Origin>xml</Origin><Value>true</Value></AnalyseTargetArguments><AttributeFilters i:type="ParameterValueOfAttributeFiltersNcCATIYq"><Origin>default</Origin><Value i:nil="true"/></AttributeFilters><CoreInstructionSet i:type="ParameterValueOfstring"><Origin>xml</Origin><Value i:nil="true"/></CoreInstructionSet><CoreLogMask i:type="ParameterValueOfstring"><Origin>cmd</Origin><Value>PdbBridge</Value></CoreLogMask><Filters i:type="ParameterValueOfCoverageFiltersNcCATIYq"><Origin>+:BCT*</Origin><Value><ExcludeFilters/><IncludeFilters><FilterEntry><ClassMask>*</ClassMask><FunctionMask>*</FunctionMask><ModuleMask>BCT*</ModuleMask></FilterEntry></IncludeFilters></Value></Filters><InheritConsole i:type="ParameterValueOfboolean"><Origin>xml</Origin><Value>true</Value></InheritConsole><Output i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>C:\Users\Administrator\AppData\Local\Temp\1\tmpB6C3.tmp</Value></Output><SymbolSearchPath i:type="ParameterValueOfstring"><Origin>xml</Origin><Value i:nil="true"/></SymbolSearchPath><TargetArguments i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>/testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll</Value></TargetArguments><TargetExecutable i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe</Value></TargetExecutable><TargetWorkingDir i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service</Value></TargetWorkingDir><TempDir i:type="ParameterValueOfstring"><Origin>xml</Origin><Value/></TempDir></CoverageParams>                                                                  
9:52:48 AM.535: Thread:1: [JetDispatcher] Thread <NULL>:1 created an Avalon marshaller.
9:52:48 AM.535: Thread:1: [JetDispatcher] Thread <NULL>:1 pwned.
9:52:48 AM.653: Thread:1: [JetEnvironment] IApplicationDescriptor::JetEnvironment::Products++ 0^1: JetBrains.dotCover.ShellBase.DotCoverApplicationDescriptorLite.
9:52:50 AM.567: Thread:1: [ReportsProductsAllowedToRun] IProductCanBeStarted::JetEnvironment::IProductCanBeStarted[]++ ^: JetBrains.Application.Env.Components.SuspendResumeProductCanBeStarted (ACK).
9:52:50 AM.568: Thread:1: [ReportsProductsAllowedToRun] IProductCanBeStarted::JetEnvironment::IProductCanBeStarted[]++ ^: JetBrains.UI.License.UITimeBombComponent (ACK).
9:52:50 AM.568: Thread:1: [ReportsProductsAllowedToRun] IProductCanBeStarted::JetEnvironment::IProductCanBeStarted[]++ ^: JetBrains.dotCover.Infrastructure.Environment.Model.LiberalLicenseCheckComponent (ACK).
9:52:50 AM.656: Thread:1: [RunsProducts] IApplicationDescriptor::RunsProducts::ProductsToRun++ 0^1: JetBrains.dotCover.ShellBase.DotCoverApplicationDescriptorLite.
9:52:50 AM.709: Thread:1: [RunningProducts] KeyValuePair`2::RunsProducts::ProductContainersNonComposed++ 0^1: “[JetBrains.dotCover.ShellBase.DotCoverApplicationDescriptorLite, 'Product(dotCover)' (JetBrains.Application.Components.CatalogueComponentContainer`1[JetBrains.Application.ShellComponentAttribute])]”.
9:52:50 AM.890: Thread:3: [JetDispatcher] Thread FileSystemTrackerCommit:3 created an Avalon marshaller.
9:52:50 AM.890: Thread:3: [JetDispatcher] Thread FileSystemTrackerCommit:3 pwned.
9:52:50 AM.996: Thread:1: [FST] TryInitFileSystemWatcher - ok
9:52:51 AM.193: Thread:1: [FST] TryInitFileSystemWatcher - ok
9:52:51 AM.289: Thread:5: [JetDispatcher] Thread SettingsChangeDispatch:5 created an Avalon marshaller.
9:52:51 AM.289: Thread:5: [JetDispatcher] Thread SettingsChangeDispatch:5 pwned.
9:52:52 AM.363: Thread:1: dotCover 2.5 Version=2.5.574.60, Built=2013-09-05T06:55:00, Configuration=“ConsoleRunnerApplication Full PublicMode”
9:52:52 AM.586: Thread:1: [MW] OnWmActivate Attached.
9:52:52 AM.771: Thread:1: Unused action handlers for action 'ShowThemedIconsToolWindow'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'Expand'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'Collapse'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'CopyLayerToLayer'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'FocusMonitor'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'SettingsLayersDialogToolbar.AddLayer'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'SettingsLayersDialogToolbar.ImportFrom'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'DumpToolWindowState'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'TestUpdatesXslt'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'WindowManager.ActivateRecentTool'
9:52:52 AM.771: Thread:1: Unused action handlers for action 'WindowManager.CloseRecentTool'
9:52:52 AM.820: Thread:1: [UserActivityMonitor] Boolean::HavePendingSwitch: <N/A> -> False.
9:52:52 AM.834: Thread:1: [UserActivityMonitor] Boolean::(HavePendingSwitch,IsApplicationActive).And: <N/A> -> False.
9:52:52 AM.834: Thread:1: [UserActivityMonitor] Boolean::HaveSwitchAndActiveDeferred: <N/A> -> False.
9:52:53 AM.302: Thread:1: [FST] TryInitFileSystemWatcher - ok
9:52:53 AM.441: Thread:1: [RunningProducts] KeyValuePair`2::RunsProducts::ProductContainersComposed++ 0^1: “[JetBrains.dotCover.ShellBase.DotCoverApplicationDescriptorLite, 'Product(dotCover)' (JetBrains.Application.Components.CatalogueComponentContainer`1[JetBrains.Application.ShellComponentAttribute])]”.
9:52:53 AM.519: Thread:1: Resulting coverage configuration:
<HostParameters type="LocalHostParameters" /><Argument type="StandaloneArgument"><Arguments>/testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll</Arguments><FileName>D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe</FileName><ProfileChildProcesses>True</ProfileChildProcesses><WorkingDirectory>C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service</WorkingDirectory></Argument><Info type="CoverageInfo"><CyclomaticComplexityGather>True</CyclomaticComplexityGather><InjectInfo><SearchPaths /><Scope><PatternFilters><Item><AssemblyFilter>BCT*</AssemblyFilter></Item><Item><AssemblyFilter>mscorlib</AssemblyFilter><Type>Deny</Type></Item><Item><AssemblyFilter>System</AssemblyFilter><Type>Deny</Type></Item><Item><AssemblyFilter>System.*</AssemblyFilter><Type>Deny</Type></Item><Item><AssemblyFilter>Microsoft.*</AssemblyFilter><Type>Deny</Type></Item></PatternFilters><DenyAttributeFilters /></Scope></InjectInfo></Info><CoreOptions><CoreLogMask>PdbBridge</CoreLogMask><CoreRegistrationRegistryFreeInstructionSet IsNull="False"></CoreRegistrationRegistryFreeInstructionSet><CoreTempPath IsNull="False"></CoreTempPath></CoreOptions><HostOptions><HostTempPath IsNull="False"></HostTempPath><UserData /></HostOptions>
9:52:53 AM.519: Thread:1: Parsing arguments for 'report' command...
9:52:53 AM.527: Thread:1: Parsed parameters:
<ReportParams xmlns:i="http://www.w3.org/2001/XMLSchema-instance"><IncludeEnvironmentSpecificInfo i:type="ParameterValueOfboolean"><Origin>xml</Origin><Value>true</Value></IncludeEnvironmentSpecificInfo><Output i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>D:\TestResults\dotCoverOutput3.html</Value></Output><ReportType i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>HTML</Value></ReportType><Source i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>C:\Users\Administrator\AppData\Local\Temp\1\tmpB6C3.tmp</Value></Source></ReportParams>                                                                                                                                                                                                                                                                                                                                                                                                              
9:52:53 AM.528: Thread:1: Parameters after relative to absolute path conversion:
<ReportParams xmlns:i="http://www.w3.org/2001/XMLSchema-instance"><IncludeEnvironmentSpecificInfo i:type="ParameterValueOfboolean"><Origin>xml</Origin><Value>true</Value></IncludeEnvironmentSpecificInfo><Output i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>D:\TestResults\dotCoverOutput3.html</Value></Output><ReportType i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>HTML</Value></ReportType><Source i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>C:\Users\Administrator\AppData\Local\Temp\1\tmpB6C3.tmp</Value></Source></ReportParams>                                                                                                                                                                                                                                                                                                                                                                                                                  
9:52:53 AM.530: Thread:1: Parsing arguments for 'delete' command...
9:52:53 AM.540: Thread:1: Parsed parameters:
<DeleteParams xmlns:i="http://www.w3.org/2001/XMLSchema-instance"><Source xmlns:a="http://schemas.microsoft.com/2003/10/Serialization/Arrays"><a:anyType i:type="ParameterValueOfstring"><Origin>xml</Origin><Value>C:\Users\Administrator\AppData\Local\Temp\1\tmpB6C3.tmp</Value></a:anyType></Source></DeleteParams>
9:52:53 AM.541: Thread:1: Parameters after relative to absolute path conversion:
<DeleteParams xmlns:i="http://www.w3.org/2001/XMLSchema-instance"><Source xmlns:a="http://schemas.microsoft.com/2003/10/Serialization/Arrays"><a:anyType i:type="ParameterValueOfstring"><Origin>descr</Origin><Value>C:\Users\Administrator\AppData\Local\Temp\1\tmpB6C3.tmp</Value></a:anyType></Source></DeleteParams>
9:52:53 AM.570: Thread:1: Coverage session started [10/11/2013 9:52:53 AM]
9:52:53 AM.575: Thread:1: [CoverageSession#0] Queueing start command
9:52:53 AM.578: Thread:1: [CoverageSession#0] Queueing add configuration command (configuration id: '')
9:52:53 AM.579: Thread:1: [CoverageSession#0] Waiting for the session to finish (Timeout=-1)
9:52:53 AM.580: Thread:11: [CoverageSession#0] Starting coverage session
9:52:53 AM.580: Thread:11: [CoverageSession#0] Expected configuration ids: ''
9:52:53 AM.585: Thread:11: [CoverageSession#0] Adding configuration (configuration id: '')
9:52:53 AM.585: Thread:11: [CoverageSession#0] Queueing configuration execution (configuration id: '')
9:52:53 AM.591: Thread:12: [CoverageSession#0] Executing configuration (configuration id: '')
9:52:53 AM.591: Thread:12: [CoverageSession#0] Preparing launcher controller (configuration id: '')
9:52:53 AM.597: Thread:12: [LauncherController] List prevent connecting executables for global mode:
'JetBrains.dotCover.WorkspaceHost.exe'
9:52:53 AM.603: Thread:12: [LauncherController] Configuration:
<?xml version="1.0" encoding="utf-8"?>
<Configuration>
  <HostParameters type="LocalHostParameters" />
  <Argument type="StandaloneArgument">
   <Arguments>/testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll</Arguments>
   <FileName>D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe</FileName>
   <ProfileChildProcesses>True</ProfileChildProcesses>
   <WorkingDirectory>C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service</WorkingDirectory>
  </Argument>
  <Info type="CoverageInfo">
   <CyclomaticComplexityGather>True</CyclomaticComplexityGather>
   <InjectInfo>
    <SearchPaths />
    <Scope>
     <PatternFilters>
      <Item>
       <AssemblyFilter>BCT*</AssemblyFilter>
      </Item>
      <Item>
       <AssemblyFilter>mscorlib</AssemblyFilter>
       <Type>Deny</Type>
      </Item>
      <Item>
       <AssemblyFilter>System</AssemblyFilter>
       <Type>Deny</Type>
      </Item>
      <Item>
       <AssemblyFilter>System.*</AssemblyFilter>
       <Type>Deny</Type>
      </Item>
      <Item>
       <AssemblyFilter>Microsoft.*</AssemblyFilter>
       <Type>Deny</Type>
      </Item>
     </PatternFilters>
     <DenyAttributeFilters />
    </Scope>
   </InjectInfo>
  </Info>
  <CoreOptions>
   <CoreLogMask>PdbBridge</CoreLogMask>
   <CoreRegistrationRegistryFreeInstructionSet IsNull="False">
   </CoreRegistrationRegistryFreeInstructionSet>
   <CoreTempPath IsNull="False">
   </CoreTempPath>
  </CoreOptions>
  <HostOptions>
   <HostTempPath IsNull="False">
   </HostTempPath>
   <UserData />
  </HostOptions>
</Configuration>
9:52:53 AM.605: Thread:12: [CoverageSession#0] Launching coverage analysis (configuration id: '')
9:52:53 AM.605: Thread:11: [CoverageSession#0] Ready to execute 'start' callback (configuration id: '')
9:52:53 AM.644: Thread:12: Local SysTools v2.5.574.60 loaded
9:52:53 AM.700: Thread:12: [TransparentIntegration] name='CoverageProfiler' res=no
9:52:53 AM.734: Thread:12: [Core] profilerActivationFlags='pm'
instructionSet=x64
instructionSet=x86
9:52:53 AM.754: Thread:12: Starting process 'C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.CorePdbServer.x64.exe' /l {9cc919f6-bcde-4fd6-9c69-a8560ed37c43}
9:52:53 AM.758: Thread:12: [PdbServer] Started pid=4848 id='{9cc919f6-bcde-4fd6-9c69-a8560ed37c43}'
9:52:53 AM.872: Thread:12: [PdbServer] Listen pid=4848
9:52:53 AM.872: Thread:12: [Core] registryFreeRegistration=False checkMetroAccessRights=False
9:52:53 AM.891: Thread:12: [RegisterCore] op=Install instructionSet=x64 path='C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x64.dll'
9:52:53 AM.892: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceSampling={4a7c006c-be98-4f36-9e83-a9536c4f3148}
9:52:53 AM.892: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceTracing={78d7003b-d2ee-4c74-991a-d4fa8626ebfc}
9:52:53 AM.892: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceTracingInject={7122880f-d2b9-4e76-8234-530174452844}
9:52:53 AM.892: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestPerformanceSampling={6d257aaa-b619-459f-b5d7-98ff3b473968}
9:52:53 AM.892: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestPerformance={8be60fd2-1a80-4cbf-9633-973ef542de11}
9:52:53 AM.892: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseMemory={07f7318e-2939-46b4-9c76-9998a078110e}
9:52:53 AM.892: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestMemory={ac7b786b-2d9f-4937-8984-cacdeba078fe}
9:52:53 AM.892: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseCoverage={762a40a9-7a75-4662-96fa-4dc67a8f77c4}
9:52:53 AM.892: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestCoverage={84173644-4aee-4ffc-83fc-141dbc5510ce}
9:52:53 AM.906: Thread:12: Starting console app: "C:\Windows\system32\RegSvr32.exe" /s "C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x64.dll"
9:52:53 AM.949: Thread:12: Console app exited with code [0]: "C:\Windows\system32\RegSvr32.exe" /s "C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x64.dll"
9:52:53 AM.961: Thread:12: [RegisterCore] op=Install instructionSet=x86 path='C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x86.dll'
9:52:53 AM.961: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceSampling={4a7c006c-be98-4f36-9e83-a9536c4f3148}
9:52:53 AM.961: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceTracing={78d7003b-d2ee-4c74-991a-d4fa8626ebfc}
9:52:53 AM.961: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceTracingInject={7122880f-d2b9-4e76-8234-530174452844}
9:52:53 AM.961: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestPerformanceSampling={6d257aaa-b619-459f-b5d7-98ff3b473968}
9:52:53 AM.961: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestPerformance={8be60fd2-1a80-4cbf-9633-973ef542de11}
9:52:53 AM.961: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseMemory={07f7318e-2939-46b4-9c76-9998a078110e}
9:52:53 AM.961: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestMemory={ac7b786b-2d9f-4937-8984-cacdeba078fe}
9:52:53 AM.961: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseCoverage={762a40a9-7a75-4662-96fa-4dc67a8f77c4}
9:52:53 AM.961: Thread:12: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestCoverage={84173644-4aee-4ffc-83fc-141dbc5510ce}
9:52:53 AM.961: Thread:12: Starting console app: "C:\Windows\SysWOW64\RegSvr32.exe" /s "C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x86.dll"
9:52:54 AM.020: Thread:12: Console app exited with code [0]: "C:\Windows\SysWOW64\RegSvr32.exe" /s "C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x86.dll"
9:52:54 AM.035: Thread:15: Create new listener cc6690ff-e365-4163-8894-c4e09ed07878 on port 52171
9:52:54 AM.163: Thread:12: [SessionController.Finished] Boolean::SessionController.Finished: <N/A> -> False.
9:52:54 AM.163: Thread:12: [SessionController.Terminated] Boolean::SessionController.Terminated: <N/A> -> False.
9:52:54 AM.165: Thread:12: [SessionController.Connected] Boolean::SessionController.WasConnection: <N/A> -> False.
9:52:54 AM.165: Thread:12: [SessionController.EmptyConnections] Boolean::SessionController.BridgeControllers::IsEmpty: <N/A> -> True.
9:52:54 AM.165: Thread:12: [SessionController.CoreEmptyOperations] Boolean::SessionController.CoreOperations::IsEmpty: <N/A> -> True.
9:52:54 AM.165: Thread:12: [SessionController.DownloadEmptyOperations] Boolean::SessionController.DownloadOperations::IsEmpty: <N/A> -> True.
9:52:54 AM.165: Thread:12: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: <N/A> -> True.
9:52:54 AM.165: Thread:12: [SessionController.NoConnectionsAndOperations] Boolean::(SessionController.BridgeControllers::IsEmpty,(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And).And: <N/A> -> True.
9:52:54 AM.165: Thread:12: [SessionController.TerminatedAndNoConnectionsAndOperations] Boolean::(SessionController.Terminated,(SessionController.BridgeControllers::IsEmpty,(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And).And).And: <N/A> -> False.
9:52:54 AM.165: Thread:12: [SessionController.DelayedNoConnectionsAndOperations] Boolean::SessionController.DelayedNoConnectionsAndOperations: <N/A> -> False.
9:52:54 AM.165: Thread:12: [SessionController.ConnectedAndDelayedNoConnectionsAndOperations] Boolean::(SessionController.WasConnection,SessionController.DelayedNoConnectionsAndOperations).And: <N/A> -> False.
9:52:54 AM.167: Thread:12: [SessionController.FinishedRequest] Boolean::((SessionController.Terminated,(SessionController.BridgeControllers::IsEmpty,(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And).And).And,(SessionController.WasConnection,SessionController.DelayedNoConnectionsAndOperations).And).Or: <N/A> -> False.
9:52:54 AM.171: Thread:12: Starting process 'D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe' /testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll
9:52:54 AM.172: Thread:12: [CoverageSession#0] Waiting for the analysis to finish (configuration id: '')
9:52:54 AM.173: Thread:11: [CoverageSession#0] Executing 'start' callback (configuration id: '')
9:52:54 AM.187: Thread:4: Incoming connection on port 52171
9:52:54 AM.240: Thread:15: Popped 1 new streams
9:52:54 AM.303: Thread:18: [SessionController.EmptyConnections] Boolean::SessionController.BridgeControllers::IsEmpty: True -> False.
9:52:54 AM.303: Thread:18: [SessionController.NoConnectionsAndOperations] Boolean::(SessionController.BridgeControllers::IsEmpty,(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And).And: True -> False.
9:52:54 AM.304: Thread:18: [SessionController.Connected] Boolean::SessionController.WasConnection: False -> True.
9:52:56 AM.314: Thread:4: Incoming connection on port 52171
9:52:56 AM.357: Thread:15: Popped 1 new streams
9:53:00 AM.002: Thread:19: [CommandProcessor] OperationFinished coreOperation=SnapShotSaving
9:53:00 AM.003: Thread:19: [SessionController.CoreEmptyOperations] Boolean::SessionController.CoreOperations::IsEmpty: True -> False.
9:53:00 AM.003: Thread:19: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: True -> False.
9:53:00 AM.105: Thread:19: [CommandProcessor] OperationFinished
9:53:00 AM.108: Thread:19: [SessionController.CoreEmptyOperations] Boolean::SessionController.CoreOperations::IsEmpty: False -> True.
9:53:00 AM.108: Thread:19: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: False -> True.
9:53:00 AM.112: Thread:19: [Downloader] ProcessIndexFile process={6a54868b-fbc5-4a78-b5bf-755f15b5ac88}:0 instance=1:0 sequence={99041fdc-33f2-43dc-94d4-6ded65c80787}:0 snapshot={f718e270-c788-451c-ad17-ecbead019dc4} localIndexFile='C:\Users\Administrator\AppData\Local\Temp\1\ssc05D86.tmp'
9:53:00 AM.112: Thread:19: [Downloader] ProcessIndexFile id=1 process={6a54868b-fbc5-4a78-b5bf-755f15b5ac88}:0 instance=1:0 sequence={99041fdc-33f2-43dc-94d4-6ded65c80787}:0 snapshot={f718e270-c788-451c-ad17-ecbead019dc4} localIndexFile='C:\Users\Administrator\AppData\Local\Temp\1\ssc05D86.tmp'
9:53:00 AM.117: Thread:19: [Downloader] ProcessStarted id=1
9:53:00 AM.122: Thread:19: [SessionController.DownloadEmptyOperations] Boolean::SessionController.DownloadOperations::IsEmpty: True -> False.
9:53:00 AM.123: Thread:19: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: True -> False.
9:53:00 AM.124: Thread:19: [Downloader] OperationStarted id=1 hostOperation=SnapShotQueueing
9:53:00 AM.126: Thread:13: [Downloader] OperationFinished id=1
9:53:00 AM.133: Thread:13: [Downloader] OperationStarted id=1 hostOperation=SnapShotSending
9:53:00 AM.160: Thread:13: [Downloader] SnapShotDone id=1 indexFile='C:\Users\Administrator\AppData\Local\Temp\1\ssc05D86.tmp'
9:53:00 AM.161: Thread:13: [CoverageSession#0] SnapshotDone event recieved. Queueing handler (configuration id: '')
9:53:00 AM.161: Thread:13: [Downloader] OperationFinished id=1
9:53:00 AM.162: Thread:20: [CoverageSession#0] Snapshot received: C:\Users\Administrator\AppData\Local\Temp\1\ssc05D86.tmp
9:53:00 AM.162: Thread:13: [Downloader] ProcessFinished id=1
9:53:00 AM.166: Thread:13: [SessionController.DownloadEmptyOperations] Boolean::SessionController.DownloadOperations::IsEmpty: False -> True.
9:53:00 AM.166: Thread:13: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: False -> True.
9:53:00 AM.497: Thread:18: [CommandProcessor] OperationFinished coreOperation=SnapShotSaving
9:53:00 AM.497: Thread:18: [SessionController.CoreEmptyOperations] Boolean::SessionController.CoreOperations::IsEmpty: True -> False.
9:53:00 AM.497: Thread:18: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: True -> False.
9:53:00 AM.497: Thread:18: [CommandProcessor] OperationFinished
9:53:00 AM.497: Thread:18: [SessionController.CoreEmptyOperations] Boolean::SessionController.CoreOperations::IsEmpty: False -> True.
9:53:00 AM.497: Thread:18: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: False -> True.
9:53:00 AM.497: Thread:18: [Downloader] ProcessIndexFile process={05c0cbc0-5ff3-4ee5-b323-2e8c1524d22f}:0 instance=1:0 sequence={fc479c21-b47b-47ea-8145-1723b1c9aa91}:0 snapshot={2bc3b229-c35e-49b6-9811-2457b9f55c75} localIndexFile='C:\Users\Administrator\AppData\Local\Temp\1\ssc00FFA.tmp'
9:53:00 AM.497: Thread:18: [Downloader] ProcessIndexFile id=2 process={05c0cbc0-5ff3-4ee5-b323-2e8c1524d22f}:0 instance=1:0 sequence={fc479c21-b47b-47ea-8145-1723b1c9aa91}:0 snapshot={2bc3b229-c35e-49b6-9811-2457b9f55c75} localIndexFile='C:\Users\Administrator\AppData\Local\Temp\1\ssc00FFA.tmp'
9:53:00 AM.497: Thread:18: [Downloader] ProcessStarted id=2
9:53:00 AM.497: Thread:18: [SessionController.DownloadEmptyOperations] Boolean::SessionController.DownloadOperations::IsEmpty: True -> False.
9:53:00 AM.497: Thread:18: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: True -> False.
9:53:00 AM.497: Thread:18: [Downloader] OperationStarted id=2 hostOperation=SnapShotQueueing
9:53:00 AM.497: Thread:14: [Downloader] OperationFinished id=2
9:53:00 AM.497: Thread:14: [Downloader] OperationStarted id=2 hostOperation=SnapShotSending
9:53:00 AM.498: Thread:14: [Downloader] SnapShotDone id=2 indexFile='C:\Users\Administrator\AppData\Local\Temp\1\ssc00FFA.tmp'
9:53:00 AM.498: Thread:14: [CoverageSession#0] SnapshotDone event recieved. Queueing handler (configuration id: '')
9:53:00 AM.498: Thread:14: [Downloader] OperationFinished id=2
9:53:00 AM.498: Thread:14: [Downloader] ProcessFinished id=2
9:53:00 AM.498: Thread:20: [CoverageSession#0] Snapshot received: C:\Users\Administrator\AppData\Local\Temp\1\ssc00FFA.tmp
9:53:00 AM.498: Thread:14: [SessionController.DownloadEmptyOperations] Boolean::SessionController.DownloadOperations::IsEmpty: False -> True.
9:53:00 AM.498: Thread:14: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: False -> True.
9:53:01 AM.030: Thread:19: [Downloader] ProcessLogFile process={6a54868b-fbc5-4a78-b5bf-755f15b5ac88} instance=1' localLogFile='C:\Users\Administrator\AppData\Local\Temp\1\lgc02D25.tmp'
9:53:01 AM.030: Thread:19: [Downloader] ProcessLogFile id=3 process={6a54868b-fbc5-4a78-b5bf-755f15b5ac88} instance=1' localLogFile='C:\Users\Administrator\AppData\Local\Temp\1\lgc02D25.tmp'
9:53:01 AM.030: Thread:19: [Downloader] ProcessStarted id=3
9:53:01 AM.031: Thread:19: [SessionController.DownloadEmptyOperations] Boolean::SessionController.DownloadOperations::IsEmpty: True -> False.
9:53:01 AM.031: Thread:19: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: True -> False.
9:53:01 AM.031: Thread:19: [Downloader] OperationStarted id=3 hostOperation=LogQueueing
9:53:01 AM.033: Thread:9: process [3756] 'MSTest' has exited with code 0
9:53:01 AM.042: Thread:19: Removing stream 59b40391-9dd7-4c85-b437-a36a57f54386 from listener cc6690ff-e365-4163-8894-c4e09ed07878
9:53:01 AM.397: Thread:18: [Downloader] ProcessLogFile process={05c0cbc0-5ff3-4ee5-b323-2e8c1524d22f} instance=1' localLogFile='C:\Users\Administrator\AppData\Local\Temp\1\lgc03124.tmp'
9:53:01 AM.397: Thread:18: [Downloader] ProcessLogFile id=4 process={05c0cbc0-5ff3-4ee5-b323-2e8c1524d22f} instance=1' localLogFile='C:\Users\Administrator\AppData\Local\Temp\1\lgc03124.tmp'
9:53:01 AM.397: Thread:18: [Downloader] ProcessStarted id=4
9:53:01 AM.397: Thread:18: [Downloader] OperationStarted id=4 hostOperation=LogQueueing
9:53:01 AM.397: Thread:18: [SessionController.EmptyConnections] Boolean::SessionController.BridgeControllers::IsEmpty: False -> True.
9:53:01 AM.397: Thread:18: Removing stream e4d265ad-56b9-4a54-89ad-de4a8a1ed00b from listener cc6690ff-e365-4163-8894-c4e09ed07878
9:53:04 AM.032: Thread:13: [Downloader] OperationFinished id=3
9:53:04 AM.033: Thread:13: [Downloader] OperationStarted id=3 hostOperation=LogSending
9:53:04 AM.035: Thread:13: [Downloader] LogDone id=3 logFile='C:\Users\Administrator\AppData\Local\Temp\1\lgc02D25.tmp'
9:53:04 AM.036: Thread:13: [CoverageSession#0] LogDone event recieved. Queueing handler (configuration id: '')
9:53:04 AM.037: Thread:13: [Downloader] OperationFinished id=3
9:53:04 AM.037: Thread:13: [Downloader] ProcessFinished id=3
9:53:04 AM.038: Thread:21: [CoverageSession#0] Log file received: C:\Users\Administrator\AppData\Local\Temp\1\lgc02D25.tmp
9:53:04 AM.046: Thread:21: File 'C:\Users\Administrator\AppData\Local\Temp\1\lgc02D25.tmp' successfully moved to 'C:\Users\Administrator\AppData\Local\Temp\1\JetLogs\JetBrainsLog.dotCover.2013-10-11T09-52-48.dotCover#604.Core.log'
9:53:04 AM.047: Thread:21: ====================================================================================================
9:53:04 AM.047: Thread:21: Core log file: C:\Users\Administrator\AppData\Local\Temp\1\JetLogs\JetBrainsLog.dotCover.2013-10-11T09-52-48.dotCover#604.Core.log
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Initialized
9:53:04 AM.048: Thread:21:  LogFile='C:\Users\ADMINI~1\AppData\Local\Temp\1\lgc02D25.tmp'
9:53:04 AM.048: Thread:21:  RealLogFile='C:\Users\Administrator\AppData\Local\Temp\1\lgc02D25.tmp'
9:53:04 AM.048: Thread:21:  Build=2.5.574.60
9:53:04 AM.048: Thread:21:  BuildTime=04.09.2013 20:53:24
9:53:04 AM.048: Thread:21:  ComponentMask=0000000000000008
9:53:04 AM.048: Thread:21:    0: [ ] Com
9:53:04 AM.048: Thread:21:    1: [ ] Api
9:53:04 AM.048: Thread:21:    2: [ ] Bridge
9:53:04 AM.048: Thread:21:    3: [X] PdbBridge
9:53:04 AM.048: Thread:21:    4: [ ] EtwBridge
9:53:04 AM.048: Thread:21:    5: [ ] Snapshot
9:53:04 AM.048: Thread:21:    8: [ ] MetaDataGt
9:53:04 AM.048: Thread:21:    9: [ ] PdbGt
9:53:04 AM.048: Thread:21:   10: [ ] ModulePathGt
9:53:04 AM.048: Thread:21:   11: [ ] InstrumentationGt
9:53:04 AM.048: Thread:21:   12: [ ] ThreadGt
9:53:04 AM.048: Thread:21:   13: [ ] ClassGt
9:53:04 AM.048: Thread:21:   14: [ ] MethodFilterGt
9:53:04 AM.048: Thread:21:   15: [ ] FuidGt
9:53:04 AM.048: Thread:21:   20: [ ] PerformanceSamplingGt
9:53:04 AM.048: Thread:21:   24: [ ] CoverageGroupGt
9:53:04 AM.048: Thread:21:   25: [ ] CoverageCyclomaticComplexityGt
9:53:04 AM.048: Thread:21:   28: [ ] MemoryDumpGt
9:53:04 AM.048: Thread:21:   32: [ ] AppDomainCb
9:53:04 AM.048: Thread:21:   33: [ ] AssemblyCb
9:53:04 AM.048: Thread:21:   34: [ ] ClassCb
9:53:04 AM.048: Thread:21:   35: [ ] ExceptionCb
9:53:04 AM.048: Thread:21:   36: [ ] ExceptionClrCb
9:53:04 AM.048: Thread:21:   37: [ ] FunctionCb
9:53:04 AM.048: Thread:21:   38: [ ] GcCb
9:53:04 AM.048: Thread:21:   39: [ ] HandleCb
9:53:04 AM.048: Thread:21:   40: [ ] ModuleCb
9:53:04 AM.048: Thread:21:   41: [ ] RemotingCb
9:53:04 AM.048: Thread:21:   42: [ ] RuntimeCb
9:53:04 AM.048: Thread:21:   43: [ ] ThreadCb
9:53:04 AM.048: Thread:21:   44: [ ] TransitionCb
9:53:04 AM.048: Thread:21:   45: [ ] VTableCb
9:53:04 AM.048: Thread:21:   46: [ ] ReJitCb
9:53:04 AM.048: Thread:21:   56: [ ] InstrumentationEp
9:53:04 AM.048: Thread:21:   57: [ ] FunctionEp
9:53:04 AM.048: Thread:21:   58: [ ] MapperEp
9:53:04 AM.048: Thread:21:  Time=11.10.2013 15:52:56
9:53:04 AM.048: Thread:21:  ProcessorArchitecture=0
9:53:04 AM.048: Thread:21:  PageSize=4096
9:53:04 AM.048: Thread:21:  MinimumApplicationAddress=00010000
9:53:04 AM.048: Thread:21:  MaximumApplicationAddress=7FFEFFFF
9:53:04 AM.048: Thread:21:  ActiveProcessorMask=00000003
9:53:04 AM.048: Thread:21:  NumberOfProcessors=2
9:53:04 AM.048: Thread:21:  AllocationGranularity=65536
9:53:04 AM.048: Thread:21:  ProcessorLevel=6
9:53:04 AM.048: Thread:21:  ProcessorRevision=2C02
9:53:04 AM.048: Thread:21:  NativeProcessorArchitecture=9
9:53:04 AM.048: Thread:21:  MajorVersion=6
9:53:04 AM.048: Thread:21:  MinorVersion=1
9:53:04 AM.048: Thread:21:  BuildNumber=7601
9:53:04 AM.048: Thread:21:  PlatformId=2
9:53:04 AM.048: Thread:21:  CSDVersion='Service Pack 1'
9:53:04 AM.048: Thread:21:  ServicePackMajor=1
9:53:04 AM.048: Thread:21:  ServicePackMinor=0
9:53:04 AM.048: Thread:21:  SuiteMask=0110
9:53:04 AM.048: Thread:21:  ProductType=3
9:53:04 AM.048: Thread:21:  VistaProductType=7
9:53:04 AM.048: Thread:21:  UserName='USBSRDRSMWEB3\Administrator'
9:53:04 AM.048: Thread:21:  ProcessId=00000374 (884)
9:53:04 AM.048: Thread:21:  CommandLine='"D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\QTAgent32_40.exe" /agentKey f02378ad-6f92-4684-9af9-7f605521d1b4 /hostProcessId 3756 /hostIpcPortName eqt-93c2f472-2f12-659a-1397-79d1d5097b75'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Profiler res=failed name='ReleasePerformanceTracing'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Profiler res=failed name='ReleasePerformanceSampling'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Profiler res=failed name='ReleaseMemory'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Profiler res=failed name='ReleasePerformanceTracingInject'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Profiler res=ok guid={762A40A9-7A75-4662-96FA-4DC67A8F77C4} name='ReleaseCoverage'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Profiler res=failed name='ReleaseTestPerformance'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Profiler res=failed name='ReleaseTestPerformanceSampling'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Profiler res=failed name='ReleaseTestMemory'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 Profiler res=failed name='ReleaseTestCoverage'
9:53:04 AM.048: Thread:21: 00001370 0 00000000 ProcessGuid id={6A54868B-FBC5-4A78-B5BF-755F15B5AC88}
9:53:04 AM.048: Thread:21: 00001370 0 00000000 DllGetClassObject clsid={762A40A9-7A75-4662-96FA-4DC67A8F77C4} iid={00000001-0000-0000-C000-000000000046}
9:53:04 AM.048: Thread:21: 00001370 0 00000000 DllGetClassObject clsid={762A40A9-7A75-4662-96FA-4DC67A8F77C4} res=ok name='Coverage'
9:53:04 AM.048: Thread:21: 00001370 1 00000000 BProf::Initialize
9:53:04 AM.048: Thread:21: 00001370 1 00000000 BProf::UpdateRuntimeVersion interface=4 type='desktop' version=4.0.30319.18034 ciid=0D
9:53:04 AM.048: Thread:21: 00001370 1 00000000 B::Connect addressFamily=2 ipAddress='127.0.0.1' port=52171
9:53:04 AM.048: Thread:21: 00000774 1 00000000 B::DoWorkThread
9:53:04 AM.048: Thread:21: 00000774 1 00000000 BB::TryConnect controlKind=manual
9:53:04 AM.048: Thread:21:  <?xml version="1.0" encoding="utf-8"?>
9:53:04 AM.048: Thread:21:  <Configuration>
9:53:04 AM.048: Thread:21:   <HostParameters type="LocalHostParameters" />
9:53:04 AM.048: Thread:21:   <Argument type="StandaloneArgument">
9:53:04 AM.048: Thread:21:    <Arguments>/testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll</Arguments>
9:53:04 AM.048: Thread:21:    <FileName>D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe</FileName>
9:53:04 AM.048: Thread:21:    <ProfileChildProcesses>True</ProfileChildProcesses>
9:53:04 AM.048: Thread:21:    <WorkingDirectory>C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service</WorkingDirectory>
9:53:04 AM.048: Thread:21:   </Argument>
9:53:04 AM.048: Thread:21:   <Info type="CoverageInfo">
9:53:04 AM.048: Thread:21:    <CyclomaticComplexityGather>True</CyclomaticComplexityGather>
9:53:04 AM.048: Thread:21:    <InjectInfo>
9:53:04 AM.048: Thread:21:     <SearchPaths />
9:53:04 AM.048: Thread:21:     <Scope>
9:53:04 AM.048: Thread:21:      <PatternFilters>
9:53:04 AM.048: Thread:21:       <Item>
9:53:04 AM.048: Thread:21:        <AssemblyFilter>BCT*</AssemblyFilter>
9:53:04 AM.048: Thread:21:       </Item>
9:53:04 AM.048: Thread:21:       <Item>
9:53:04 AM.048: Thread:21:        <AssemblyFilter>mscorlib</AssemblyFilter>
9:53:04 AM.048: Thread:21:        <Type>Deny</Type>
9:53:04 AM.048: Thread:21:       </Item>
9:53:04 AM.048: Thread:21:       <Item>
9:53:04 AM.048: Thread:21:        <AssemblyFilter>System</AssemblyFilter>
9:53:04 AM.048: Thread:21:        <Type>Deny</Type>
9:53:04 AM.048: Thread:21:       </Item>
9:53:04 AM.048: Thread:21:       <Item>
9:53:04 AM.048: Thread:21:        <AssemblyFilter>System.*</AssemblyFilter>
9:53:04 AM.048: Thread:21:        <Type>Deny</Type>
9:53:04 AM.048: Thread:21:       </Item>
9:53:04 AM.048: Thread:21:       <Item>
9:53:04 AM.048: Thread:21:        <AssemblyFilter>Microsoft.*</AssemblyFilter>
9:53:04 AM.048: Thread:21:        <Type>Deny</Type>
9:53:04 AM.048: Thread:21:       </Item>
9:53:04 AM.048: Thread:21:      </PatternFilters>
9:53:04 AM.048: Thread:21:      <DenyAttributeFilters />
9:53:04 AM.048: Thread:21:     </Scope>
9:53:04 AM.048: Thread:21:    </InjectInfo>
9:53:04 AM.048: Thread:21:   </Info>
9:53:04 AM.048: Thread:21:   <CoreOptions>
9:53:04 AM.048: Thread:21:    <CoreLogMask>PdbBridge</CoreLogMask>
9:53:04 AM.048: Thread:21:    <CoreRegistrationRegistryFreeInstructionSet IsNull="False">
9:53:04 AM.048: Thread:21:    </CoreRegistrationRegistryFreeInstructionSet>
9:53:04 AM.048: Thread:21:    <CoreTempPath IsNull="False">
9:53:04 AM.048: Thread:21:    </CoreTempPath>
9:53:04 AM.048: Thread:21:   </CoreOptions>
9:53:04 AM.048: Thread:21:   <HostOptions>
9:53:04 AM.048: Thread:21:    <HostTempPath IsNull="False">
9:53:04 AM.048: Thread:21:    </HostTempPath>
9:53:04 AM.048: Thread:21:    <UserData />
9:53:04 AM.048: Thread:21:   </HostOptions>
9:53:04 AM.048: Thread:21:  </Configuration>
9:53:04 AM.048: Thread:21: 00001370 1 00000000 CProf::OnConnected
9:53:04 AM.048: Thread:21: 00001370 1 00000000 BProf::CleanEnvironmentVariables
9:53:04 AM.048: Thread:21: 00001370 1 00000000 CProf::OnBeginInitialize memoryThreshold=214735257
9:53:04 AM.048: Thread:21: 00001370 1 00000000 MDG::Create
9:53:04 AM.048: Thread:21: 00001370 1 00000000 PG::Create policy=FOsR
9:53:04 AM.048: Thread:21: 00001370 1 00000000 PDBB::Open
9:53:04 AM.048: Thread:21: 00000500 1 00000000 PDBB::DoWorkThread
9:53:04 AM.048: Thread:21: 00001370 1 00000000 MG::Create
9:53:04 AM.048: Thread:21: 00001370 1 00000000 MF::PatternFilters count=5
9:53:04 AM.048: Thread:21:  #0: type=allow amask='BCT*' avmask='*' tmask='*' mmask='*'
9:53:04 AM.048: Thread:21:  #1: type=deny amask='mscorlib' avmask='*' tmask='*' mmask='*'
9:53:04 AM.048: Thread:21:  #2: type=deny amask='System' avmask='*' tmask='*' mmask='*'
9:53:04 AM.048: Thread:21:  #3: type=deny amask='System.*' avmask='*' tmask='*' mmask='*'
9:53:04 AM.048: Thread:21:  #4: type=deny amask='Microsoft.*' avmask='*' tmask='*' mmask='*'
9:53:04 AM.048: Thread:21: 00001370 1 00000000 MF::DenyAttributeFilters count=0
9:53:04 AM.048: Thread:21: 00001370 1 00000000 CGath::Create
9:53:04 AM.048: Thread:21: 00001370 1 00000000 CPool::Create
9:53:04 AM.048: Thread:21: 00001370 1 00000000 BPool::Create
9:53:04 AM.048: Thread:21: 00001370 1 00000000 BACProf::OnEndInitialize
9:53:04 AM.048: Thread:21: 00001370 1 00000000 BB::ActivateCommands
9:53:04 AM.048: Thread:21: 00001290 1 00000000 CT::DoWorkThread
9:53:04 AM.048: Thread:21: 000010E0 1 113A0020 PDBB::LoadModule mvid={3A9CF6A0-74BA-49C7-8A5D-C686ED9C72DD} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\TestResults\Administrator_USBSRDRSMWEB3 2013-10-11 09_52_56\Out\BCT.RSM.Services.Cadence.IntegrationTests.dll'
9:53:04 AM.048: Thread:21: 000010E0 1 113A0020 PDBB::LoadModule cmd=LoadModule id=1 size=210
9:53:04 AM.048: Thread:21: 00000500 1 00000000 PDBB::DoWorkThread awr=LoadModule id=1 size=9 pdbmid=0
9:53:04 AM.048: Thread:21: 000010E0 1 113A0020 PDBB::LoadModule mvid={6B914A07-2B1C-4C8E-AF7B-E11BE17B24E6} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\TestResults\Administrator_USBSRDRSMWEB3 2013-10-11 09_52_56\Out\BCT.RSM.Services.Cadence.exe'
9:53:04 AM.048: Thread:21: 000010E0 1 113A0020 PDBB::LoadModule cmd=LoadModule id=2 size=193
9:53:04 AM.049: Thread:21: 00000500 1 00000000 PDBB::DoWorkThread awr=LoadModule id=2 size=9 pdbmid=0
9:53:04 AM.049: Thread:21: 00000E58 1 114057D8 PDBB::LoadModule mvid={EDC81DBB-EDF3-4B34-BF24-1B445AABBDA3} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\TestResults\Administrator_USBSRDRSMWEB3 2013-10-11 09_52_56\Out\Internal Bin\BCT.Common.Barcode.dll'
9:53:04 AM.049: Thread:21: 00000E58 1 114057D8 PDBB::LoadModule cmd=LoadModule id=3 size=200
9:53:04 AM.049: Thread:21: 00000500 1 00000000 PDBB::DoWorkThread awr=LoadModule id=3 size=9 pdbmid=0
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 BProf::Shutdown
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 BB::DeactivateCommands
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 BACProf::OnBeginShutdown
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 CPool::MergeWriteDelete
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 BPool::DoAndDelete
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 CProf::OnEndShutdown
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 CPool::Close
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 BPool::Close
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 CGath::Close
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 IVG::Close
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 MG::Close
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 PG::Close
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 PDBB::Close
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 PDBB::Close cmd=Quit id=4 size=4
9:53:04 AM.049: Thread:21: 00000500 1 00000000 PDBB::DoWorkThread awr=Quit id=4 size=5
9:53:04 AM.049: Thread:21: 00000500 1 00000000 PDBB::DoWorkThread Stop Processing
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 MDG::Close
9:53:04 AM.049: Thread:21: 00001370 1 003E5C78 BB::Close
9:53:04 AM.049: Thread:21: 00001370 1 00000000 BProf::Shutdown res=ok
9:53:04 AM.049: Thread:21: 00001370 1 00000000 BB::Abort
9:53:04 AM.049: Thread:21: 00001370 0 00000000 Finished
9:53:04 AM.049: Thread:21: ====================================================================================================
9:53:04 AM.397: Thread:14: [Downloader] OperationFinished id=4
9:53:04 AM.397: Thread:14: [Downloader] OperationStarted id=4 hostOperation=LogSending
9:53:04 AM.397: Thread:14: [Downloader] LogDone id=4 logFile='C:\Users\Administrator\AppData\Local\Temp\1\lgc03124.tmp'
9:53:04 AM.397: Thread:14: [CoverageSession#0] LogDone event recieved. Queueing handler (configuration id: '')
9:53:04 AM.397: Thread:14: [Downloader] OperationFinished id=4
9:53:04 AM.397: Thread:14: [Downloader] ProcessFinished id=4
9:53:04 AM.397: Thread:21: [CoverageSession#0] Log file received: C:\Users\Administrator\AppData\Local\Temp\1\lgc03124.tmp
9:53:04 AM.397: Thread:14: [SessionController.DownloadEmptyOperations] Boolean::SessionController.DownloadOperations::IsEmpty: False -> True.
9:53:04 AM.397: Thread:14: [SessionController.NoConnectionsAndOperations] Boolean::(SessionController.BridgeControllers::IsEmpty,(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And).And: False -> True.
9:53:04 AM.397: Thread:14: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: False -> True.
9:53:04 AM.398: Thread:21: File 'C:\Users\Administrator\AppData\Local\Temp\1\lgc03124.tmp' successfully moved to 'C:\Users\Administrator\AppData\Local\Temp\1\JetLogs\JetBrainsLog.dotCover.2013-10-11T09-52-48.dotCover#604.Core.1.log'
9:53:04 AM.398: Thread:21: ====================================================================================================
9:53:04 AM.398: Thread:21: Core log file: C:\Users\Administrator\AppData\Local\Temp\1\JetLogs\JetBrainsLog.dotCover.2013-10-11T09-52-48.dotCover#604.Core.1.log
9:53:04 AM.398: Thread:21: 00000960 0 00000000 Initialized
9:53:04 AM.398: Thread:21:  LogFile='C:\Users\ADMINI~1\AppData\Local\Temp\1\lgc03124.tmp'
9:53:04 AM.398: Thread:21:  RealLogFile='C:\Users\Administrator\AppData\Local\Temp\1\lgc03124.tmp'
9:53:04 AM.398: Thread:21:  Build=2.5.574.60
9:53:04 AM.398: Thread:21:  BuildTime=04.09.2013 20:53:24
9:53:04 AM.398: Thread:21:  ComponentMask=0000000000000008
9:53:04 AM.398: Thread:21:    0: [ ] Com
9:53:04 AM.398: Thread:21:    1: [ ] Api
9:53:04 AM.398: Thread:21:    2: [ ] Bridge
9:53:04 AM.398: Thread:21:    3: [X] PdbBridge
9:53:04 AM.398: Thread:21:    4: [ ] EtwBridge
9:53:04 AM.398: Thread:21:    5: [ ] Snapshot
9:53:04 AM.398: Thread:21:    8: [ ] MetaDataGt
9:53:04 AM.398: Thread:21:    9: [ ] PdbGt
9:53:04 AM.398: Thread:21:   10: [ ] ModulePathGt
9:53:04 AM.398: Thread:21:   11: [ ] InstrumentationGt
9:53:04 AM.398: Thread:21:   12: [ ] ThreadGt
9:53:04 AM.398: Thread:21:   13: [ ] ClassGt
9:53:04 AM.398: Thread:21:   14: [ ] MethodFilterGt
9:53:04 AM.398: Thread:21:   15: [ ] FuidGt
9:53:04 AM.398: Thread:21:   20: [ ] PerformanceSamplingGt
9:53:04 AM.398: Thread:21:   24: [ ] CoverageGroupGt
9:53:04 AM.398: Thread:21:   25: [ ] CoverageCyclomaticComplexityGt
9:53:04 AM.398: Thread:21:   28: [ ] MemoryDumpGt
9:53:04 AM.398: Thread:21:   32: [ ] AppDomainCb
9:53:04 AM.398: Thread:21:   33: [ ] AssemblyCb
9:53:04 AM.398: Thread:21:   34: [ ] ClassCb
9:53:04 AM.398: Thread:21:   35: [ ] ExceptionCb
9:53:04 AM.398: Thread:21:   36: [ ] ExceptionClrCb
9:53:04 AM.398: Thread:21:   37: [ ] FunctionCb
9:53:04 AM.398: Thread:21:   38: [ ] GcCb
9:53:04 AM.398: Thread:21:   39: [ ] HandleCb
9:53:04 AM.398: Thread:21:   40: [ ] ModuleCb
9:53:04 AM.398: Thread:21:   41: [ ] RemotingCb
9:53:04 AM.398: Thread:21:   42: [ ] RuntimeCb
9:53:04 AM.398: Thread:21:   43: [ ] ThreadCb
9:53:04 AM.398: Thread:21:   44: [ ] TransitionCb
9:53:04 AM.398: Thread:21:   45: [ ] VTableCb
9:53:04 AM.398: Thread:21:   46: [ ] ReJitCb
9:53:04 AM.398: Thread:21:   56: [ ] InstrumentationEp
9:53:04 AM.398: Thread:21:   57: [ ] FunctionEp
9:53:04 AM.398: Thread:21:   58: [ ] MapperEp
9:53:04 AM.398: Thread:21:  Time=11.10.2013 15:52:54
9:53:04 AM.398: Thread:21:  ProcessorArchitecture=0
9:53:04 AM.398: Thread:21:  PageSize=4096
9:53:04 AM.398: Thread:21:  MinimumApplicationAddress=00010000
9:53:04 AM.398: Thread:21:  MaximumApplicationAddress=7FFEFFFF
9:53:04 AM.398: Thread:21:  ActiveProcessorMask=00000003
9:53:04 AM.398: Thread:21:  NumberOfProcessors=2
9:53:04 AM.398: Thread:21:  AllocationGranularity=65536
9:53:04 AM.398: Thread:21:  ProcessorLevel=6
9:53:04 AM.398: Thread:21:  ProcessorRevision=2C02
9:53:04 AM.398: Thread:21:  NativeProcessorArchitecture=9
9:53:04 AM.398: Thread:21:  MajorVersion=6
9:53:04 AM.398: Thread:21:  MinorVersion=1
9:53:04 AM.398: Thread:21:  BuildNumber=7601
9:53:04 AM.398: Thread:21:  PlatformId=2
9:53:04 AM.398: Thread:21:  CSDVersion='Service Pack 1'
9:53:04 AM.398: Thread:21:  ServicePackMajor=1
9:53:04 AM.398: Thread:21:  ServicePackMinor=0
9:53:04 AM.398: Thread:21:  SuiteMask=0110
9:53:04 AM.399: Thread:21:  ProductType=3
9:53:04 AM.399: Thread:21:  VistaProductType=7
9:53:04 AM.399: Thread:21:  UserName='USBSRDRSMWEB3\Administrator'
9:53:04 AM.399: Thread:21:  ProcessId=00000EAC (3756)
9:53:04 AM.399: Thread:21:  CommandLine='"D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe" /testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Profiler res=failed name='ReleasePerformanceTracing'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Profiler res=failed name='ReleasePerformanceSampling'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Profiler res=failed name='ReleaseMemory'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Profiler res=failed name='ReleasePerformanceTracingInject'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Profiler res=ok guid={762A40A9-7A75-4662-96FA-4DC67A8F77C4} name='ReleaseCoverage'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Profiler res=failed name='ReleaseTestPerformance'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Profiler res=failed name='ReleaseTestPerformanceSampling'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Profiler res=failed name='ReleaseTestMemory'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Profiler res=failed name='ReleaseTestCoverage'
9:53:04 AM.399: Thread:21: 00000960 0 00000000 ProcessGuid id={05C0CBC0-5FF3-4EE5-B323-2E8C1524D22F}
9:53:04 AM.399: Thread:21: 00000960 0 00000000 DllGetClassObject clsid={762A40A9-7A75-4662-96FA-4DC67A8F77C4} iid={00000001-0000-0000-C000-000000000046}
9:53:04 AM.399: Thread:21: 00000960 0 00000000 DllGetClassObject clsid={762A40A9-7A75-4662-96FA-4DC67A8F77C4} res=ok name='Coverage'
9:53:04 AM.399: Thread:21: 00000960 1 00000000 BProf::Initialize
9:53:04 AM.399: Thread:21: 00000960 1 00000000 BProf::UpdateRuntimeVersion interface=4 type='desktop' version=4.0.30319.18034 ciid=0D
9:53:04 AM.399: Thread:21: 00000960 1 00000000 B::Connect addressFamily=2 ipAddress='127.0.0.1' port=52171
9:53:04 AM.399: Thread:21: 000004CC 1 00000000 B::DoWorkThread
9:53:04 AM.399: Thread:21: 000004CC 1 00000000 BB::TryConnect controlKind=manual
9:53:04 AM.399: Thread:21:  <?xml version="1.0" encoding="utf-8"?>
9:53:04 AM.399: Thread:21:  <Configuration>
9:53:04 AM.399: Thread:21:   <HostParameters type="LocalHostParameters" />
9:53:04 AM.399: Thread:21:   <Argument type="StandaloneArgument">
9:53:04 AM.399: Thread:21:    <Arguments>/testcontainer:BCT.RSM.Services.Cadence.IntegrationTests.dll</Arguments>
9:53:04 AM.399: Thread:21:    <FileName>D:\Program Files (x86)\Microsoft Visual Studio 11.0\Common7\IDE\MSTest.exe</FileName>
9:53:04 AM.399: Thread:21:    <ProfileChildProcesses>True</ProfileChildProcesses>
9:53:04 AM.399: Thread:21:    <WorkingDirectory>C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service</WorkingDirectory>
9:53:04 AM.399: Thread:21:   </Argument>
9:53:04 AM.399: Thread:21:   <Info type="CoverageInfo">
9:53:04 AM.399: Thread:21:    <CyclomaticComplexityGather>True</CyclomaticComplexityGather>
9:53:04 AM.399: Thread:21:    <InjectInfo>
9:53:04 AM.399: Thread:21:     <SearchPaths />
9:53:04 AM.399: Thread:21:     <Scope>
9:53:04 AM.399: Thread:21:      <PatternFilters>
9:53:04 AM.399: Thread:21:       <Item>
9:53:04 AM.399: Thread:21:        <AssemblyFilter>BCT*</AssemblyFilter>
9:53:04 AM.399: Thread:21:       </Item>
9:53:04 AM.399: Thread:21:       <Item>
9:53:04 AM.399: Thread:21:        <AssemblyFilter>mscorlib</AssemblyFilter>
9:53:04 AM.399: Thread:21:        <Type>Deny</Type>
9:53:04 AM.399: Thread:21:       </Item>
9:53:04 AM.399: Thread:21:       <Item>
9:53:04 AM.399: Thread:21:        <AssemblyFilter>System</AssemblyFilter>
9:53:04 AM.399: Thread:21:        <Type>Deny</Type>
9:53:04 AM.399: Thread:21:       </Item>
9:53:04 AM.399: Thread:21:       <Item>
9:53:04 AM.399: Thread:21:        <AssemblyFilter>System.*</AssemblyFilter>
9:53:04 AM.399: Thread:21:        <Type>Deny</Type>
9:53:04 AM.399: Thread:21:       </Item>
9:53:04 AM.399: Thread:21:       <Item>
9:53:04 AM.399: Thread:21:        <AssemblyFilter>Microsoft.*</AssemblyFilter>
9:53:04 AM.399: Thread:21:        <Type>Deny</Type>
9:53:04 AM.399: Thread:21:       </Item>
9:53:04 AM.399: Thread:21:      </PatternFilters>
9:53:04 AM.399: Thread:21:      <DenyAttributeFilters />
9:53:04 AM.399: Thread:21:     </Scope>
9:53:04 AM.399: Thread:21:    </InjectInfo>
9:53:04 AM.399: Thread:21:   </Info>
9:53:04 AM.399: Thread:21:   <CoreOptions>
9:53:04 AM.399: Thread:21:    <CoreLogMask>PdbBridge</CoreLogMask>
9:53:04 AM.399: Thread:21:    <CoreRegistrationRegistryFreeInstructionSet IsNull="False">
9:53:04 AM.399: Thread:21:    </CoreRegistrationRegistryFreeInstructionSet>
9:53:04 AM.399: Thread:21:    <CoreTempPath IsNull="False">
9:53:04 AM.399: Thread:21:    </CoreTempPath>
9:53:04 AM.399: Thread:21:   </CoreOptions>
9:53:04 AM.399: Thread:21:   <HostOptions>
9:53:04 AM.399: Thread:21:    <HostTempPath IsNull="False">
9:53:04 AM.399: Thread:21:    </HostTempPath>
9:53:04 AM.399: Thread:21:    <UserData />
9:53:04 AM.399: Thread:21:   </HostOptions>
9:53:04 AM.399: Thread:21:  </Configuration>
9:53:04 AM.399: Thread:21: 00000960 1 00000000 CProf::OnConnected
9:53:04 AM.399: Thread:21: 00000960 1 00000000 BProf::CleanEnvironmentVariables
9:53:04 AM.399: Thread:21: 00000960 1 00000000 CProf::OnBeginInitialize memoryThreshold=214735257
9:53:04 AM.399: Thread:21: 00000960 1 00000000 MDG::Create
9:53:04 AM.399: Thread:21: 00000960 1 00000000 PG::Create policy=FOsR
9:53:04 AM.399: Thread:21: 00000960 1 00000000 PDBB::Open
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread
9:53:04 AM.399: Thread:21: 00000960 1 00000000 MG::Create
9:53:04 AM.399: Thread:21: 00000960 1 00000000 MF::PatternFilters count=5
9:53:04 AM.399: Thread:21:  #0: type=allow amask='BCT*' avmask='*' tmask='*' mmask='*'
9:53:04 AM.399: Thread:21:  #1: type=deny amask='mscorlib' avmask='*' tmask='*' mmask='*'
9:53:04 AM.399: Thread:21:  #2: type=deny amask='System' avmask='*' tmask='*' mmask='*'
9:53:04 AM.399: Thread:21:  #3: type=deny amask='System.*' avmask='*' tmask='*' mmask='*'
9:53:04 AM.399: Thread:21:  #4: type=deny amask='Microsoft.*' avmask='*' tmask='*' mmask='*'
9:53:04 AM.399: Thread:21: 00000960 1 00000000 MF::DenyAttributeFilters count=0
9:53:04 AM.399: Thread:21: 00000960 1 00000000 CGath::Create
9:53:04 AM.399: Thread:21: 00000960 1 00000000 CPool::Create
9:53:04 AM.399: Thread:21: 00000960 1 00000000 BPool::Create
9:53:04 AM.399: Thread:21: 00000960 1 00000000 BACProf::OnEndInitialize
9:53:04 AM.399: Thread:21: 00000960 1 00000000 BB::ActivateCommands
9:53:04 AM.399: Thread:21: 00000BF4 1 00000000 CT::DoWorkThread
9:53:04 AM.399: Thread:21: 00000960 1 008243F0 PDBB::LoadModule mvid={3A9CF6A0-74BA-49C7-8A5D-C686ED9C72DD} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\BCT.RSM.Services.Cadence.IntegrationTests.dll'
9:53:04 AM.399: Thread:21: 00000960 1 008243F0 PDBB::LoadModule cmd=LoadModule id=1 size=145
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=LoadModule id=1 size=9 pdbmid=0
9:53:04 AM.399: Thread:21: 00000960 1 008243F0 PDBB::LoadModule mvid={3A9CF6A0-74BA-49C7-8A5D-C686ED9C72DD} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\bct.rsm.services.cadence.integrationtests.dll'
9:53:04 AM.399: Thread:21: 00000960 1 008243F0 PDBB::LoadModule cmd=LoadModule id=2 size=145
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=LoadModule id=2 size=9 pdbmid=0
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule mvid={3A9CF6A0-74BA-49C7-8A5D-C686ED9C72DD} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\bct.rsm.services.cadence.integrationtests.dll'
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule cmd=LoadModule id=3 size=145
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=LoadModule id=3 size=9 pdbmid=0
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule mvid={6B914A07-2B1C-4C8E-AF7B-E11BE17B24E6} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\BCT.RSM.Services.Cadence.exe'
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule cmd=LoadModule id=4 size=128
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=LoadModule id=4 size=9 pdbmid=0
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule mvid={DD14F685-C45F-4624-BB83-9E251A80BBE8} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\Internal Bin\BCT.RSM.Shared.Utility.dll'
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule cmd=LoadModule id=5 size=139
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=LoadModule id=5 size=9 pdbmid=0
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule mvid={2ACE4451-41E5-488A-B08B-061FA1EF0C9C} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\Internal Bin\BCT.RSM.ApplicationServiceProxy.dll'
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule cmd=LoadModule id=6 size=148
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=LoadModule id=6 size=9 pdbmid=0
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule mvid={9826D8BE-3473-40A1-8AAA-14D07E6644F0} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\Internal Bin\BCT.RSM.ApplicationServicesData.dll'
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule cmd=LoadModule id=7 size=148
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=LoadModule id=7 size=9 pdbmid=0
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule mvid={DE574070-39D3-4174-9E87-EEC335840862} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\Internal Bin\BCT.RSM.StringResources.dll'
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule cmd=LoadModule id=8 size=140
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=LoadModule id=8 size=9 pdbmid=0
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule mvid={EDC81DBB-EDF3-4B34-BF24-1B445AABBDA3} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\Internal Bin\BCT.Common.Barcode.dll'
9:53:04 AM.399: Thread:21: 000013E0 1 06F78F10 PDBB::LoadModule cmd=LoadModule id=9 size=135
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=LoadModule id=9 size=9 pdbmid=0
9:53:04 AM.399: Thread:21: 00001224 1 00000000 BProf::Shutdown
9:53:04 AM.399: Thread:21: 00001224 1 00000000 BB::DeactivateCommands
9:53:04 AM.399: Thread:21: 00001224 1 00000000 BACProf::OnBeginShutdown
9:53:04 AM.399: Thread:21: 00001224 1 00000000 CPool::MergeWriteDelete
9:53:04 AM.399: Thread:21: 00001224 1 00000000 BPool::DoAndDelete
9:53:04 AM.399: Thread:21: 00001224 1 00000000 CProf::OnEndShutdown
9:53:04 AM.399: Thread:21: 00001224 1 00000000 CPool::Close
9:53:04 AM.399: Thread:21: 00001224 1 00000000 BPool::Close
9:53:04 AM.399: Thread:21: 00001224 1 00000000 CGath::Close
9:53:04 AM.399: Thread:21: 00001224 1 00000000 IVG::Close
9:53:04 AM.399: Thread:21: 00001224 1 00000000 MG::Close
9:53:04 AM.399: Thread:21: 00001224 1 00000000 PG::Close
9:53:04 AM.399: Thread:21: 00001224 1 00000000 PDBB::Close
9:53:04 AM.399: Thread:21: 00001224 1 00000000 PDBB::Close cmd=Quit id=10 size=4
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread awr=Quit id=10 size=5
9:53:04 AM.399: Thread:21: 00000FC4 1 00000000 PDBB::DoWorkThread Stop Processing
9:53:04 AM.399: Thread:21: 00001224 1 00000000 MDG::Close
9:53:04 AM.399: Thread:21: 00001224 1 00000000 BB::Close
9:53:04 AM.399: Thread:21: 00001224 1 00000000 BProf::Shutdown res=ok
9:53:04 AM.399: Thread:21: 00001224 1 00000000 BB::Abort
9:53:04 AM.399: Thread:21: 00000960 0 00000000 Finished
9:53:04 AM.399: Thread:21: ====================================================================================================
9:53:05 AM.401: Thread:9: [SessionController.ConnectedAndDelayedNoConnectionsAndOperations] Boolean::(SessionController.WasConnection,SessionController.DelayedNoConnectionsAndOperations).And: False -> True.
9:53:05 AM.401: Thread:9: [SessionController.FinishedRequest] Boolean::((SessionController.Terminated,(SessionController.BridgeControllers::IsEmpty,(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And).And).And,(SessionController.WasConnection,SessionController.DelayedNoConnectionsAndOperations).And).Or: False -> True.
9:53:05 AM.402: Thread:9: [SessionController.DelayedNoConnectionsAndOperations] Boolean::SessionController.DelayedNoConnectionsAndOperations: False -> True.
9:53:05 AM.403: Thread:22: [SessionController] Finished
9:53:05 AM.408: Thread:22: [SessionController.Finished] Boolean::SessionController.Finished: False -> True.
9:53:05 AM.409: Thread:22: [CoverageSession#0] Finished event recieved. Queueing handler (configuration id: '')
9:53:05 AM.414: Thread:23: [CoverageSession#0] Configuration finished (configuration id: '')
9:53:05 AM.418: Thread:23: [CoverageSession#0] Handling session finish
9:53:05 AM.420: Thread:23: [SessionController.FinishedRequest] Boolean::((SessionController.Terminated,(SessionController.BridgeControllers::IsEmpty,(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And).And).And,(SessionController.WasConnection,SessionController.DelayedNoConnectionsAndOperations).And).Or: True -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.ConnectedAndDelayedNoConnectionsAndOperations] Boolean::(SessionController.WasConnection,SessionController.DelayedNoConnectionsAndOperations).And: True -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.DelayedNoConnectionsAndOperations] Boolean::SessionController.DelayedNoConnectionsAndOperations: True -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.TerminatedAndNoConnectionsAndOperations] Boolean::(SessionController.Terminated,(SessionController.BridgeControllers::IsEmpty,(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And).And).And: False -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.NoConnectionsAndOperations] Boolean::(SessionController.BridgeControllers::IsEmpty,(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And).And: True -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.NoOperations] Boolean::(SessionController.CoreOperations::IsEmpty,SessionController.DownloadOperations::IsEmpty).And: True -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.DownloadEmptyOperations] Boolean::SessionController.DownloadOperations::IsEmpty: True -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.CoreEmptyOperations] Boolean::SessionController.CoreOperations::IsEmpty: True -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.EmptyConnections] Boolean::SessionController.BridgeControllers::IsEmpty: True -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.Connected] Boolean::SessionController.WasConnection: True -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.Terminated] Boolean::SessionController.Terminated: False -> <N/A>.
9:53:05 AM.426: Thread:23: [SessionController.Finished] Boolean::SessionController.Finished: True -> <N/A>.
9:53:05 AM.497: Thread:12: [CoverageSession#0] Analysis finished (configuration id: '')
9:53:05 AM.518: Thread:15: Removing listener cc6690ff-e365-4163-8894-c4e09ed07878
9:53:05 AM.521: Thread:23: [RegisterCore] op=Uninstall instructionSet=x86 path='C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x86.dll'
9:53:05 AM.521: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceSampling={4a7c006c-be98-4f36-9e83-a9536c4f3148}
9:53:05 AM.521: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceTracing={78d7003b-d2ee-4c74-991a-d4fa8626ebfc}
9:53:05 AM.521: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceTracingInject={7122880f-d2b9-4e76-8234-530174452844}
9:53:05 AM.521: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestPerformanceSampling={6d257aaa-b619-459f-b5d7-98ff3b473968}
9:53:05 AM.521: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestPerformance={8be60fd2-1a80-4cbf-9633-973ef542de11}
9:53:05 AM.521: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseMemory={07f7318e-2939-46b4-9c76-9998a078110e}
9:53:05 AM.521: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestMemory={ac7b786b-2d9f-4937-8984-cacdeba078fe}
9:53:05 AM.521: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseCoverage={762a40a9-7a75-4662-96fa-4dc67a8f77c4}
9:53:05 AM.521: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestCoverage={84173644-4aee-4ffc-83fc-141dbc5510ce}
9:53:05 AM.521: Thread:23: Starting console app: "C:\Windows\SysWOW64\RegSvr32.exe" /s /u "C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x86.dll"
9:53:05 AM.538: Thread:23: Console app exited with code [0]: "C:\Windows\SysWOW64\RegSvr32.exe" /s /u "C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x86.dll"
9:53:05 AM.538: Thread:23: [RegisterCore] op=Uninstall instructionSet=x64 path='C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x64.dll'
9:53:05 AM.538: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceSampling={4a7c006c-be98-4f36-9e83-a9536c4f3148}
9:53:05 AM.538: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceTracing={78d7003b-d2ee-4c74-991a-d4fa8626ebfc}
9:53:05 AM.538: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleasePerformanceTracingInject={7122880f-d2b9-4e76-8234-530174452844}
9:53:05 AM.538: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestPerformanceSampling={6d257aaa-b619-459f-b5d7-98ff3b473968}
9:53:05 AM.538: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestPerformance={8be60fd2-1a80-4cbf-9633-973ef542de11}
9:53:05 AM.538: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseMemory={07f7318e-2939-46b4-9c76-9998a078110e}
9:53:05 AM.538: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestMemory={ac7b786b-2d9f-4937-8984-cacdeba078fe}
9:53:05 AM.538: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseCoverage={762a40a9-7a75-4662-96fa-4dc67a8f77c4}
9:53:05 AM.538: Thread:23: [RegisterCore] JETBRAINS_PROFILER_CORE_TYPE_ReleaseTestCoverage={84173644-4aee-4ffc-83fc-141dbc5510ce}
9:53:05 AM.539: Thread:23: Starting console app: "C:\Windows\system32\RegSvr32.exe" /s /u "C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x64.dll"
9:53:05 AM.549: Thread:23: Console app exited with code [0]: "C:\Windows\system32\RegSvr32.exe" /s /u "C:\Program Files (x86)\JetBrains\dotCover\v2.5\Bin\JetBrains.Profiler.Core.Win.x64.dll"
9:53:05 AM.553: Thread:23: [PdbServer] TerminateRequestSent pid=4848
9:53:05 AM.598: Thread:23: [PdbServer] Exited pid=4848 exitCode=0
9:53:05 AM.615: Thread:23: [CoverageSession#0] Executing 'finish' callback (configuration id: '')
9:53:05 AM.618: Thread:23: [CoverageSession#0] Executing 'finish' callback after session lifetime termination (configuration id: '')
9:53:05 AM.618: Thread:23: [CoverageSession#0] Setting SessionFinishedEvent
9:53:05 AM.618: Thread:1: [CoverageSession#0] SessionFinishedEvent was received
9:53:05 AM.619: Thread:1: Coverage session finished [10/11/2013 9:53:05 AM]
9:53:05 AM.619: Thread:1: Index Files = C:\Users\Administrator\AppData\Local\Temp\1\ssc05D86.tmp, C:\Users\Administrator\AppData\Local\Temp\1\ssc00FFA.tmp
9:53:05 AM.620: Thread:1: Aborted = False
9:53:05 AM.620: Thread:1: Exit Code = 0
9:53:05 AM.621: Thread:1: Coverage results post-processing started [10/11/2013 9:53:05 AM]
9:53:05 AM.630: Thread:1: Merging snapshots 1-2
9:53:06 AM.087: Thread:1: Coverage results post-processing finished [10/11/2013 9:53:06 AM]
9:53:06 AM.103: Thread:7: process [4848] 'JetBrains.Profiler.CorePdbServer.x64' has exited with code 0
9:53:06 AM.116: Thread:1: Report generation started [10/11/2013 9:53:06 AM]
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000004 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000005 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000004 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000005 from
9:53:06 AM.192: Thread:1: Could not load referenced assembly 23000006 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000004 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000005 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000006 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000007 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000008 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000009 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 2300000A from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 2300000B from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 2300000C from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 2300000D from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 2300000E from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000004 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000005 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000006 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000007 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000009 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000004 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000005 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000006 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000007 from
9:53:06 AM.193: Thread:1: Could not load referenced assembly 23000009 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 2300000A from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 2300000B from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 2300000C from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000004 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000005 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000006 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000004 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000005 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000005 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.194: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.344: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.346: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.352: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.354: Thread:1: Could not load referenced assembly 23000003 from
9:53:06 AM.355: Thread:1: Could not load referenced assembly 23000002 from
9:53:06 AM.356: Thread:1: Could not load referenced assembly 23000005 from
9:53:06 AM.372: Thread:1: Could not load referenced assembly 23000001 from
9:53:06 AM.553: Thread:1: Report generation finished [10/11/2013 9:53:06 AM]
9:53:06 AM.557: Thread:1: Obtaining list of snapshot files for index file 'C:\Users\Administrator\AppData\Local\Temp\1\tmpB6C3.tmp'
9:53:06 AM.557: Thread:1: Resulting file list: C:\Users\Administrator\AppData\Local\Temp\1\tmpB6C3.tmp
9:53:06 AM.558: Thread:1: [JetEnvironment] IApplicationDescriptor::JetEnvironment::Products-- 1v0: JetBrains.dotCover.ShellBase.DotCoverApplicationDescriptorLite.
9:53:06 AM.573: Thread:1: [RunningProducts] KeyValuePair`2::RunsProducts::ProductContainersComposed-- 1v0: “[JetBrains.dotCover.ShellBase.DotCoverApplicationDescriptorLite, 'Product(dotCover)' (JetBrains.Application.Components.CatalogueComponentContainer`1[JetBrains.Application.ShellComponentAttribute])]”.
9:53:06 AM.636: Thread:1: [UserActivityMonitor] Boolean::HaveSwitchAndActiveDeferred: False -> <N/A>.
9:53:06 AM.636: Thread:1: [UserActivityMonitor] Boolean::(HavePendingSwitch,IsApplicationActive).And: False -> <N/A>.
9:53:06 AM.638: Thread:1: [UserActivityMonitor] Boolean::HavePendingSwitch: False -> <N/A>.
9:53:06 AM.665: Thread:1: [MW] OnWmActivate Detached.
9:53:06 AM.682: Thread:1: dotCover 2.5 Version=2.5.574.60, Built=2013-09-05T06:55:00, Configuration=“ConsoleRunnerApplication Full PublicMode”
9:53:06 AM.732: Thread:1: [RunningProducts] KeyValuePair`2::RunsProducts::ProductContainersNonComposed-- 1v0: “[JetBrains.dotCover.ShellBase.DotCoverApplicationDescriptorLite, 'Product(dotCover)' (JetBrains.Application.Components.CatalogueComponentContainer`1[JetBrains.Application.ShellComponentAttribute])]”.
9:53:06 AM.733: Thread:1: [RunsProducts] IApplicationDescriptor::RunsProducts::ProductsToRun-- 1v0: JetBrains.dotCover.ShellBase.DotCoverApplicationDescriptorLite.
9:53:06 AM.736: Thread:1: [ReportsProductsAllowedToRun] IProductCanBeStarted::JetEnvironment::IProductCanBeStarted[]-- v: JetBrains.Application.Env.Components.SuspendResumeProductCanBeStarted (ACK).
9:53:06 AM.736: Thread:1: [ReportsProductsAllowedToRun] IProductCanBeStarted::JetEnvironment::IProductCanBeStarted[]-- v: JetBrains.UI.License.UITimeBombComponent (ACK).
9:53:06 AM.736: Thread:1: [ReportsProductsAllowedToRun] IProductCanBeStarted::JetEnvironment::IProductCanBeStarted[]-- v: JetBrains.dotCover.Infrastructure.Environment.Model.LiberalLicenseCheckComponent (ACK).

0

Hi Sara,

There are multiple records in your log file like this:

9:53:04 AM.048: Thread:21: 000010E0 1 113A0020 PDBB::LoadModule mvid={3A9CF6A0-74BA-49C7-8A5D-C686ED9C72DD} name='C:\Program Files\Terumo BCT\Reveos System Manager\Services\RSM Cadence Service\TestResults\Administrator_USBSRDRSMWEB3 2013-10-11 09_52_56\Out\BCT.RSM.Services.Cadence.IntegrationTests.dll'
9:53:04 AM.048: Thread:21: 000010E0 1 113A0020 PDBB::LoadModule cmd=LoadModule id=1 size=210
9:53:04 AM.048: Thread:21: 00000500 1 00000000 PDBB::DoWorkThread awr=LoadModule id=1 size=9 pdbmid=0

pdbmid=0 shows that dotCover couldn't find a PDB file for a corresponding dll. Could you please check that these PDB-s were in the same folders as test dll-s?

0

Please sign in to leave a comment.