MTM can't auto install test agents on lab machines

Category: visual studio mtm

Question

JackHoran896 on Wed, 07 May 2014 19:10:43


Hello,

Let me first start off by giving a brief description of our lab management setup.  We are running TFS 2013 and have configured an SCVMM environment for lab manager.  We have 2 hyper-v hosts (non-clustered) and 1 VMM server for that environment.  

The VMs that are spun up from Lab Center in this environment are placed into an isolated virtual network in scvmm separate from our corporate network (this was a decision made early on due to security concerns).  So this means that we can't connect directly to any of the potential lab machines as a result as they are technically on a different network.  As a result in order to allow some communication between some of our other TFS servers/clients we placed a test controller on the virtual network with 2 NICs, one on the corp. network and one on the virtual network so that the test controller can communicate with both networks.

Something we have discovered however is that when creating a new environment from a template in Lab Center we are unable to get the test agents to be automatically installed on the machines in the environment.  The environments always complete and show as "Not Ready."  When we try to reconfigure the environment we fail at the verification step "Verify that the machines are accessible using the user name and password provided."  We have configured local shadow accounts on the test controller and the VM templates that are being used that have the same user name and password.  We input them in Lab Center as .\{username}, so I don't think the login credentials are the culprit here.

The interesting thing here is we created a VM in SCVMM with 2 NICs similar to the test controller mentioned above and we installed MTM on it.  From this machine we are able to create environments successfully (in a ready state).  And the verification step that fails above passes successfully.  If we disable the NIC that is on the virtual network we get the same results as above.  So this leads me to believe there this has something to do with there being 2 NICs on the test controller or something along those lines.

Any thoughts?

Replies

Starian chen on Thu, 08 May 2014 07:58:44


Hi JackHoran896,

According to your description, I would like to know the details:

  1. As you said that after you create a new lab environment, it shows as Not Ready. Did you check whether the test agent was installed in the VM or not. (Check the installed program)
  2. If you install the test agent manually without configure it, then create a new lab environment, what’s the result of that?

On the other hand, you may could enable tracing for MTM and check the result.

# How To: Enable Tracing for MTM

http://blogs.msdn.com/b/gautamg/archive/2011/01/20/how-to-enable-tracing-for-mtm.aspx

Thanks

Best Regards

JackHoran896 on Thu, 08 May 2014 15:40:57


Hi Starain,

Thanks for the reply, so the test agent has been installed on the templates that I am using so it should already be there on every environment.  Once the environment is created and "Not Ready" I can connect to the machines and configure manually, but this is not ideal.  Also I think it is worth noting that the agent has been registered with the controller already when I go to configure it manually.

I ran it with the logging on both from the machine with the 2 NICs where is it working and the machine with the one NIC that it fails on.

Here is the log for the working:

V, 4012, 6, 2014/05/08, 10:24:09.499, <machine name>\mtm.exe, Step: -1, TestManagement: Begin web service call to FindController with id 35
Web method running: [http://<TFS URL>/TestManagement/v2.0/TestManagementWebService.asmx] FindController[TestManagement]
Web method response: [http://<TFS URL>/TestManagement/v2.0/TestManagementWebService.asmx] FindController[TestManagement] 74 ms
V, 4012, 6, 2014/05/08, 10:24:09.574, <machine name>\mtm.exe, Step: -1, TestManagement: End web service call to FindController with id 35
V, 4012, 6, 2014/05/08, 10:24:09.903, <machine name>\mtm.exe, TcpClientServerChannelContainer.FixMachineNameProperty: machine has more than one NIC; using machine name in the .NET Remoting configuration
V, 4012, 6, 2014/05/08, 10:24:09.918, <machine name>\mtm.exe, TcpClientServerChannelContainer.FixMachineNameProperty: Using machineName in channel properties as <machine name>
V, 4012, 6, 2014/05/08, 10:24:09.918, <machine name>\mtm.exe, TcpClientServerChannelContainer: creating TcpChannel 'Controller235dfad0-1568-4702-b9d1-d7318ea3ca1d_TcpChannel' listening on port 0
V, 4012, 6, 2014/05/08, 10:24:10.044, <machine name>\mtm.exe, TcpClientServerChannelContainer: creating a TcpServerChannel 'Controller235dfad0-1568-4702-b9d1-d7318ea3ca1d_TcpServerChannel_IPv6' listening to all IPv6 addresses on port 36308.
I, 4012, 6, 2014/05/08, 10:24:10.046, <machine name>\mtm.exe, TcpClientServerChannelContainer: TcpChannel 'Controller235dfad0-1568-4702-b9d1-d7318ea3ca1d_TcpChannel' is registered and listening on URI 'tcp://<machine name>:36308/'.
I, 4012, 6, 2014/05/08, 10:24:10.046, <machine name>\mtm.exe, TcpClientServerChannelContainer: TcpServerChannel 'Controller235dfad0-1568-4702-b9d1-d7318ea3ca1d_TcpServerChannel_IPv6' is registered and listening on URI 'tcp://<machine name>:36308/'.
I, 4012, 6, 2014/05/08, 10:24:10.050, <machine name>\mtm.exe, ExecutionUtilits.UpdateRemotingCredentials Invoked
I, 4012, 6, 2014/05/08, 10:24:10.105, <machine name>\mtm.exe, ExecutionUtilits.UpdateRemotingCredentials : Domain USNBKA412P User tfslabservice
I, 4012, 6, 2014/05/08, 10:24:14.855, <machine name>\mtm.exe, Internal Connect : controllerVersion 12.0
I, 4012, 6, 2014/05/08, 10:24:14.876, <machine name>\mtm.exe, ExecutionUtilits.UpdateRemotingCredentials Invoked
I, 4012, 6, 2014/05/08, 10:24:14.877, <machine name>\mtm.exe, ExecutionUtilits.UpdateRemotingCredentials : Domain USNBKA412P User tfslabservice
V, 4012, 6, 2014/05/08, 10:24:21.611, <machine name>\mtm.exe, Step: -1, LabManagement: Begin web service call to ValidateLabEnvironmentUpdatePack with id 36
Web method running: [http://<TFS URL>/Lab/v4.0/LabService.asmx] ValidateLabEnvironmentUpdatePack[Lab]
Web method response: [http://<TFS URL>/Lab/v4.0/LabService.asmx] ValidateLabEnvironmentUpdatePack[Lab] 44 ms
V, 4012, 6, 2014/05/08, 10:24:21.656, <machine name>\mtm.exe, Step: -1, LabManagement: End web service call to ValidateLabEnvironmentUpdatePack with id 36
V, 4012, 6, 2014/05/08, 10:24:22.657, <machine name>\mtm.exe, Step: -1, LabManagement: Begin web service call to GetLabOperation with id 37
Web method running: [http://<TFS URL>/Lab/v4.0/LabService.asmx] GetLabOperation[Lab]
Web method response: [http://<TFS URL>/Lab/v4.0/LabService.asmx] GetLabOperation[Lab] 63 ms
V, 4012, 6, 2014/05/08, 10:24:22.722, <machine name>\mtm.exe, Step: -1, LabManagement: End web service call to GetLabOperation with id 37
V, 4012, 11, 2014/05/08, 10:24:26.648, <machine name>\mtm.exe, Step: 0, AttachmentUpload: Read
V, 4012, 11, 2014/05/08, 10:24:26.649, <machine name>\mtm.exe, Step: 0, AttachmentUpload: ReadFileWithRecovery
V, 4012, 11, 2014/05/08, 10:24:26.649, <machine name>\mtm.exe, Step: 0, AttachmentUpload: Cannot read primary file because of System.IO.FileNotFoundException: Could not find file '<Install Path>\AppData\Local\Microsoft\Team Foundation\4.0\TestManagement\d43ac0c1-d08f-40a8-a147-36fabbc08da2_Aum.xml'.
File name: '<Install Path>\AppData\Local\Microsoft\Team Foundation\4.0\TestManagement\d43ac0c1-d08f-40a8-a147-36fabbc08da2_Aum.xml'
   at System.IO.__Error.WinIOError(Int32 errorCode, String maybeFullPath)
   at System.IO.FileStream.Init(String path, FileMode mode, FileAccess access, Int32 rights, Boolean useRights, FileShare share, Int32 bufferSize, FileOptions options, SECURITY_ATTRIBUTES secAttrs, String msgPath, Boolean bFromProxy, Boolean useLongPath, Boolean checkHost)
   at System.IO.FileStream..ctor(String path, FileMode mode, FileAccess access, FileShare share)
   at System.IO.File.OpenRead(String path)
   at Microsoft.TeamFoundation.TestManagement.Client.AttachmentUploadManager.ReadFile(Boolean useBackup)
   at Microsoft.TeamFoundation.TestManagement.Client.AttachmentUploadManager.ReadFileWithRecovery()
V, 4012, 11, 2014/05/08, 10:24:26.650, <machine name>\mtm.exe, Step: 0, AttachmentUpload: Cannot read backup file because of System.IO.FileNotFoundException: Could not find file '<Install Path>\AppData\Local\Microsoft\Team Foundation\4.0\TestManagement\d43ac0c1-d08f-40a8-a147-36fabbc08da2_Aum.xml.bak'.
File name: '<Install Path>\AppData\Local\Microsoft\Team Foundation\4.0\TestManagement\d43ac0c1-d08f-40a8-a147-36fabbc08da2_Aum.xml.bak'
   at System.IO.__Error.WinIOError(Int32 errorCode, String maybeFullPath)
   at System.IO.FileStream.Init(String path, FileMode mode, FileAccess access, Int32 rights, Boolean useRights, FileShare share, Int32 bufferSize, FileOptions options, SECURITY_ATTRIBUTES secAttrs, String msgPath, Boolean bFromProxy, Boolean useLongPath, Boolean checkHost)
   at System.IO.FileStream..ctor(String path, FileMode mode, FileAccess access, FileShare share)
   at System.IO.File.OpenRead(String path)
   at Microsoft.TeamFoundation.TestManagement.Client.AttachmentUploadManager.ReadFile(Boolean useBackup)
   at Microsoft.TeamFoundation.TestManagement.Client.AttachmentUploadManager.ReadFileWithRecovery(), will clear list
V, 4012, 11, 2014/05/08, 10:24:26.650, <machine name>\mtm.exe, Step: 0, AttachmentUpload: EntryLock for Clear in thread
V, 4012, 11, 2014/05/08, 10:24:26.650, <machine name>\mtm.exe, Step: 0, AttachmentUpload: Dispatcher checking for new work
V, 4012, 11, 2014/05/08, 10:24:26.650, <machine name>\mtm.exe, Step: 0, AttachmentUpload: EntryLock for FindNewEntryToProcess
V, 4012, 11, 2014/05/08, 10:24:26.651, <machine name>\mtm.exe, Step: 0, AttachmentUpload: EntryLock for FindZombieUpload

Here is the failure:

V, 2980, 13, 2014/05/08, 10:26:29.424, <computer name>\mtm.exe, Step: -1, TestManagement: Begin web service call to FindController with id 131
Web method running: [http://<TFS URL>/TestManagement/v2.0/TestManagementWebService.asmx] FindController[TestManagement]
Web method response: [http://<TFS URL>/TestManagement/v2.0/TestManagementWebService.asmx] FindController[TestManagement] 23 ms
V, 2980, 13, 2014/05/08, 10:26:29.448, <computer name>\mtm.exe, Step: -1, TestManagement: End web service call to FindController with id 131
V, 2980, 8, 2014/05/08, 10:26:43.936, <computer name>\mtm.exe, Step: 0, AttachmentUpload: Read
V, 2980, 8, 2014/05/08, 10:26:43.936, <computer name>\mtm.exe, Step: 0, AttachmentUpload: ReadFileWithRecovery
V, 2980, 8, 2014/05/08, 10:26:43.936, <computer name>\mtm.exe, Step: 0, AttachmentUpload: Read successful, version now: 375
V, 2980, 8, 2014/05/08, 10:26:43.937, <computer name>\mtm.exe, Step: 0, AttachmentUpload: Dispatcher checking for new work
V, 2980, 8, 2014/05/08, 10:26:43.937, <computer name>\mtm.exe, Step: 0, AttachmentUpload: EntryLock for FindNewEntryToProcess
V, 2980, 8, 2014/05/08, 10:26:43.937, <computer name>\mtm.exe, Step: 0, AttachmentUpload: EntryLock for FindZombieUpload

and here is the controller log for the failure:

V, 1212, 4, 2014/05/08, 10:26:30.391, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/529 of environment [ReadyNotReady] trying to connect.
V, 1212, 4, 2014/05/08, 10:26:30.391, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/529
V, 1212, 4, 2014/05/08, 10:26:30.391, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
V, 1212, 4, 2014/05/08, 10:26:31.701, <controller server name>\QTController.exe, ControllerObject: Hello
V, 1212, 4, 2014/05/08, 10:26:32.189, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/502 of environment [TestMachine] trying to connect.
V, 1212, 4, 2014/05/08, 10:26:32.189, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/502
V, 1212, 4, 2014/05/08, 10:26:34.522, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/486 of environment [Brad Win7 Client] trying to connect.
V, 1212, 4, 2014/05/08, 10:26:34.522, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/486
V, 1212, 4, 2014/05/08, 10:26:34.522, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, ControllerObject:: Getting TestEnvironments
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:26:38.072, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
I, 1212, 5, 2014/05/08, 10:26:38.087, <controller server name>\QTController.exe, ControllerObject.SynchronizeWithTfs: Starting sync
V, 1212, 16, 2014/05/08, 10:26:38.103, <controller server name>\QTController.exe, RunMonitor: Executing query SELECT * FROM TestRun WHERE (State = 'InProgress' OR  State = 'Waiting') AND IsAutomated = 1 AND TestEnvironmentId IN ('35e6a54a-c094-4f3e-95c7-c2cab7851b8a','92bbb595-cf10-4be0-98fc-111cb97af0fa','4784d808-d4b8-44b3-abee-6ca2bce97962','7df75a46-8464-4425-890d-7a269b45fd82','0ee990d5-a384-4a77-8272-bcedc89a74eb') ORDER BY CreationDate
I, 1212, 5, 2014/05/08, 10:26:38.103, <controller server name>\QTController.exe, TestManagementServiceHelper.UpdateControllerProperties: Updating controller '<controller server name> (<controller server name>:6901)' on TFS 'http://<project colletion URL>'
I, 1212, 5, 2014/05/08, 10:26:39.010, <controller server name>\QTController.exe, Network service name NT AUTHORITY\NETWORK SERVICE
V, 1212, 4, 2014/05/08, 10:26:39.676, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/477 of environment [Brad-Webserver] trying to connect.
V, 1212, 4, 2014/05/08, 10:26:39.676, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/477
V, 1212, 4, 2014/05/08, 10:26:39.676, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
I, 1212, 5, 2014/05/08, 10:26:39.854, <controller server name>\QTController.exe, ControllerConfiguration : ConfigureLabSystem : User NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:39.854, <controller server name>\QTController.exe, Creating user NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
V, 1212, 5, 2014/05/08, 10:26:39.854, <controller server name>\QTController.exe, Created Nt account NT AUTHORITY\NETWORK SERVICE for userName NT AUTHORITY\NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:39.854, <controller server name>\QTController.exe, Found Sid S-1-5-20 for userName NT AUTHORITY\NETWORK SERVICE
E, 1212, 5, 2014/05/08, 10:26:40.707, <controller server name>\QTController.exe, Error during DsBind operation: 1355
I, 1212, 5, 2014/05/08, 10:26:40.707, <controller server name>\QTController.exe, Using machine$ account NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
I, 1212, 5, 2014/05/08, 10:26:40.707, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:40.707, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:40.707, <controller server name>\QTController.exe, Getting user NT AUTHORITY/NETWORK SERVICE entry with domain NT AUTHORITY which is null /? False
I, 1212, 5, 2014/05/08, 10:26:40.707, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:40.707, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:40.707, <controller server name>\QTController.exe, Adding user WinNT://NT AUTHORITY/NETWORK SERVICE,user to group TeamTestAgentService on controller.
V, 1212, 5, 2014/05/08, 10:26:40.707, <controller server name>\QTController.exe, User WinNT://NT AUTHORITY/NETWORK SERVICE,user existed in group System.DirectoryServices.DirectoryEntry
I, 1212, 5, 2014/05/08, 10:26:41.543, <controller server name>\QTController.exe, Network service name NT AUTHORITY\NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:42.381, <controller server name>\QTController.exe, ControllerConfiguration : ConfigureLabSystem : User NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:42.381, <controller server name>\QTController.exe, Creating user NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
V, 1212, 5, 2014/05/08, 10:26:42.381, <controller server name>\QTController.exe, Created Nt account NT AUTHORITY\NETWORK SERVICE for userName NT AUTHORITY\NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:42.381, <controller server name>\QTController.exe, Found Sid S-1-5-20 for userName NT AUTHORITY\NETWORK SERVICE
E, 1212, 5, 2014/05/08, 10:26:43.220, <controller server name>\QTController.exe, Error during DsBind operation: 1355
I, 1212, 5, 2014/05/08, 10:26:43.220, <controller server name>\QTController.exe, Using machine$ account NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
I, 1212, 5, 2014/05/08, 10:26:43.220, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:43.220, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:43.220, <controller server name>\QTController.exe, Getting user NT AUTHORITY/NETWORK SERVICE entry with domain NT AUTHORITY which is null /? False
I, 1212, 5, 2014/05/08, 10:26:43.220, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:43.220, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:43.220, <controller server name>\QTController.exe, Adding user WinNT://NT AUTHORITY/NETWORK SERVICE,user to group TeamTestAgentService on controller.
V, 1212, 5, 2014/05/08, 10:26:43.220, <controller server name>\QTController.exe, User WinNT://NT AUTHORITY/NETWORK SERVICE,user existed in group System.DirectoryServices.DirectoryEntry
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, ControllerObject:: Getting TestEnvironments
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:26:43.802, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
I, 1212, 5, 2014/05/08, 10:26:44.090, <controller server name>\QTController.exe, Network service name NT AUTHORITY\NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:44.940, <controller server name>\QTController.exe, ControllerConfiguration : ConfigureLabSystem : User NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:44.940, <controller server name>\QTController.exe, Creating user NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
V, 1212, 5, 2014/05/08, 10:26:44.940, <controller server name>\QTController.exe, Created Nt account NT AUTHORITY\NETWORK SERVICE for userName NT AUTHORITY\NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:44.940, <controller server name>\QTController.exe, Found Sid S-1-5-20 for userName NT AUTHORITY\NETWORK SERVICE
E, 1212, 5, 2014/05/08, 10:26:45.789, <controller server name>\QTController.exe, Error during DsBind operation: 1355
I, 1212, 5, 2014/05/08, 10:26:45.789, <controller server name>\QTController.exe, Using machine$ account NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
I, 1212, 5, 2014/05/08, 10:26:45.789, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:45.789, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:45.789, <controller server name>\QTController.exe, Getting user NT AUTHORITY/NETWORK SERVICE entry with domain NT AUTHORITY which is null /? False
I, 1212, 5, 2014/05/08, 10:26:45.789, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:45.789, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:45.789, <controller server name>\QTController.exe, Adding user WinNT://NT AUTHORITY/NETWORK SERVICE,user to group TeamTestAgentService on controller.
V, 1212, 5, 2014/05/08, 10:26:45.789, <controller server name>\QTController.exe, User WinNT://NT AUTHORITY/NETWORK SERVICE,user existed in group System.DirectoryServices.DirectoryEntry
I, 1212, 5, 2014/05/08, 10:26:46.618, <controller server name>\QTController.exe, Network service name NT AUTHORITY\NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:47.449, <controller server name>\QTController.exe, ControllerConfiguration : ConfigureLabSystem : User NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:47.449, <controller server name>\QTController.exe, Creating user NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
V, 1212, 5, 2014/05/08, 10:26:47.449, <controller server name>\QTController.exe, Created Nt account NT AUTHORITY\NETWORK SERVICE for userName NT AUTHORITY\NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:47.449, <controller server name>\QTController.exe, Found Sid S-1-5-20 for userName NT AUTHORITY\NETWORK SERVICE
E, 1212, 5, 2014/05/08, 10:26:48.277, <controller server name>\QTController.exe, Error during DsBind operation: 1355
I, 1212, 5, 2014/05/08, 10:26:48.277, <controller server name>\QTController.exe, Using machine$ account NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
I, 1212, 5, 2014/05/08, 10:26:48.277, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:48.277, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:48.277, <controller server name>\QTController.exe, Getting user NT AUTHORITY/NETWORK SERVICE entry with domain NT AUTHORITY which is null /? False
I, 1212, 5, 2014/05/08, 10:26:48.277, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:48.277, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:48.277, <controller server name>\QTController.exe, Adding user WinNT://NT AUTHORITY/NETWORK SERVICE,user to group TeamTestAgentService on controller.
V, 1212, 5, 2014/05/08, 10:26:48.277, <controller server name>\QTController.exe, User WinNT://NT AUTHORITY/NETWORK SERVICE,user existed in group System.DirectoryServices.DirectoryEntry
I, 1212, 5, 2014/05/08, 10:26:49.119, <controller server name>\QTController.exe, Network service name NT AUTHORITY\NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:49.957, <controller server name>\QTController.exe, ControllerConfiguration : ConfigureLabSystem : User NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:49.957, <controller server name>\QTController.exe, Creating user NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
V, 1212, 5, 2014/05/08, 10:26:49.957, <controller server name>\QTController.exe, Created Nt account NT AUTHORITY\NETWORK SERVICE for userName NT AUTHORITY\NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:49.957, <controller server name>\QTController.exe, Found Sid S-1-5-20 for userName NT AUTHORITY\NETWORK SERVICE
E, 1212, 5, 2014/05/08, 10:26:50.801, <controller server name>\QTController.exe, Error during DsBind operation: 1355
I, 1212, 5, 2014/05/08, 10:26:50.801, <controller server name>\QTController.exe, Using machine$ account NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
I, 1212, 5, 2014/05/08, 10:26:50.801, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:50.801, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:50.801, <controller server name>\QTController.exe, Getting user NT AUTHORITY/NETWORK SERVICE entry with domain NT AUTHORITY which is null /? False
I, 1212, 5, 2014/05/08, 10:26:50.801, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:50.801, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:50.801, <controller server name>\QTController.exe, Adding user WinNT://NT AUTHORITY/NETWORK SERVICE,user to group TeamTestAgentService on controller.
V, 1212, 5, 2014/05/08, 10:26:50.801, <controller server name>\QTController.exe, User WinNT://NT AUTHORITY/NETWORK SERVICE,user existed in group System.DirectoryServices.DirectoryEntry
V, 1212, 4, 2014/05/08, 10:26:51.556, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/505 of environment [Updated WinServer2012] trying to connect.
V, 1212, 4, 2014/05/08, 10:26:51.556, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/505
V, 1212, 4, 2014/05/08, 10:26:51.556, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
I, 1212, 5, 2014/05/08, 10:26:51.634, <controller server name>\QTController.exe, Network service name NT AUTHORITY\NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:52.474, <controller server name>\QTController.exe, ControllerConfiguration : ConfigureLabSystem : User NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:52.474, <controller server name>\QTController.exe, Creating user NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
V, 1212, 5, 2014/05/08, 10:26:52.474, <controller server name>\QTController.exe, Created Nt account NT AUTHORITY\NETWORK SERVICE for userName NT AUTHORITY\NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:52.474, <controller server name>\QTController.exe, Found Sid S-1-5-20 for userName NT AUTHORITY\NETWORK SERVICE
E, 1212, 5, 2014/05/08, 10:26:53.318, <controller server name>\QTController.exe, Error during DsBind operation: 1355
I, 1212, 5, 2014/05/08, 10:26:53.318, <controller server name>\QTController.exe, Using machine$ account NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
I, 1212, 5, 2014/05/08, 10:26:53.318, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:53.318, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:53.318, <controller server name>\QTController.exe, Getting user NT AUTHORITY/NETWORK SERVICE entry with domain NT AUTHORITY which is null /? False
I, 1212, 5, 2014/05/08, 10:26:53.318, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:53.318, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:53.318, <controller server name>\QTController.exe, Adding user WinNT://NT AUTHORITY/NETWORK SERVICE,user to group TeamTestAgentService on controller.
V, 1212, 5, 2014/05/08, 10:26:53.318, <controller server name>\QTController.exe, User WinNT://NT AUTHORITY/NETWORK SERVICE,user existed in group System.DirectoryServices.DirectoryEntry
I, 1212, 5, 2014/05/08, 10:26:54.152, <controller server name>\QTController.exe, Network service name NT AUTHORITY\NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:54.991, <controller server name>\QTController.exe, ControllerConfiguration : ConfigureLabSystem : User NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:54.991, <controller server name>\QTController.exe, Creating user NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
V, 1212, 5, 2014/05/08, 10:26:54.991, <controller server name>\QTController.exe, Created Nt account NT AUTHORITY\NETWORK SERVICE for userName NT AUTHORITY\NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:54.991, <controller server name>\QTController.exe, Found Sid S-1-5-20 for userName NT AUTHORITY\NETWORK SERVICE
E, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, Error during DsBind operation: 1355
I, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, Using machine$ account NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
I, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, Getting user NT AUTHORITY/NETWORK SERVICE entry with domain NT AUTHORITY which is null /? False
I, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, Adding user WinNT://NT AUTHORITY/NETWORK SERVICE,user to group TeamTestAgentService on controller.
V, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, User WinNT://NT AUTHORITY/NETWORK SERVICE,user existed in group System.DirectoryServices.DirectoryEntry
I, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, Process Name and path: D:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\IDE\QTController.exe
I, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, Process Name and path: D:\Program Files (x86)\Microsoft Visual Studio 12.0\Common7\IDE\QTController.exe
V, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, UpdateMaxTestAgentVersionOnTFs: updating max test agent version on tfs to 12.0.21005
I, 1212, 5, 2014/05/08, 10:26:55.829, <controller server name>\QTController.exe, TestManagementServiceHelper.UpdateControllerProperties: Updating controller '<controller server name> (<controller server name>:6901)' on TFS 'http://<project colletion URL>'
I, 1212, 5, 2014/05/08, 10:26:55.845, <controller server name>\QTController.exe, ControllerObject.SynchronizeWithTfs: Finished sync
V, 1212, 4, 2014/05/08, 10:27:00.407, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/529 of environment [ReadyNotReady] trying to connect.
V, 1212, 4, 2014/05/08, 10:27:00.407, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/529
V, 1212, 4, 2014/05/08, 10:27:00.407, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
V, 1212, 4, 2014/05/08, 10:27:02.209, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/502 of environment [TestMachine] trying to connect.
V, 1212, 4, 2014/05/08, 10:27:02.209, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/502
V, 1212, 4, 2014/05/08, 10:27:05.569, <controller server name>\QTController.exe, Agent : <controller server name>\TFSLabService
V, 1212, 4, 2014/05/08, 10:27:05.569, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/486 of environment [Brad Win7 Client] trying to connect.
V, 1212, 4, 2014/05/08, 10:27:05.569, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is in group TeamTestAgentService.
I, 1212, 4, 2014/05/08, 10:27:05.569, <controller server name>\QTController.exe, A user has successfully authenticated to obtain the ControllerObject.
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, ControllerObject:: Getting TestEnvironments
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:08.082, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:08.191, <controller server name>\QTController.exe, RunMonitor: Executing query SELECT * FROM TestRun WHERE (State = 'InProgress' OR  State = 'Waiting') AND IsAutomated = 1 AND TestEnvironmentId IN ('35e6a54a-c094-4f3e-95c7-c2cab7851b8a','92bbb595-cf10-4be0-98fc-111cb97af0fa','4784d808-d4b8-44b3-abee-6ca2bce97962','7df75a46-8464-4425-890d-7a269b45fd82','0ee990d5-a384-4a77-8272-bcedc89a74eb') ORDER BY CreationDate
V, 1212, 4, 2014/05/08, 10:27:09.685, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/477 of environment [Brad-Webserver] trying to connect.
V, 1212, 4, 2014/05/08, 10:27:09.685, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/477
V, 1212, 4, 2014/05/08, 10:27:09.685, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, ControllerObject:: Getting TestEnvironments
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 14, 2014/05/08, 10:27:13.865, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 4, 2014/05/08, 10:27:21.561, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/505 of environment [Updated WinServer2012] trying to connect.
V, 1212, 4, 2014/05/08, 10:27:21.561, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/505
V, 1212, 4, 2014/05/08, 10:27:21.561, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
V, 1212, 4, 2014/05/08, 10:27:26.595, <controller server name>\QTController.exe, ControllerObject.ConnectAgent: Agent: vstfs:///LabManagement/TestMachine/486 from machine: YPN5F25VM1J6BR2 trying to connect.
V, 1212, 4, 2014/05/08, 10:27:26.595, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/486 of environment [Brad Win7 Client] trying to connect.
V, 1212, 4, 2014/05/08, 10:27:26.595, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is in group TeamTestAgentService.
I, 1212, 4, 2014/05/08, 10:27:26.595, <controller server name>\QTController.exe, AgentDomainTrusted : Controller Domain  Agent Domain 
V, 1212, 9, 2014/05/08, 10:27:27.423, <controller server name>\QTController.exe, Successfully verified connection for agent vstfs:///LabManagement/TestMachine/486
I, 1212, 4, 2014/05/08, 10:27:27.423, <controller server name>\QTController.exe, AgentManager: Agent 'vstfs:///LabManagement/TestMachine/486' successfully connected.
V, 1212, 4, 2014/05/08, 10:27:27.423, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
V, 1212, 4, 2014/05/08, 10:27:27.423, <controller server name>\QTController.exe, ControllerObject.ConnectAgent: Agent: vstfs:///LabManagement/TestMachine/486 Returning.
V, 1212, 4, 2014/05/08, 10:27:30.414, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/529 of environment [ReadyNotReady] trying to connect.
V, 1212, 4, 2014/05/08, 10:27:30.414, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/529
V, 1212, 4, 2014/05/08, 10:27:30.414, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
V, 1212, 4, 2014/05/08, 10:27:32.231, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/502 of environment [TestMachine] trying to connect.
V, 1212, 4, 2014/05/08, 10:27:32.231, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/502
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, ControllerObject:: Getting TestEnvironments
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
V, 1212, 16, 2014/05/08, 10:27:38.092, <controller server name>\QTController.exe, User <controller server name>\TFSLabService is system, Admin, or controller user
I, 1212, 19, 2014/05/08, 10:27:38.108, <controller server name>\QTController.exe, ControllerObject.SynchronizeWithTfs: Starting sync
I, 1212, 19, 2014/05/08, 10:27:38.108, <controller server name>\QTController.exe, TestManagementServiceHelper.UpdateControllerProperties: Updating controller '<controller server name> (<controller server name>:6901)' on TFS 'http://<project colletion URL>'
V, 1212, 16, 2014/05/08, 10:27:38.123, <controller server name>\QTController.exe, RunMonitor: Executing query SELECT * FROM TestRun WHERE (State = 'InProgress' OR  State = 'Waiting') AND IsAutomated = 1 AND TestEnvironmentId IN ('35e6a54a-c094-4f3e-95c7-c2cab7851b8a','92bbb595-cf10-4be0-98fc-111cb97af0fa','4784d808-d4b8-44b3-abee-6ca2bce97962','7df75a46-8464-4425-890d-7a269b45fd82','0ee990d5-a384-4a77-8272-bcedc89a74eb') ORDER BY CreationDate
I, 1212, 19, 2014/05/08, 10:27:39.010, <controller server name>\QTController.exe, Network service name NT AUTHORITY\NETWORK SERVICE
V, 1212, 4, 2014/05/08, 10:27:39.691, <controller server name>\QTController.exe, ControllerObject.RequireAgentServiceUser: Agent: vstfs:///LabManagement/TestMachine/477 of environment [Brad-Webserver] trying to connect.
V, 1212, 4, 2014/05/08, 10:27:39.691, <controller server name>\QTController.exe, ControllerObject: AgentHello from vstfs:///LabManagement/TestMachine/477
V, 1212, 4, 2014/05/08, 10:27:39.691, <controller server name>\QTController.exe, Verifying the connection integrity for following number of objects: 5
I, 1212, 19, 2014/05/08, 10:27:39.847, <controller server name>\QTController.exe, ControllerConfiguration : ConfigureLabSystem : User NETWORK SERVICE
I, 1212, 19, 2014/05/08, 10:27:39.847, <controller server name>\QTController.exe, Creating user NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
V, 1212, 19, 2014/05/08, 10:27:39.847, <controller server name>\QTController.exe, Created Nt account NT AUTHORITY\NETWORK SERVICE for userName NT AUTHORITY\NETWORK SERVICE
V, 1212, 19, 2014/05/08, 10:27:39.847, <controller server name>\QTController.exe, Found Sid S-1-5-20 for userName NT AUTHORITY\NETWORK SERVICE
E, 1212, 19, 2014/05/08, 10:27:40.677, <controller server name>\QTController.exe, Error during DsBind operation: 1355
I, 1212, 19, 2014/05/08, 10:27:40.677, <controller server name>\QTController.exe, Using machine$ account NT AUTHORITY\NETWORK SERVICE on machine <controller server name>
I, 1212, 19, 2014/05/08, 10:27:40.677, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 19, 2014/05/08, 10:27:40.677, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 19, 2014/05/08, 10:27:40.677, <controller server name>\QTController.exe, Getting user NT AUTHORITY/NETWORK SERVICE entry with domain NT AUTHORITY which is null /? False
I, 1212, 19, 2014/05/08, 10:27:40.677, <controller server name>\QTController.exe, InitialUser : NT AUTHORITY\NETWORK SERVICE : Domain: NT AUTHORITY : Machine : <controller server name> : UserName NETWORK SERVICE
I, 1212, 19, 2014/05/08, 10:27:40.677, <controller server name>\QTController.exe, Final Domain: NT AUTHORITY.  Final username: NT AUTHORITY/NETWORK SERVICE
V, 1212, 19, 2014/05/08, 10:27:40.677, <controller server name>\QTController.exe, Adding user WinNT://NT AUTHORITY/NETWORK SERVICE,user to group TeamTestAgentService on controller.
V, 1212, 19, 2014/05/08, 10:27:40.677, <controller server name>\QTController.exe, User WinNT://NT AUTHORITY/NETWORK SERVICE,user existed in group System.DirectoryServices.DirectoryEntry
I, 1212, 19, 2014/05/08, 10:27:41.510, <controller server name>\QTController.exe, Network service name NT AUTHORITY\NETWORK SERVICE

Nothing jumps out at me in the logs as the cause of the issues.  Am I missing anything?

Thanks in advance,

-Jack

JackHoran896 on Tue, 13 May 2014 20:46:21


It is looking like maybe I need to be able to connect/communicate to the lab vm directly from the computer that I am running MTM on in order for the agent install to work, as opposed to only needing to be able to communicate with the test controller.  At least it appears this is needed for the verification step.

Can anyone confirm this to be a requirement for configuring the test agent?

JackHoran896 on Wed, 21 May 2014 20:35:46


So it would appear my above thought might hold some water.  In my hosts file I added an entry for one of the lab manager VM names to go to a box I could access from my machine, the verification step that was failing passed and then the agent configuration completed successfully.

So it looks like I have 2 choices,

to either figure out how to trick MTM into logging into a machine for everything so the credentials work and the agent can be installed (not ideal).  

(Ideal) Or figure out a way to add the credentials upon initial creation of the environment.  By default MTM appears to be using the domain account credentials I am logged in with, since the lab machines are not in our domain and exist in an isolated network in a workgroup these fail when it appears to be trying to configure the agent.  I am able to enter the correct credentials for each machine after the environment is created... Does anyone know if this is possible to do upon initial creation?