{"action":"created","issue":{"url":"https://api.github.com/repos/Microsoft/vsts-agent/issues/1213","repository_url":"https://api.github.com/repos/Microsoft/vsts-agent","labels_url":"https://api.github.com/repos/Microsoft/vsts-agent/issues/1213/labels{/name}","comments_url":"https://api.github.com/repos/Microsoft/vsts-agent/issues/1213/comments","events_url":"https://api.github.com/repos/Microsoft/vsts-agent/issues/1213/events","html_url":"https://github.com/Microsoft/vsts-agent/issues/1213","id":258748363,"number":1213,"title":"Agent can't download new version of a task","user":{"login":"tomkuijsten","id":3097047,"avatar_url":"https://avatars2.githubusercontent.com/u/3097047?v=4","gravatar_id":"","url":"https://api.github.com/users/tomkuijsten","html_url":"https://github.com/tomkuijsten","followers_url":"https://api.github.com/users/tomkuijsten/followers","following_url":"https://api.github.com/users/tomkuijsten/following{/other_user}","gists_url":"https://api.github.com/users/tomkuijsten/gists{/gist_id}","starred_url":"https://api.github.com/users/tomkuijsten/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/tomkuijsten/subscriptions","organizations_url":"https://api.github.com/users/tomkuijsten/orgs","repos_url":"https://api.github.com/users/tomkuijsten/repos","events_url":"https://api.github.com/users/tomkuijsten/events{/privacy}","received_events_url":"https://api.github.com/users/tomkuijsten/received_events","type":"User","site_admin":false},"labels":[],"state":"open","locked":false,"assignee":null,"assignees":[],"milestone":null,"comments":6,"created_at":"2017-09-19T09:08:33Z","updated_at":"2017-09-20T14:30:38Z","closed_at":null,"author_association":"NONE","body":"## Agent version and platform\r\nAgent version: 2.117.2\r\nOS: Win 2012 R2 (x64)\r\n\r\n## VSTS type and version\r\nTFS 2017 update 2\r\n\r\n## What's not working?\r\nWhen a new version of a task is available, the agent has problems downloading the new task to the `_work\\_tasks` folder. This time it was the task 'VSTest' version '2.0.55'. If I copy the task from another agent which already has this version and put it in the `_work\\_tasks` folder, the build is working correctly. A couple of questions:\r\n - How does an agent know when a new version is available?\r\n - How does an agent get the new version?\r\n - Can I manually download the task from somewhere?\r\n\r\nThe log doesn't have any usefull info other then \"The operation timed out\". The agent is running as a windows service and the credentials have access to internet.\r\n\r\nAlready used fiddler to see if any traffic was blocked, but I didn't caught a single request. If I start a build on another agent (which doesn't use the VSTest step) I do get requests in fiddler.\r\n\r\n## Agent and Worker's diag log\r\nAgent\r\n```\r\n[2017-09-19 08:45:42Z INFO RSAEncryptedFileKeyManager] Loading RSA key parameters from file c:\\TfsBuildAgents\\06\\.credentials_rsaparams\r\n[2017-09-19 08:45:42Z INFO MessageListener] Message '5' received from session '8853a090-0f37-4193-af6e-77e4a095b8c8'.\r\n[2017-09-19 08:45:42Z INFO JobDispatcher] Job request 904e7c36-6864-44ce-a96b-6eb8b80b7e60 received.\r\n[2017-09-19 08:45:42Z INFO JobDispatcher] Job request f76abb40-cf21-4dce-9e87-e142d3e85e7c processed succeed.\r\n[2017-09-19 08:45:42Z INFO Terminal] WRITE LINE: 2017-09-19 08:45:42Z: Running job: Build\r\n[2017-09-19 08:45:42Z INFO JobDispatcher] Start renew job request 25565 for job 904e7c36-6864-44ce-a96b-6eb8b80b7e60.\r\n[2017-09-19 08:45:42Z INFO JobDispatcher] Successfully renew job request 25565, job is valid till 9/19/2017 8:50:42 AM\r\n[2017-09-19 08:45:42Z INFO ProcessInvoker] Starting process:\r\n[2017-09-19 08:45:42Z INFO ProcessInvoker]   File name: 'c:\\TfsBuildAgents\\06\\bin\\Agent.Worker.exe'\r\n[2017-09-19 08:45:42Z INFO ProcessInvoker]   Arguments: 'spawnclient 2492 2504'\r\n[2017-09-19 08:45:42Z INFO ProcessInvoker]   Working directory: 'c:\\TfsBuildAgents\\06\\bin'\r\n[2017-09-19 08:45:42Z INFO ProcessInvoker]   Require exit code zero: 'False'\r\n[2017-09-19 08:45:42Z INFO ProcessInvoker]   Encoding web name:  ; code page: ''\r\n[2017-09-19 08:45:42Z INFO ProcessInvoker]   Force kill process on cancellation: 'True'\r\n[2017-09-19 08:45:42Z INFO ProcessInvoker] Process started with process id 13336, waiting for process exit.\r\n[2017-09-19 08:45:42Z INFO JobDispatcher] Send job request message to worker for job 904e7c36-6864-44ce-a96b-6eb8b80b7e60.\r\n[2017-09-19 08:45:42Z INFO JobNotification] Entering JobStarted Notification\r\n[2017-09-19 08:45:58Z INFO ProcessInvoker] Finished process with exit code 102, and elapsed time 00:00:15.8414613.\r\n[2017-09-19 08:45:58Z INFO JobDispatcher] Worker finished for job 904e7c36-6864-44ce-a96b-6eb8b80b7e60. Code: 102\r\n[2017-09-19 08:45:58Z INFO JobDispatcher] finish job request for job 904e7c36-6864-44ce-a96b-6eb8b80b7e60 with result: Failed\r\n[2017-09-19 08:45:58Z INFO Terminal] WRITE LINE: 2017-09-19 08:45:58Z: Job Build completed with result: Failed\r\n[2017-09-19 08:45:58Z INFO JobDispatcher] Stop renew job request for job 904e7c36-6864-44ce-a96b-6eb8b80b7e60.\r\n[2017-09-19 08:45:58Z INFO JobDispatcher] job renew has been canceled, stop renew job request 25565.\r\n[2017-09-19 08:45:58Z INFO JobNotification] Entering JobCompleted Notification\r\n```\r\n\r\nWorker\r\n\r\n```\r\n[2017-09-19 08:45:46Z INFO TaskManager] Ensuring task exists: ID 'e213ff0f-5d5c-4791-802d-52ea3e7be1f1', version '1.2.3', name 'PowerShell', directory 'c:\\TfsBuildAgents\\06\\_work\\_tasks\\PowerShell_e213ff0f-5d5c-4791-802d-52ea3e7be1f1\\1.2.3'.\r\n[2017-09-19 08:45:46Z INFO TaskManager] Ensuring task exists: ID '333b11bd-d341-40d9-afcf-b32d5ce6f23b', version '0.2.31', name 'NuGetInstaller', directory 'c:\\TfsBuildAgents\\06\\_work\\_tasks\\NuGetInstaller_333b11bd-d341-40d9-afcf-b32d5ce6f23b\\0.2.31'.\r\n[2017-09-19 08:45:46Z INFO TaskManager] Ensuring task exists: ID '71a9a2d3-a98a-4caa-96ab-affca411ecda', version '1.119.0', name 'VSBuild', directory 'c:\\TfsBuildAgents\\06\\_work\\_tasks\\VSBuild_71a9a2d3-a98a-4caa-96ab-affca411ecda\\1.119.0'.\r\n[2017-09-19 08:45:46Z INFO TaskManager] Ensuring task exists: ID 'ef087383-ee5e-42c7-9a53-ab56c98420f9', version '2.0.55', name 'VSTest', directory 'c:\\TfsBuildAgents\\06\\_work\\_tasks\\VSTest_ef087383-ee5e-42c7-9a53-ab56c98420f9\\2.0.55'.\r\n[2017-09-19 08:45:56Z INFO JobServerQueue] Catch exception during append web console line, keep going since the process is best effort. Due with exception when all batches finish.\r\n[2017-09-19 08:45:56Z INFO JobServerQueue] Try to append 1 batches web console lines, success rate: 0/1.\r\n[2017-09-19 08:45:56Z ERR  JobServerQueue] System.AggregateException: Catch exception during append web console line. (An error occurred while sending the request.) ---> System.Net.Http.HttpRequestException: An error occurred while sending the request. ---> System.Net.Http.WinHttpException: The operation timed out\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at System.Net.Http.WinHttpHandler.<StartRequest>d__105.MoveNext()\r\n   --- End of inner exception stack trace ---\r\n   at Microsoft.VisualStudio.Services.Common.VssHttpRetryMessageHandler.<SendAsync>d__4.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at Microsoft.VisualStudio.Services.Agent.ThrottlingReportHandler.<SendAsync>d__2.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at System.Net.Http.HttpClient.<FinishSendAsync>d__58.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1.ConfiguredTaskAwaiter.GetResult()\r\n   at Microsoft.VisualStudio.Services.WebApi.VssHttpClientBase.<SendAsync>d__48.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1.ConfiguredTaskAwaiter.GetResult()\r\n   at Microsoft.VisualStudio.Services.WebApi.VssHttpClientBase.<SendAsync>d__30.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at Microsoft.VisualStudio.Services.Agent.JobServerQueue.<ProcessWebConsoleLinesQueueAsync>d__30.MoveNext()\r\n   --- End of inner exception stack trace ---\r\n---> (Inner Exception #0) System.Net.Http.HttpRequestException: An error occurred while sending the request. ---> System.Net.Http.WinHttpException: The operation timed out\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at System.Net.Http.WinHttpHandler.<StartRequest>d__105.MoveNext()\r\n   --- End of inner exception stack trace ---\r\n   at Microsoft.VisualStudio.Services.Common.VssHttpRetryMessageHandler.<SendAsync>d__4.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at Microsoft.VisualStudio.Services.Agent.ThrottlingReportHandler.<SendAsync>d__2.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at System.Net.Http.HttpClient.<FinishSendAsync>d__58.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1.ConfiguredTaskAwaiter.GetResult()\r\n   at Microsoft.VisualStudio.Services.WebApi.VssHttpClientBase.<SendAsync>d__48.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at System.Runtime.CompilerServices.ConfiguredTaskAwaitable`1.ConfiguredTaskAwaiter.GetResult()\r\n   at Microsoft.VisualStudio.Services.WebApi.VssHttpClientBase.<SendAsync>d__30.MoveNext()\r\n--- End of stack trace from previous location where exception was thrown ---\r\n   at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()\r\n   at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification(Task task)\r\n   at Microsoft.VisualStudio.Services.Agent.JobServerQueue.<ProcessWebConsoleLinesQueueAsync>d__30.MoveNext()<---\r\n\r\n```\r\n"},"comment":{"url":"https://api.github.com/repos/Microsoft/vsts-agent/issues/comments/330870007","html_url":"https://github.com/Microsoft/vsts-agent/issues/1213#issuecomment-330870007","issue_url":"https://api.github.com/repos/Microsoft/vsts-agent/issues/1213","id":330870007,"user":{"login":"TingluoHuang","id":1750815,"avatar_url":"https://avatars3.githubusercontent.com/u/1750815?v=4","gravatar_id":"","url":"https://api.github.com/users/TingluoHuang","html_url":"https://github.com/TingluoHuang","followers_url":"https://api.github.com/users/TingluoHuang/followers","following_url":"https://api.github.com/users/TingluoHuang/following{/other_user}","gists_url":"https://api.github.com/users/TingluoHuang/gists{/gist_id}","starred_url":"https://api.github.com/users/TingluoHuang/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/TingluoHuang/subscriptions","organizations_url":"https://api.github.com/users/TingluoHuang/orgs","repos_url":"https://api.github.com/users/TingluoHuang/repos","events_url":"https://api.github.com/users/TingluoHuang/events{/privacy}","received_events_url":"https://api.github.com/users/TingluoHuang/received_events","type":"User","site_admin":false},"created_at":"2017-09-20T14:30:38Z","updated_at":"2017-09-20T14:30:38Z","author_association":"MEMBER","body":"@tomkuijsten before agent version 2.119.x, the agent will follow IE proxy setting if you don't have a `.proxy` file, I guess you have a IE proxy setting on that box.\r\nfrom agent 2.119.x, we change the agent only follow what you put in the `.proxy` file, if you don't have `.proxy`, no proxy will be used."}}
{"actor":{"display_login":"TingluoHuang"}}