[11/13 10:04:22,Telerik.TestStudio.Scheduling.Client.exe(8804:22),Error] JobBroker.-ctor() : Job runner did not start job for TestList: InfoColTestList!
[11/13 10:04:34,Telerik.TestStudio.Scheduling.Client.exe(8804:21),Framework] FireFoxInstallation.EnumFireFoxInstallations() : Valid Firefox 56.0.0.2 (x64) installation found at "C:\Program Files\Mozilla Firefox\firefox.exe".
[11/13 10:04:53,Telerik.TestStudio.Scheduling.Client.exe(8804:13),Error] JobBroker.-ctor() : Job runner did not start job for TestList: InfoColTestList!
[11/13 10:09:00,Telerik.TestStudio.Scheduling.Client.exe(8804:9)] First trace message from pool unnamed thread (managed ID = 9, native ID = 4016).
[11/13 10:09:00,Telerik.TestStudio.Scheduling.Client.exe(8804:9),Framework] FireFoxInstallation.EnumFireFoxInstallations() : Valid Firefox 56.0.0.2 (x64) installation found at "C:\Program Files\Mozilla Firefox\firefox.exe".
[11/13 10:09:28,Telerik.TestStudio.Scheduling.Setup.exe(508:1)] First trace message from process 508: "C:\Program Files (x86)\Telerik\Test Studio\Bin\Telerik.TestStudio.Scheduling.Setup.exe" 
[11/13 10:09:28,Telerik.TestStudio.Scheduling.Setup.exe(508:1)] First trace message from foreground unnamed thread (managed ID = 1, native ID = 7196).
[11/13 10:09:28,Telerik.TestStudio.Scheduling.Setup.exe(508:1),Execution] ServiceConfiguration.SaveAsConfig() : Config file found.
[11/13 10:09:28,Telerik.TestStudio.Scheduling.Setup.exe(508:1),Execution] ServiceConfiguration.SaveAsConfig() : Config file found.
[11/13 10:09:41,Telerik.TestStudio.ExecutionManagerService.exe(4528:1)] First trace message from process 4528: "C:\Program Files (x86)\Telerik\Test Studio\Bin\Telerik.TestStudio.ExecutionManagerService.exe"
[11/13 10:09:41,Telerik.TestStudio.ExecutionManagerService.exe(4528:1)] First trace message from foreground unnamed thread (managed ID = 1, native ID = 8732).
[11/13 10:09:41,Telerik.TestStudio.ExecutionManagerService.exe(4528:1),Execution] ServiceConfiguration.SetupConfig() : Config file found.
[11/13 10:09:42,Telerik.TestStudio.ExecutionManagerService.exe(4528:1),TestStudio] Loader.LoadTranslatorGroups() : ------- Function Start -------
[11/13 10:09:43,Telerik.TestStudio.ExecutionManagerService.exe(4528:1),TestStudio] Loader.LoadTranslatorGroups() : ------- Function End -------
[11/13 10:09:46,Telerik.TestStudio.ExecutionManagerService.exe(4528:7)] First trace message from background unnamed thread (managed ID = 7, native ID = 2092).
[11/13 10:09:46,Telerik.TestStudio.ExecutionManagerService.exe(4528:7),Execution] StorageServiceCommunicationChecker.PingStorage() : Active Storage service located at http://run-time.dcbcn.local:8492/v1/
[11/13 10:10:04,Telerik.TestStudio.Scheduling.Client.exe(2556:1)] First trace message from process 2556: "C:\Program Files (x86)\Telerik\Test Studio\Bin\Telerik.TestStudio.Scheduling.Client.exe" 
[11/13 10:10:04,Telerik.TestStudio.Scheduling.Client.exe(2556:1)] First trace message from foreground unnamed thread (managed ID = 1, native ID = 1220).
[11/13 10:10:04,Telerik.TestStudio.Scheduling.Client.exe(2556:1),Execution] ServiceConfiguration.SetupConfig() : Config file found.
[11/13 10:10:05,Telerik.TestStudio.Scheduling.Client.exe(2556:1),TestStudio] Loader.LoadTranslatorGroups() : ------- Function Start -------
[11/13 10:10:06,Telerik.TestStudio.Scheduling.Client.exe(2556:1),TestStudio] Loader.LoadTranslatorGroups() : ------- Function End -------
[11/13 10:10:09,Telerik.TestStudio.Scheduling.Client.exe(2556:1),Execution] TabControlViewModel constructor : Attempted to start a new scheduling server, but detected an already operational one.... using existing
[11/13 10:10:09,Telerik.TestStudio.Scheduling.Client.exe(2556:1),Execution] ProcessManager.StartProcess() : Starting profiler
[11/13 10:10:09,Telerik.TestStudio.Scheduling.Client.exe(2556:1),Execution] ProcessManager.CreateNativeProcess() : Started profiler:2296 url= http://prerun-time.dcbcn.local:8031/
[11/13 10:10:09,Telerik.TestStudio.Scheduling.Client.exe(2556:1),Execution] ProcessManager.StartProcess() : Starting executor
[11/13 10:10:10,Telerik.TestStudio.Scheduling.Client.exe(2556:1),Execution] ProcessManager.CreateNativeProcess() : Started executor:4592 url= http://prerun-time.dcbcn.local:8032/
[11/13 10:10:10,Telerik.TestStudio.RemoteExecutor.exe(4592:1)] First trace message from process 4592: "Telerik.TestStudio.RemoteExecutor.exe" "http://prerun-time.dcbcn.local:8032/" ""
[11/13 10:10:10,Telerik.TestStudio.RemoteExecutor.exe(4592:1)] First trace message from foreground unnamed thread (managed ID = 1, native ID = 4952).
[11/13 10:10:10,Telerik.TestStudio.RemoteExecutor.exe(4592:1),TestStudio] Loader.LoadTranslatorGroups() : ------- Function Start -------
[11/13 10:10:12,Telerik.TestStudio.RemoteExecutor.exe(4592:1),TestStudio] Loader.LoadTranslatorGroups() : ------- Function End -------
[11/13 10:10:13,Telerik.TestStudio.Profiler.exe(2296:1)] First trace message from process 2296: "Telerik.TestStudio.Profiler.exe" "http://prerun-time.dcbcn.local:8031/" ""
[11/13 10:10:13,Telerik.TestStudio.Profiler.exe(2296:1)] First trace message from foreground unnamed thread (managed ID = 1, native ID = 412).
[11/13 10:10:13,Telerik.TestStudio.Profiler.exe(2296:1),Execution] WcfHttpRawCommunicationLayer.Start() : Starting WCF Service with RawHTTP Bindings at http://prerun-time.dcbcn.local:8031/
[11/13 10:10:13,Telerik.TestStudio.Scheduling.Client.exe(2556:1),Framework] FireFoxInstallation.EnumFireFoxInstallations() : Valid Firefox 56.0.0.2 (x64) installation found at "C:\Program Files\Mozilla Firefox\firefox.exe".
[11/13 10:10:16,Telerik.TestStudio.ExecutionManagerService.exe(4528:10)] First trace message from pool unnamed thread (managed ID = 10, native ID = 8548).
[11/13 10:10:16,Telerik.TestStudio.ExecutionManagerService.exe(4528:10),Execution] JobRunner.RunJobAsync() : TestList loaded for job ID = d42eae4e-30b3-4f57-a8fb-4970a2beb9ce
[11/13 10:10:16,Telerik.TestStudio.ExecutionManagerService.exe(4528:10),Execution] JobRunner.RunJobAsync() : Job started, ID = d42eae4e-30b3-4f57-a8fb-4970a2beb9ce
[11/13 10:10:18,Telerik.TestStudio.Scheduling.Client.exe(2556:1),Framework] FireFoxInstallation.EnumFireFoxInstallations() : Valid Firefox 56.0.0.2 (x64) installation found at "C:\Program Files\Mozilla Firefox\firefox.exe".
[11/13 10:10:32,Telerik.TestStudio.RemoteExecutor.exe(4592:6)] First trace message from pool unnamed thread (managed ID = 6, native ID = 6492).
[11/13 10:10:32,Telerik.TestStudio.RemoteExecutor.exe(4592:6),Execution] RunningTestsController.StartTest() : Test run requested for test with path 'ApoderadoValencia.tstest'. Project path: 'C:\Users\SebastianGI\Source\Repos\webvalenciarepo'.
[11/13 10:10:32,Telerik.TestStudio.RemoteExecutor.exe(4592:6),Warning] CloudRunnableGUITestBuilder.CreateLocalCache() : Started getting project from storage
[11/13 10:10:34,Telerik.TestStudio.RemoteExecutor.exe(4592:5)] First trace message from pool unnamed thread (managed ID = 5, native ID = 6000).
[11/13 10:10:34,Telerik.TestStudio.RemoteExecutor.exe(4592:5),Execution] CloudStorageProjectOpener.DownloadAndSaveTestsAsync() : ------- Function Start -------
[11/13 10:10:38,Telerik.TestStudio.RemoteExecutor.exe(4592:14)] First trace message from pool unnamed thread (managed ID = 14, native ID = 7604).
[11/13 10:10:38,Telerik.TestStudio.RemoteExecutor.exe(4592:14),Execution] CloudStorageProjectOpener.DownloadAndSaveTestsAsync() : ------- Function End -------
[11/13 10:10:38,Telerik.TestStudio.RemoteExecutor.exe(4592:6),Warning] CloudRunnableGUITestBuilder.CreateLocalCache() : Finished getting project from storage
[11/13 10:10:39,Telerik.TestStudio.RemoteExecutor.exe(4592:5),TestStudio] <>c__DisplayClass35_1.<LoadInternal>b__2() : Extract elements time: 00:00:00.1865056
[11/13 10:10:39,Telerik.TestStudio.RemoteExecutor.exe(4592:5),TestStudio] <>c__DisplayClass35_1.<LoadInternal>b__2() : Merge elements time: 00:00:00.0511609
[11/13 10:10:39,Telerik.TestStudio.RemoteExecutor.exe(4592:5),TestStudio] <>c__DisplayClass35_1.<LoadInternal>b__2() : Total Elements count: 80
[11/13 10:10:40,Telerik.TestStudio.RemoteExecutor.exe(4592:6),Framework] TestAppLoader.LoadRefAssemblies() : External assembly loaded into the AppDomain: C:\Users\adminBCN\AppData\Local\Temp\Projects\3fb4ba58-d1ab-487a-aa66-bdbdc9bf7110\webvalenciarepo\..\webvalenciarepo\WinAPI.dll.
[11/13 10:10:40,Telerik.TestStudio.RemoteExecutor.exe(4592:6),Framework] TestAppLoader.LoadRefAssemblies() : External assembly loaded into the AppDomain: C:\Users\adminBCN\AppData\Local\Temp\Projects\3fb4ba58-d1ab-487a-aa66-bdbdc9bf7110\webvalenciarepo\..\webvalenciarepo\Bcn.Comun.WebTest.dll.
[11/13 10:10:40,Telerik.TestStudio.RemoteExecutor.exe(4592:6),Framework] TestAppLoader.LoadRefAssemblies() : External assembly loaded into the AppDomain: C:\Users\adminBCN\AppData\Local\Temp\Projects\3fb4ba58-d1ab-487a-aa66-bdbdc9bf7110\webvalenciarepo\..\webvalenciarepo\Bcn.Utils.dll.
[11/13 10:10:44,ArtOfTest.Runner.exe(5020:3)] First trace message from process 5020: "C:\Program Files (x86)\Telerik\Test Studio\Bin\ArtOfTest.Runner.exe"  /controller /parentprocesshandle=2408
[11/13 10:10:44,ArtOfTest.Runner.exe(5020:3)] First trace message from foreground thread "Remote.ArtOfTest.Runner.Listener" (managed ID = 3, native ID = 1188).
[11/13 10:10:44,ArtOfTest.Runner.exe(5020:3),TestStudio] Loader.LoadTranslatorGroups() : ------- Function Start -------
[11/13 10:10:45,ArtOfTest.Runner.exe(5020:3),TestStudio] Loader.LoadTranslatorGroups() : ------- Function End -------
[11/13 10:10:45,ArtOfTest.Runner.exe(5020:4)] First trace message from pool unnamed thread (managed ID = 4, native ID = 7916).
[11/13 10:10:45,ArtOfTest.Runner.exe(5020:4),Framework] TestAppLoader.LoadRefAssemblies() : External assembly loaded into the AppDomain: C:\Users\adminBCN\AppData\Local\Temp\Projects\3fb4ba58-d1ab-487a-aa66-bdbdc9bf7110\webvalenciarepo\..\webvalenciarepo\WinAPI.dll.
[11/13 10:10:45,ArtOfTest.Runner.exe(5020:4),Framework] TestAppLoader.LoadRefAssemblies() : External assembly loaded into the AppDomain: C:\Users\adminBCN\AppData\Local\Temp\Projects\3fb4ba58-d1ab-487a-aa66-bdbdc9bf7110\webvalenciarepo\..\webvalenciarepo\Bcn.Comun.WebTest.dll.
[11/13 10:10:45,ArtOfTest.Runner.exe(5020:4),Framework] TestAppLoader.LoadRefAssemblies() : External assembly loaded into the AppDomain: C:\Users\adminBCN\AppData\Local\Temp\Projects\3fb4ba58-d1ab-487a-aa66-bdbdc9bf7110\webvalenciarepo\..\webvalenciarepo\Bcn.Utils.dll.
[11/13 10:10:51,ArtOfTest.Runner.exe(5020:12)] First trace message from pool unnamed thread (managed ID = 12, native ID = 7868).
[11/13 10:10:51,ArtOfTest.Runner.exe(5020:12),Framework] Manager.AddNewBrowser() : Added client ID "fa75424d-ab9f-4923-a96e-8a2c3e55c940" (now there is/are 1 total).
[11/13 10:10:51,ArtOfTest.Runner.exe(5020:4),Execution] ExecutionEngine.InternalExecuteTest() : Executing test: 'ApoderadoValencia', path: 'ApoderadoValencia.tstest.'
[11/13 10:10:51,ArtOfTest.Runner.exe(5020:4),Execution] ExtensionsManager.LoadExtensions() : ------- Function Start -------
[11/13 10:10:51,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Got 9 plugin(s) in folder "C:\Program Files (x86)\Telerik\Test Studio\Bin\Plugins".
[11/13 10:10:51,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "LibGit2Sharp.dll" from plugins folder.
[11/13 10:10:51,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Jira.BugTracking.dll" from plugins folder.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.OTA.Interop.dll" from plugins folder.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Plugins.dll" from plugins folder.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.Shared.dll" from plugins folder.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.SourceControl.dll" from plugins folder.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.SourceControl.Git.dll" from plugins folder.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.SourceControl.Git.TS.dll" from plugins folder.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Uncategorized] ExtensionsManager.LoadExtensions() : Loaded assembly "Telerik.TestStudio.TeamPulse.dll" from plugins folder.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Execution] ExtensionsManager.LoadExtensions() : ------- Function End -------
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::Start
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),TestStudio] VisualDebugger.ShutDown() : VisualDebbuger::ShutDown::End
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Framework] BrowserProvisioner.EndService() : Connecting to the provisioning pipe "Pipe.ArtOfTest.WebAii.BrowserProvisioner_2103307005" in order to unblock and eventually terminate it...
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Framework] BrowserProvisioner.EndService() : Provisioning pipe connected.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:5)] First trace message from background thread "Pipe.ArtOfTest.WebAii.BrowserProvisioner" (managed ID = 5, native ID = 616).
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:5),Framework] BrowserProvisioner.ServiceThread() : A new client has connected to the provisioning pipe but this will be treated as a termination cue.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Framework] BrowserProvisioner.EndService() : Provisioning thread terminated.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),DialogPlayback] DialogMonitor.AddDialog() : Added {OnBeforeUnloadDialog(Dismiss=OK)} for monitoring.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Framework] Manager.RemoveBrowser() : Removed client ID "fa75424d-ab9f-4923-a96e-8a2c3e55c940" (0 remaining).
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Framework] Manager.SetActiveBrowser() : Active browser is now null.
[11/13 10:10:52,ArtOfTest.Runner.exe(5020:4),Warning] Manager.RemoveBrowser() : Attempted to remove a client ID "fa75424d-ab9f-4923-a96e-8a2c3e55c940" that was not in the list.
[11/13 10:10:53,ArtOfTest.Runner.exe(5020:4),DialogPlayback] DialogMonitor.Stop() : Dialog monitoring is being halted.
[11/13 10:10:53,ArtOfTest.Runner.exe(5020:4),UIAutomation] AutomationExtensions.AddAutomationEventHandler() : Added a(n) WindowPatternIdentifiers.WindowOpenedProperty handler on element System.Windows.Automation.AutomationElement scope Descendants.
[11/13 10:10:53,Telerik.TestStudio.RemoteExecutor.exe(4592:17)] First trace message from background thread "Callback Listener Thread" (managed ID = 17, native ID = 8308).
[11/13 10:10:53,Telerik.TestStudio.RemoteExecutor.exe(4592:17),Execution] TestPlatform.AfterRunFinished() : Finished running test platform- attempting publish
[11/13 10:10:53,Telerik.TestStudio.RemoteExecutor.exe(4592:17),Framework] FireFoxInstallation.EnumFireFoxInstallations() : Valid Firefox 56.0.0.2 (x64) installation found at "C:\Program Files\Mozilla Firefox\firefox.exe".
[11/13 10:11:09,Telerik.TestStudio.RemoteExecutor.exe(4592:14),Execution] CloudRunnableGUITestBuilder.CleanupTest() : No Unable to Delete.
[11/13 10:12:05,Telerik.TestStudio.Scheduling.Client.exe(2556:5)] First trace message from pool unnamed thread (managed ID = 5, native ID = 7268).
[11/13 10:12:05,Telerik.TestStudio.Scheduling.Client.exe(2556:5),Framework] FireFoxInstallation.EnumFireFoxInstallations() : Valid Firefox 56.0.0.2 (x64) installation found at "C:\Program Files\Mozilla Firefox\firefox.exe".
