Load testing with two agents - I get the error."Results from agent '<One of my agents>' were not received in time to be included in the overall results for a sampling interval."

Question

I am execution a Load test with two remote agents.

I Increased the sampling rate (sampling interval) to 30 seconds, but am still getting the error.

I am getting the error from both the agents if i run the tests long enough...the errors seems to alternate from period to period from agent_1 and agent_2 respectively.

I did restart the controller/ agents/ etc...

Error message:

“Results from agent '<one of my agent machines>' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent”

I couldn’t find a definitive solutions by googling. There was a defect logged with Microsoft(connect) which seemed to be closed as well..

http://social.msdn.microsoft.com/Forums/en/vstswebtest/thread/dea7f4d5-a78e-47c0-8d8e-9a1d631abc69

http://social.msdn.microsoft.com/Forums/en-US/vstswebtest/thread/915bd80e-7897-4a6a-9e37-bf7130319c36

---------------------------------------------------------------------------------------------------------------------------------------------

The log from the agents did not have any relevant text.

Log information from the controller

V, 5532, 4, 2012/08/01, 10:23:08.271, ControllerName\QTController.exe, Checking if user DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService
V, 5532, 4, 2012/08/01, 10:23:08.271, ControllerName\QTController.exe, User DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService.
V, 5532, 4, 2012/08/01, 10:23:08.271, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: invoking special job checker for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 4, 2012/08/01, 10:23:08.271, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: successfully invoked special job checker for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 4, 2012/08/01, 10:23:08.271, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: isSpecial = False
V, 5532, 4, 2012/08/01, 10:23:08.271, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: Queuing job 'Type Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper: ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 4, 2012/08/01, 10:23:08.272, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver)+ExternalJob.ProcessJob: invoking job processor for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 4, 2012/08/01, 10:23:08.278, ControllerName\QTController.exe, WebLoadTestAdapter: Received message Result - Interval results from agent Agent_2_Name (Interval number: 103)
V, 5532, 49, 2012/08/01, 10:23:08.278, ControllerName\QTController.exe, WebLoadTestAdapter: Processing message Result - Interval results from agent Agent_2_Name (Interval number: 103)
V, 5532, 49, 2012/08/01, 10:23:08.278, ControllerName\QTController.exe, WebLoadTestAdapter: PerformanceCounterReporter.ReportLoad: Instance: _Agent(Agent_2_Name), Interval: 103, Load: 5
V, 5532, 4, 2012/08/01, 10:23:08.278, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver)+ExternalJob.ProcessJob: successfully invoked job processor for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector collecting Load Test counters
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Transactions
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Avg. Transaction Time
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Avg. Response Time
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Transactions/Sec
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Http Errors
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Validation Rule Errors
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Extraction Rule Errors
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Requests Timed Out
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Exceptions
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Errors
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Errors/Sec
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Pages
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Avg. Page Time
V, 5532, 51, 2012/08/01, 10:23:11.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Page Response Time Goal
V, 5532, 51, 2012/08/01, 10:23:11.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: % Pages Meeting Goal
V, 5532, 51, 2012/08/01, 10:23:11.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Pages/Sec
V, 5532, 51, 2012/08/01, 10:23:11.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Log Entries
V, 5532, 51, 2012/08/01, 10:23:11.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Log Entries/Sec
V, 5532, 51, 2012/08/01, 10:23:11.937, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector applying threshold rules
V, 5532, 51, 2012/08/01, 10:23:11.950, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector invoking interval data callback
V, 5532, 51, 2012/08/01, 10:23:11.957, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: invoking special job checker for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 51, 2012/08/01, 10:23:11.957, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: successfully invoked special job checker for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 51, 2012/08/01, 10:23:11.957, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: isSpecial = False
V, 5532, 51, 2012/08/01, 10:23:11.957, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: Queuing job 'Type Microsoft.VisualStudio.TestTools.WebStress.LoadTestResultMessage: run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 51, 2012/08/01, 10:23:11.957, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector writing interval data to repository
V, 5532, 51, 2012/08/01, 10:23:11.957, ControllerName\QTController.exe, WebLoadTestAdapter: Queued command WriteIntervalData to LoadTest performance counter writer (queue length: 0)
V, 5532, 51, 2012/08/01, 10:23:11.957, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector done processing interval
V, 5532, 4, 2012/08/01, 10:23:11.957, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender)+ExternalJob.ProcessJob: invoking job processor for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 4, 2012/08/01, 10:23:11.961, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender)+ExternalJob.ProcessJob: successfully invoked job processor for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
E, 5532, 49, 2012/08/01, 10:23:12.283, ControllerName\QTController.exe, WebLoadTestAdapter: Results from agent 'Agent_1_Name' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent.
E, 5532, 49, 2012/08/01, 10:23:12.285, ControllerName\QTController.exe, WebLoadTestAdapter: LoadTestResultsCollector: Reporting exception: Microsoft.VisualStudio.TestTools.WebStress.LoadTestAgentResultsLateException: Results from agent 'Agent_1_Name' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent.
W, 5532, 49, 2012/08/01, 10:23:12.286, ControllerName\QTController.exe, WebLoadTestAdapter: Results collection error: LoadTestAgentResultsLateException: Results from agent 'Agent_1_Name' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent.
V, 5532, 51, 2012/08/01, 10:23:12.936, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector collecting non-Load Test counters
V, 5532, 51, 2012/08/01, 10:23:12.960, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector waiting for Load Test counters
V, 5532, 43, 2012/08/01, 10:23:13.265, ControllerName\QTController.exe, Checking if user DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService
V, 5532, 43, 2012/08/01, 10:23:13.266, ControllerName\QTController.exe, User DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService.
V, 5532, 43, 2012/08/01, 10:23:13.266, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: invoking special job checker for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 43, 2012/08/01, 10:23:13.266, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: successfully invoked special job checker for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 43, 2012/08/01, 10:23:13.266, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: isSpecial = False
V, 5532, 43, 2012/08/01, 10:23:13.266, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: Queuing job 'Type Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper: ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 43, 2012/08/01, 10:23:13.266, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver)+ExternalJob.ProcessJob: invoking job processor for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 43, 2012/08/01, 10:23:13.269, ControllerName\QTController.exe, WebLoadTestAdapter: Received message Result - Interval results from agent Agent_2_Name (Interval number: 104)
V, 5532, 43, 2012/08/01, 10:23:13.269, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver)+ExternalJob.ProcessJob: successfully invoked job processor for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 49, 2012/08/01, 10:23:13.269, ControllerName\QTController.exe, WebLoadTestAdapter: Processing message Result - Interval results from agent Agent_2_Name (Interval number: 104)
V, 5532, 49, 2012/08/01, 10:23:13.269, ControllerName\QTController.exe, WebLoadTestAdapter: PerformanceCounterReporter.ReportLoad: Instance: _Agent(Agent_2_Name), Interval: 104, Load: 5
V, 5532, 32, 2012/08/01, 10:23:15.252, ControllerName\QTController.exe, ISpoolJob.WriteMessage: serializing message 'Microsoft.VisualStudio.TestTools.Common.HeartbeatMessage'
V, 5532, 32, 2012/08/01, 10:23:15.254, ControllerName\QTController.exe, ControllerExecution: Sent heartbeat to listeners
V, 5532, 4, 2012/08/01, 10:23:15.680, ControllerName\QTController.exe, Checking if user DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService
V, 5532, 4, 2012/08/01, 10:23:15.680, ControllerName\QTController.exe, User DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService.
V, 5532, 4, 2012/08/01, 10:23:15.681, ControllerName\QTController.exe, ControllerObject: AgentHello from Agent_1_Name
V, 5532, 43, 2012/08/01, 10:23:16.734, ControllerName\QTController.exe, Checking if user DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService
V, 5532, 43, 2012/08/01, 10:23:16.735, ControllerName\QTController.exe, User DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService.
V, 5532, 51, 2012/08/01, 10:23:16.936, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector collecting Load Test counters
V, 5532, 51, 2012/08/01, 10:23:16.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Transactions
V, 5532, 51, 2012/08/01, 10:23:16.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Avg. Transaction Time
V, 5532, 51, 2012/08/01, 10:23:16.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Avg. Response Time
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Transactions/Sec
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Http Errors
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Validation Rule Errors
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Extraction Rule Errors
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Requests Timed Out
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Exceptions
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Errors
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Errors/Sec
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Pages
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Avg. Page Time
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Page Response Time Goal
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: % Pages Meeting Goal
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Pages/Sec
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Log Entries
V, 5532, 51, 2012/08/01, 10:23:16.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Log Entries/Sec
V, 5532, 51, 2012/08/01, 10:23:16.938, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector applying threshold rules
V, 5532, 51, 2012/08/01, 10:23:16.940, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector invoking interval data callback
V, 5532, 51, 2012/08/01, 10:23:16.947, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: invoking special job checker for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 51, 2012/08/01, 10:23:16.947, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: successfully invoked special job checker for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 51, 2012/08/01, 10:23:16.947, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: isSpecial = False
V, 5532, 51, 2012/08/01, 10:23:16.947, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: Queuing job 'Type Microsoft.VisualStudio.TestTools.WebStress.LoadTestResultMessage: run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 51, 2012/08/01, 10:23:16.947, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector writing interval data to repository
V, 5532, 51, 2012/08/01, 10:23:16.947, ControllerName\QTController.exe, WebLoadTestAdapter: Queued command WriteIntervalData to LoadTest performance counter writer (queue length: 1)
V, 5532, 51, 2012/08/01, 10:23:16.947, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector done processing interval
V, 5532, 43, 2012/08/01, 10:23:16.949, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender)+ExternalJob.ProcessJob: invoking job processor for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 43, 2012/08/01, 10:23:16.953, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender)+ExternalJob.ProcessJob: successfully invoked job processor for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
E, 5532, 49, 2012/08/01, 10:23:17.272, ControllerName\QTController.exe, WebLoadTestAdapter: Results from agent 'Agent_1_Name' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent.
E, 5532, 49, 2012/08/01, 10:23:17.275, ControllerName\QTController.exe, WebLoadTestAdapter: LoadTestResultsCollector: Reporting exception: Microsoft.VisualStudio.TestTools.WebStress.LoadTestAgentResultsLateException: Results from agent 'Agent_1_Name' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent.
W, 5532, 49, 2012/08/01, 10:23:17.275, ControllerName\QTController.exe, WebLoadTestAdapter: Results collection error: LoadTestAgentResultsLateException: Results from agent 'Agent_1_Name' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent.
V, 5532, 4, 2012/08/01, 10:23:17.753, ControllerName\QTController.exe, Checking if user DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService
V, 5532, 4, 2012/08/01, 10:23:17.754, ControllerName\QTController.exe, User DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService.
V, 5532, 51, 2012/08/01, 10:23:17.936, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector collecting non-Load Test counters
V, 5532, 51, 2012/08/01, 10:23:17.958, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector waiting for Load Test counters
V, 5532, 43, 2012/08/01, 10:23:18.270, ControllerName\QTController.exe, Checking if user DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService
V, 5532, 43, 2012/08/01, 10:23:18.271, ControllerName\QTController.exe, User DomainName\POATCRM.PerfTestSvc is in group TeamTestAgentService.
V, 5532, 43, 2012/08/01, 10:23:18.271, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: invoking special job checker for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 43, 2012/08/01, 10:23:18.271, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: successfully invoked special job checker for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 43, 2012/08/01, 10:23:18.271, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: isSpecial = True
V, 5532, 43, 2012/08/01, 10:23:18.271, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver).TryEnqueueJob: Queuing job 'Type Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper: ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 43, 2012/08/01, 10:23:18.272, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver)+ExternalJob.ProcessJob: invoking job processor for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 43, 2012/08/01, 10:23:18.281, ControllerName\QTController.exe, WebLoadTestAdapter: Received message Result - Interval results from agent Agent_2_Name (Interval number: 105)
V, 5532, 49, 2012/08/01, 10:23:18.281, ControllerName\QTController.exe, WebLoadTestAdapter: Processing message Result - Interval results from agent Agent_2_Name (Interval number: 105)
V, 5532, 43, 2012/08/01, 10:23:18.281, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Controller.ReceivedTestMessageWrapper>(ControllerExecution.TestMessageReceiver)+ExternalJob.ProcessJob: successfully invoked job processor for job 'ReceivedTestMessageWrapper for test message 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress' from agent 'Agent_2_Name''
V, 5532, 49, 2012/08/01, 10:23:18.281, ControllerName\QTController.exe, WebLoadTestAdapter: PerformanceCounterReporter.ReportLoad: Instance: _Agent(Agent_2_Name), Interval: 105, Load: 5
V, 5532, 51, 2012/08/01, 10:23:21.936, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector collecting Load Test counters
V, 5532, 51, 2012/08/01, 10:23:21.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Transactions
V, 5532, 51, 2012/08/01, 10:23:21.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Avg. Transaction Time
V, 5532, 51, 2012/08/01, 10:23:21.936, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Avg. Response Time
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Transactions/Sec
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Http Errors
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Validation Rule Errors
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Extraction Rule Errors
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Requests Timed Out
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Exceptions
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Errors
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Errors/Sec
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Pages
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Avg. Page Time
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Page Response Time Goal
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: % Pages Meeting Goal
V, 5532, 51, 2012/08/01, 10:23:21.937, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Pages/Sec
V, 5532, 51, 2012/08/01, 10:23:21.938, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Total Log Entries
V, 5532, 51, 2012/08/01, 10:23:21.938, ControllerName\QTController.exe, WebLoadTestAdapter: No instances found for counter: Log Entries/Sec
V, 5532, 51, 2012/08/01, 10:23:21.938, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector applying threshold rules
V, 5532, 51, 2012/08/01, 10:23:21.938, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector invoking interval data callback
V, 5532, 51, 2012/08/01, 10:23:21.948, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: invoking special job checker for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 51, 2012/08/01, 10:23:21.948, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: successfully invoked special job checker for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 51, 2012/08/01, 10:23:21.948, ControllerName\QTController.exe, BackgroundSpecialJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: isSpecial = False
V, 5532, 51, 2012/08/01, 10:23:21.948, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender).TryEnqueueJob: Queuing job 'Type Microsoft.VisualStudio.TestTools.WebStress.LoadTestResultMessage: run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 51, 2012/08/01, 10:23:21.948, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector writing interval data to repository
V, 5532, 51, 2012/08/01, 10:23:21.948, ControllerName\QTController.exe, WebLoadTestAdapter: Queued command WriteIntervalData to LoadTest performance counter writer (queue length: 1)
V, 5532, 51, 2012/08/01, 10:23:21.948, ControllerName\QTController.exe, WebLoadTestAdapter: Results collector done processing interval
V, 5532, 43, 2012/08/01, 10:23:21.951, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender)+ExternalJob.ProcessJob: invoking job processor for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
V, 5532, 43, 2012/08/01, 10:23:21.955, ControllerName\QTController.exe, BackgroundJobProcessor<Microsoft.VisualStudio.TestTools.Common.TestMessage>(ControllerExecution.TestMessageSender)+ExternalJob.ProcessJob: successfully invoked job processor for job 'run id {0d6a1d10-ffe7-47c3-8050-281f9f7e899a}, test '5.1_LoadTest1' with id 0eafeea3-f46b-4468-89cf-499948d3cf6e: MessageKind: Result, Outcome: InProgress'
E, 5532, 49, 2012/08/01, 10:23:22.284, ControllerName\QTController.exe, WebLoadTestAdapter: Results from agent 'Agent_1_Name' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent.
E, 5532, 49, 2012/08/01, 10:23:22.286, ControllerName\QTController.exe, WebLoadTestAdapter: LoadTestResultsCollector: Reporting exception: Microsoft.VisualStudio.TestTools.WebStress.LoadTestAgentResultsLateException: Results from agent 'Agent_1_Name' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent.
W, 5532, 49, 2012/08/01, 10:23:22.286, ControllerName\QTController.exe, WebLoadTestAdapter: Results collection error: LoadTestAgentResultsLateException: Results from agent 'Agent_1_Name' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent.

Answer 1

Looks like a similar issue here in the link here as well ...Unfortunately I do no see the solution there either...

http://social.msdn.microsoft.com/Forums/sr/vstswebtest/thread/b4076d61-9824-426b-bd58-13be5e57fdee

---

Regards Anoop

Answer 2

Hi Puzzled_1010,

Thank you for posting in the MSDN forum.

I think you have checked this blog “Advanced Load Testing Features of Visual Studio Team System”,

A smaller sample rate, such as the default value of five seconds, requires more space in the load test results database. For longer load tests, increasing the sample rate reduces the amount of data collected.

About this issue, if you run your test with a short time or few uses or few the amount of data collected, whether it has the same issue?

About the LoadTestAgentResultsLateException, if all test Agents have the same issue, could you check your Agent machines? For example, check the Task manager. How about running the same test with test Agent in a machine which has the better configuration?

I’m afraid that it is related to the product performance, and if you have the VS2012 RC and Test Controller and Agent, maybe you could check it with this new Environment.

Best Regards,

---

Jack Zhai [MSFT]
MSDN Community Support | Feedback to us

Answer 3

Thanks Jack for the reply.

We had a look at the System event logs of the Agent servers and for some reason we have seem a system clock issue with our agent machines where system time seem to resetting every few minutes so as to advance and recede alternatively the system time almost  4 minutes...this seems to happen faily frequently every 10-15 minutes or so...

We ran a windows perfmon datacollector on the agent while we ran the test.There were periosd where the performance counter graphs blanked out due to the sytem clock being reset frequently.

We feel this might be the cause of Visual studio Controller not being able to get the counter values properly.

I am waiting for the system clock issue to be resolved to retest it..I will post my progress in due course...

---

Regards Anoop

Answer 4

We fixed the windows time synchonization issue on the Agent machines with Infrastructure team.

This has resolved the issue and we are no longer getting the following error message during our Load tests..:-)

“Results from agent '<one of my agent machines>' were not received in time to be included in the overall results for a sampling interval. To avoid this error, increase the sample rate, or decrease the load on this agent”

---

Regards Anoop

Answer 5

Hi Puzzled_1010,

Glad to see this issue has been resolved and thank you for sharing your solutions & experience here. It will be very beneficial for other community members who have similar questions.

Have a nice day,

---

Jack Zhai [MSFT]
MSDN Community Support | Feedback to us