[2019-10-09 13:59:30Z INFO Program] Version: 2.155.1
[2019-10-09 13:59:30Z INFO Program] Commit: 2a1d4271df4d990b6c8ff0d65e15b14e957393d8
[2019-10-09 13:59:30Z INFO Program] Culture: de-DE
[2019-10-09 13:59:30Z INFO Program] UI Culture: de-DE
[2019-10-09 13:59:30Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:30Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:30Z INFO HostContext] Well known config file 'Proxy': 'C:\agent3\.proxy'
[2019-10-09 13:59:30Z INFO VstsAgentWebProxy] No proxy setting found.
[2019-10-09 13:59:30Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:30Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:30Z INFO HostContext] Well known config file 'Certificates': 'C:\agent3\.certificates'
[2019-10-09 13:59:30Z INFO AgentCertificateManager] No certificate setting found.
[2019-10-09 13:59:30Z INFO Worker] Waiting to receive the job message from the channel.
[2019-10-09 13:59:30Z INFO Worker] Message received.
[2019-10-09 13:59:31Z INFO Worker] Job message:
 {
  "mask": [
    {
      "type": "regex",
      "value": ***
    },
    {
      "type": "regex",
      "value": "***"
    },
    {
      "type": "regex",
      "value": "***"
    },
    {
      "type": "regex",
      "value": "***"
    }
  ],
  "steps": [
    {
      "inputs": {
        "repository": "__designer_repo",
        "clean": "true",
        "submodules": "true",
        "fetchDepth": "0",
        "lfs": "false"
      },
      "type": "task",
      "reference": {
        "id": "6d15af64-176c-496d-b583-fd2ae21d4df4",
        "name": "Checkout",
        "version": "1.0.0"
      },
      "id": "f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689",
      "name": "Checkout",
      "displayName": "Checkout"
    },
    {
      "inputs": {
        "versionSpec": "5.0.2",
        "checkLatest": "false"
      },
      "type": "task",
      "reference": {
        "id": "2c65196a-54fd-4a02-9be8-d9d1837b7c5d",
        "name": "NuGetToolInstaller",
        "version": "1.153.0"
      },
      "condition": "succeeded()",
      "id": "69023f78-fff8-5e58-bc46-5dd9b052fdab",
      "name": "NuGetToolInstaller",
      "displayName": "NuGet 5.0.2 verwenden"
    },
    {
      "inputs": {
        "command": "restore",
        "solution": "Servicecenter.sln",
        "selectOrConfig": "select",
        "feedRestore": "",
        "includeNuGetOrg": "true",
        "nugetConfigPath": "",
        "externalEndpoints": "",
        "noCache": "true",
        "disableParallelProcessing": "false",
        "packagesDirectory": "",
        "verbosityRestore": "Detailed",
        "searchPatternPush": "$(Build.ArtifactStagingDirectory)/**/*.nupkg;!$(Build.ArtifactStagingDirectory)/**/*.symbols.nupkg",
        "nuGetFeedType": "internal",
        "feedPublish": "",
        "publishPackageMetadata": "true",
        "allowPackageConflicts": "false",
        "externalEndpoint": "",
        "verbosityPush": "Detailed",
        "searchPatternPack": "**/*.csproj",
        "configurationToPack": "$(BuildConfiguration)",
        "outputDir": "$(Build.ArtifactStagingDirectory)",
        "versioningScheme": "off",
        "includeReferencedProjects": "false",
        "versionEnvVar": "",
        "requestedMajorVersion": "1",
        "requestedMinorVersion": "0",
        "requestedPatchVersion": "0",
        "packTimezone": "utc",
        "includeSymbols": "false",
        "toolPackage": "false",
        "buildProperties": "",
        "basePath": "",
        "verbosityPack": "Detailed",
        "arguments": ""
      },
      "type": "task",
      "reference": {
        "id": "333b11bd-d341-40d9-afcf-b32d5ce6f23b",
        "name": "NuGetCommand",
        "version": "2.153.2"
      },
      "condition": "succeeded()",
      "id": "2801dbb3-35e3-532e-5a2e-9b20885fa494",
      "name": "NuGetRestore_1",
      "displayName": "NuGet restore Servicecenter.sln"
    },
    {
      "inputs": {
        "SonarQube": "2e3174f3-d4de-4d0c-971a-794325f506f8",
        "scannerMode": "MSBuild",
        "configMode": "file",
        "configFile": "sonar-project.properties",
        "cliProjectKey": "",
        "projectKey": "Servicecenter",
        "cliProjectName": "",
        "projectName": "Servicecenter",
        "cliProjectVersion": "1.0",
        "projectVersion": "1.0",
        "cliSources": ".",
        "extraProperties": "# Additional properties that will be passed to the scanner, \n# Put one key=value per line, example:\nsonar.exclusions=**/TinyMCE/**, Servicecenter/Helper/Template.html"
      },
      "type": "task",
      "reference": {
        "id": "15b84ca1-b62f-4a2a-a403-89b77a063157",
        "name": "SonarQubePrepare",
        "version": "4.8.0"
      },
      "condition": "succeeded()",
      "id": "88cad227-c762-5712-e58e-6ca7de6fa956",
      "name": "SonarQubePrepare",
      "displayName": "Prepare analysis on SonarQube"
    },
    {
      "inputs": {
        "solution": "Servicecenter.sln",
        "vsVersion": "latest",
        "msbuildArgs": "",
        "platform": "$(BuildPlatform)",
        "configuration": "$(BuildConfiguration)",
        "clean": "false",
        "maximumCpuCount": "false",
        "restoreNugetPackages": "false",
        "msbuildArchitecture": "x64",
        "logProjectEvents": "true",
        "createLogFile": "false",
        "logFileVerbosity": "normal"
      },
      "type": "task",
      "reference": {
        "id": "71a9a2d3-a98a-4caa-96ab-affca411ecda",
        "name": "VSBuild",
        "version": "1.151.2"
      },
      "condition": "succeeded()",
      "id": "6a7ac225-8257-51f6-8eed-20c2e5179b9e",
      "name": "VSBuild_2",
      "displayName": "Projektmappe Servicecenter.sln erstellen"
    },
    {
      "type": "task",
      "reference": {
        "id": "6d01813a-9589-4b15-8491-8164aeb38055",
        "name": "SonarQubeAnalyze",
        "version": "4.8.0"
      },
      "condition": "succeeded()",
      "id": "02480dbe-2227-5f4d-f0c0-783cc8a59792",
      "name": "SonarQubeAnalyze",
      "displayName": "Run Code Analysis"
    },
    {
      "inputs": {
        "pollingTimeoutSec": "300"
      },
      "type": "task",
      "reference": {
        "id": "291ed61f-1ee4-45d3-b1b0-bf822d9095ef",
        "name": "SonarQubePublish",
        "version": "4.8.0"
      },
      "condition": "succeeded()",
      "id": "bb8eda65-667d-581d-edb4-84687019bff3",
      "name": "SonarQubePublish",
      "displayName": "Publish Quality Gate Result"
    },
    {
      "inputs": {
        "disableCertCheck": "false"
      },
      "type": "task",
      "reference": {
        "id": "175c8a10-0ef0-11e7-936d-2100de00518d",
        "name": "PostBuildCleanup",
        "version": "3.0.9"
      },
      "condition": "succeeded()",
      "id": "014d0fcf-0013-58fb-46b1-4500969e75b8",
      "name": "PostBuildCleanup",
      "displayName": "Clean Agent Directories"
    }
  ],
  "variables": {
    "BuildConfiguration": {
      "value": "debug"
    },
    "BuildPlatform": {
      "value": "x64"
    },
    "system.debug": {
      "value": "false"
    },
    "system": {
      "value": "build"
    },
    "system.hosttype": {
      "value": "build"
    },
    "system.servertype": {
      "value": "OnPremises"
    },
    "system.culture": {
      "value": "de-DE"
    },
    "system.collectionId": {
      "value": "66bff1ef-8b30-4c7e-855a-19fecab9448e"
    },
    "system.collectionUri": {
      "value": "http://srcctl/DefaultCollection/"
    },
    "system.teamFoundationCollectionUri": {
      "value": "http://srcctl/DefaultCollection/"
    },
    "system.taskDefinitionsUri": {
      "value": "http://srcctl/DefaultCollection/"
    },
    "system.pipelineStartTime": {
      "value": "2019-10-09 15:59:29+02:00"
    },
    "system.teamProject": {
      "value": "Servicecenter"
    },
    "system.teamProjectId": {
      "value": "44a621a2-ddc8-4c65-aa00-4e0cce873a01"
    },
    "system.definitionId": {
      "value": "42"
    },
    "build.definitionName": {
      "value": "Servicecenter-QA"
    },
    "build.definitionVersion": {
      "value": "41"
    },
    "build.queuedBy": {
      "value": "[PII]"
    },
    "build.queuedById": {
      "value": "155bc14f-d2ee-4c3b-af09-0c4f3fb14bb6"
    },
    "build.requestedFor": {
      "value": "[PII]"
    },
    "build.requestedForId": {
      "value": "155bc14f-d2ee-4c3b-af09-0c4f3fb14bb6"
    },
    "build.requestedForEmail": {
      "value": "[PII]"
    },
    "build.sourceVersion": {
      "value": "[PII]"
    },
    "build.sourceBranch": {
      "value": "[PII]"
    },
    "build.sourceBranchName": {
      "value": "[PII]"
    },
    "build.reason": {
      "value": "Manual"
    },
    "system.pullRequest.isFork": {
      "value": "False"
    },
    "system.jobParallelismTag": {
      "value": "Private"
    },
    "MSDEPLOY_HTTP_USER_AGENT": {
      "value": "TFS_66bff1ef-8b30-4c7e-855a-19fecab9448e_build_42_0"
    },
    "AZURE_HTTP_USER_AGENT": {
      "value": "TFS_66bff1ef-8b30-4c7e-855a-19fecab9448e_build_42_0"
    },
    "build.buildId": {
      "value": "3832"
    },
    "build.buildUri": {
      "value": "vstfs:///Build/Build/3832"
    },
    "build.buildNumber": {
      "value": "20191009.3"
    },
    "build.containerId": {
      "value": "60427"
    },
    "system.isScheduled": {
      "value": "False"
    },
    "system.definitionName": {
      "value": "Servicecenter-QA"
    },
    "system.planId": {
      "value": "0e0a8220-9365-4dff-9469-9227f48acafb"
    },
    "system.timelineId": {
      "value": "0e0a8220-9365-4dff-9469-9227f48acafb"
    },
    "system.stageDisplayName": {
      "value": "__default"
    },
    "system.stageId": {
      "value": "96ac2280-8cb4-5df5-99de-dd2da759617d"
    },
    "system.stageName": {
      "value": "__default"
    },
    "system.stageAttempt": {
      "value": "1"
    },
    "system.phaseDisplayName": {
      "value": "Agentauftrag \"1\""
    },
    "system.phaseId": {
      "value": "d46bdafb-39a9-561e-f56f-8f45577d0334"
    },
    "system.phaseName": {
      "value": "Phase_1"
    },
    "system.phaseAttempt": {
      "value": "1"
    },
    "system.jobIdentifier": {
      "value": "Phase_1.__default"
    },
    "system.jobAttempt": {
      "value": "1"
    },
    "System.JobPositionInPhase": {
      "value": "1"
    },
    "System.TotalJobsInPhase": {
      "value": "1"
    },
    "system.jobDisplayName": {
      "value": "Agentauftrag \"1\""
    },
    "system.jobId": {
      "value": "fd490c07-0b22-5182-fac9-6d67fe1e939b"
    },
    "system.jobName": {
      "value": "__default"
    },
    "agent.retainDefaultEncoding": {
      "value": "false"
    },
    "agent.disablelogplugin.TestResultLogPlugin": {
      "value": "true"
    },
    "agent.disablelogplugin.TestFilePublisherPlugin": {
      "value": "true"
    },
    "build.repository.id": {
      "value": "b333d864-e76d-4c7e-83eb-c32cc31cfc26"
    },
    "build.repository.name": {
      "value": "Servicecenter"
    },
    "build.repository.uri": {
      "value": "http://srcctl/DefaultCollection/Servicecenter/_git/Servicecenter"
    },
    "build.sourceVersionAuthor": {
      "value": "[PII]"
    },
    "build.sourceVersionMessage": {
      "value": "refactor: überflüssige using-Anweisung entfernt"
    }
  },
  "messageType": "PipelineAgentJobRequest",
  "plan": {
    "scopeIdentifier": "44a621a2-ddc8-4c65-aa00-4e0cce873a01",
    "planType": "Build",
    "version": 6,
    "planId": "0e0a8220-9365-4dff-9469-9227f48acafb",
    "planGroup": "Build:44a621a2-ddc8-4c65-aa00-4e0cce873a01:3832",
    "artifactUri": "vstfs:///Build/Build/3832",
    "artifactLocation": null,
    "definition": {
      "_links": {
        "web": {
          "href": "http://srcctl/DefaultCollection/44a621a2-ddc8-4c65-aa00-4e0cce873a01/_build/definition?definitionId=42"
        },
        "self": {
          "href": "http://srcctl/DefaultCollection/44a621a2-ddc8-4c65-aa00-4e0cce873a01/_apis/build/Definitions/42"
        }
      },
      "id": 42,
      "name": "Servicecenter-QA"
    },
    "owner": {
      "_links": {
        "web": {
          "href": "http://srcctl/DefaultCollection/44a621a2-ddc8-4c65-aa00-4e0cce873a01/_build/results?buildId=3832"
        },
        "self": {
          "href": "http://srcctl/DefaultCollection/44a621a2-ddc8-4c65-aa00-4e0cce873a01/_apis/build/Builds/3832"
        }
      },
      "id": 3832,
      "name": "20191009.3"
    }
  },
  "timeline": {
    "id": "0e0a8220-9365-4dff-9469-9227f48acafb",
    "changeId": 4,
    "location": null
  },
  "jobId": "fd490c07-0b22-5182-fac9-6d67fe1e939b",
  "jobDisplayName": "Agentauftrag \"1\"",
  "jobName": "__default",
  "jobContainer": null,
  "requestId": 0,
  "lockedUntil": "0001-01-01T00:00:00",
  "resources": {
    "endpoints": [
      {
        "data": {},
        "id": "2e3174f3-d4de-4d0c-971a-794325f506f8",
        "name": "lokal",
        "type": "sonarqube",
        "owner": "Library",
        "url": "http://srcctl:9000",
        "createdBy": {
          "displayName": "Heiko Adams",
          "id": "155bc14f-d2ee-4c3b-af09-0c4f3fb14bb6",
          "uniqueName": "FW\\h.adams"
        },
        "authorization": {
          "parameters": {
            "username": ***,
            "password": ""
          },
          "scheme": "UsernamePassword"
        },
        "isShared": false,
        "isReady": true
      },
      {
        "data": {
          "ServerId": "66bff1ef-8b30-4c7e-855a-19fecab9448e",
          "ServerName": "DefaultCollection"
        },
        "name": "SystemVssConnection",
        "url": "http://srcctl/DefaultCollection/",
        "authorization": {
          "parameters": {
            "AccessToken": ***
          },
          "scheme": "OAuth"
        },
        "isShared": false,
        "isReady": true
      }
    ],
    "repositories": [
      {
        "properties": {
          "id": "b333d864-e76d-4c7e-83eb-c32cc31cfc26",
          "type": "Git",
          "name": "Servicecenter",
          "project": "44a621a2-ddc8-4c65-aa00-4e0cce873a01",
          "defaultBranch": "refs/heads/master",
          "ref": "refs/heads/master",
          "version": "0503238916de4e5882f2bdc8e349a48d882f54d6",
          "versionInfo": {
            "author": "[PII]",
            "message": "refactor: überflüssige using-Anweisung entfernt"
          },
          "url": "http://srcctl/DefaultCollection/Servicecenter/_git/Servicecenter"
        },
        "alias": "__designer_repo",
        "endpoint": {
          "name": "SystemVssConnection"
        }
      }
    ]
  },
  "workspace": {
    "clean": "outputs"
  }
}
[2019-10-09 13:59:31Z INFO JobRunner] Job ID fd490c07-0b22-5182-fac9-6d67fe1e939b
[2019-10-09 13:59:31Z INFO ConfigurationStore] currentAssemblyLocation: C:\agent3\bin\Agent.Worker.dll
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO ConfigurationStore] binPath: C:\agent3\bin
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO ConfigurationStore] RootFolder: C:\agent3
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known config file 'Agent': 'C:\agent3\.agent'
[2019-10-09 13:59:31Z INFO ConfigurationStore] ConfigFilePath: C:\agent3\.agent
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known config file 'Credentials': 'C:\agent3\.credentials'
[2019-10-09 13:59:31Z INFO ConfigurationStore] CredFilePath: C:\agent3\.credentials
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known config file 'Service': 'C:\agent3\.service'
[2019-10-09 13:59:31Z INFO ConfigurationStore] ServiceConfigFilePath: C:\agent3\.service
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known config file 'Autologon': 'C:\agent3\.autologon'
[2019-10-09 13:59:31Z INFO ConfigurationStore] AutoLogonSettingsFilePath: C:\agent3\.autologon
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known config file 'Options': 'C:\agent3\.options'
[2019-10-09 13:59:31Z INFO ConfigurationStore] RuntimeOptionsFilePath: C:\agent3\.options
[2019-10-09 13:59:31Z INFO ConfigurationStore] Read setting file: 155 chars
[2019-10-09 13:59:31Z INFO JobRunner] Ensure endpoint url match config url base. http://srcctl/DefaultCollection/
[2019-10-09 13:59:31Z INFO JobRunner] Ensure repository url match config url base. http://srcctl/DefaultCollection/Servicecenter/_git/Servicecenter
[2019-10-09 13:59:31Z INFO JobRunner] Ensure System.TaskDefinitionsUrl match config url base. http://srcctl/DefaultCollection/
[2019-10-09 13:59:31Z INFO JobRunner] Ensure System.TFCollectionUrl match config url base. http://srcctl/DefaultCollection/
[2019-10-09 13:59:31Z INFO JobRunner] Ensure System.TFServerUrl match config url base. http://srcctl/DefaultCollection/
[2019-10-09 13:59:31Z INFO JobRunner] Creating job server with URL: http://srcctl/DefaultCollection/
[2019-10-09 13:59:31Z INFO VisualStudioServices] Starting operation Location.GetConnectionData
[2019-10-09 13:59:31Z INFO Worker] Listening for cancel message from the channel.
[2019-10-09 13:59:31Z INFO Worker] Waiting for the job to complete or for a cancel message from the channel.
[2019-10-09 13:59:31Z INFO VisualStudioServices] Finished operation Location.GetConnectionData
[2019-10-09 13:59:31Z INFO JobServerQueue] Start process web console line queue.
[2019-10-09 13:59:31Z INFO JobServerQueue] Start process file upload queue.
[2019-10-09 13:59:31Z INFO JobServerQueue] Start process timeline update queue.
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:31Z INFO JobRunner] Starting the job execution context.
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:31Z INFO JobRunner] Validating directory permissions for: 'C:\agent3\_work'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Externals': 'C:\agent3\externals'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'ServerOM': 'C:\agent3\externals\vstsom'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Tools': 'C:\agent3\_work\_tool'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:31Z INFO HostContext] Well known directory 'Temp': 'C:\agent3\_work\_temp'
[2019-10-09 13:59:31Z INFO JobRunner] Creating task server with http://srcctl/DefaultCollection/
[2019-10-09 13:59:31Z INFO VisualStudioServices] Starting operation Location.GetConnectionData
[2019-10-09 13:59:31Z INFO VisualStudioServices] Finished operation Location.GetConnectionData
[2019-10-09 13:59:32Z INFO JobRunner] Getting job extension.
[2019-10-09 13:59:32Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.BuildJobExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Release.ReleaseJobExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Release.DeploymentJobExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Maintenance.MaintenanceJobExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO JobRunner] Initialize job. Getting all job steps.
[2019-10-09 13:59:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'fd490c07-0b22-5182-fac9-6d67fe1e939b', success rate: 1/1.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO BuildJobExtension] Run initial step from extension BuildJobExtension.
[2019-10-09 13:59:32Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.Build.ISourceProvider'
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.ExternalGitSourceProvider, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.GitHubSourceProvider, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.GitHubEnterpriseSourceProvider, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.BitbucketSourceProvider, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.SvnSourceProvider, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.TfsGitSourceProvider, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.TfsVCSourceProvider, Agent.Worker
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO BuildDirectoryManager] Checking if artifacts directory exists: 'C:\agent3\_work\1\a'
[2019-10-09 13:59:32Z INFO BuildDirectoryManager] Creating artifacts directory.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO BuildDirectoryManager] Checking if test results directory exists: 'C:\agent3\_work\1\TestResults'
[2019-10-09 13:59:32Z INFO BuildDirectoryManager] Creating test results directory.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO BuildDirectoryManager] Checking if binaries directory exists: 'C:\agent3\_work\1\b'
[2019-10-09 13:59:32Z INFO BuildDirectoryManager] Creating binaries directory.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO BuildDirectoryManager] Set repository path for repository __designer_repo to 'C:\agent3\_work\1\s'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO BuildJobExtension] Downloading task definitions.
[2019-10-09 13:59:32Z INFO TaskManager] Skip download checkout task.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Ensuring task exists: ID '2c65196a-54fd-4a02-9be8-d9d1837b7c5d', version '1.153.0', name 'NuGetToolInstaller', directory 'C:\agent3\_work\_tasks\NuGetToolInstaller_2c65196a-54fd-4a02-9be8-d9d1837b7c5d\1.153.0'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Ensuring task exists: ID '333b11bd-d341-40d9-afcf-b32d5ce6f23b', version '2.153.2', name 'NuGetCommand', directory 'C:\agent3\_work\_tasks\NuGetCommand_333b11bd-d341-40d9-afcf-b32d5ce6f23b\2.153.2'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Ensuring task exists: ID '15b84ca1-b62f-4a2a-a403-89b77a063157', version '4.8.0', name 'SonarQubePrepare', directory 'C:\agent3\_work\_tasks\SonarQubePrepare_15b84ca1-b62f-4a2a-a403-89b77a063157\4.8.0'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Ensuring task exists: ID '71a9a2d3-a98a-4caa-96ab-affca411ecda', version '1.151.2', name 'VSBuild', directory 'C:\agent3\_work\_tasks\VSBuild_71a9a2d3-a98a-4caa-96ab-affca411ecda\1.151.2'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Ensuring task exists: ID '6d01813a-9589-4b15-8491-8164aeb38055', version '4.8.0', name 'SonarQubeAnalyze', directory 'C:\agent3\_work\_tasks\SonarQubeAnalyze_6d01813a-9589-4b15-8491-8164aeb38055\4.8.0'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Ensuring task exists: ID '291ed61f-1ee4-45d3-b1b0-bf822d9095ef', version '4.8.0', name 'SonarQubePublish', directory 'C:\agent3\_work\_tasks\SonarQubePublish_291ed61f-1ee4-45d3-b1b0-bf822d9095ef\4.8.0'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Ensuring task exists: ID '175c8a10-0ef0-11e7-936d-2100de00518d', version '3.0.9', name 'PostBuildCleanup', directory 'C:\agent3\_work\_tasks\PostBuildCleanup_175c8a10-0ef0-11e7-936d-2100de00518d\3.0.9'.
[2019-10-09 13:59:32Z INFO BuildJobExtension] Parsing all task's condition inputs.
[2019-10-09 13:59:32Z INFO ExpressionManager] Parsing expression: <succeeded()>
[2019-10-09 13:59:32Z INFO ExpressionManager] Parsing expression: <succeeded()>
[2019-10-09 13:59:32Z INFO ExpressionManager] Parsing expression: <succeeded()>
[2019-10-09 13:59:32Z INFO ExpressionManager] Parsing expression: <succeeded()>
[2019-10-09 13:59:32Z INFO ExpressionManager] Parsing expression: <succeeded()>
[2019-10-09 13:59:32Z INFO ExpressionManager] Parsing expression: <succeeded()>
[2019-10-09 13:59:32Z INFO ExpressionManager] Parsing expression: <succeeded()>
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\NuGetToolInstaller_2c65196a-54fd-4a02-9be8-d9d1837b7c5d\1.153.0\task.json'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\NuGetCommand_333b11bd-d341-40d9-afcf-b32d5ce6f23b\2.153.2\task.json'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\SonarQubePrepare_15b84ca1-b62f-4a2a-a403-89b77a063157\4.8.0\task.json'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\VSBuild_71a9a2d3-a98a-4caa-96ab-affca411ecda\1.151.2\task.json'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\SonarQubeAnalyze_6d01813a-9589-4b15-8491-8164aeb38055\4.8.0\task.json'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\SonarQubePublish_291ed61f-1ee4-45d3-b1b0-bf822d9095ef\4.8.0\task.json'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\PostBuildCleanup_175c8a10-0ef0-11e7-936d-2100de00518d\3.0.9\task.json'.
[2019-10-09 13:59:32Z INFO BuildJobExtension] Adding pre-job step from extension.
[2019-10-09 13:59:32Z INFO BuildJobExtension] Adding post-job step from extension.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO BuildJobExtension] Adding post-job steps from tasks.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 13:59:32Z INFO BuildJobExtension] Total accessible running process: 153.
[2019-10-09 13:59:32Z INFO JobRunner] Total job steps: 10.
[2019-10-09 13:59:32Z INFO JobRunner] Run all job steps.
[2019-10-09 13:59:32Z INFO StepsRunner] Processing step: DisplayName='Checkout', ContinueOnError=False, Enabled=True
[2019-10-09 13:59:32Z INFO ExpressionManager] Evaluating: SucceededNode()
[2019-10-09 13:59:32Z INFO ExpressionManager] Result: True
[2019-10-09 13:59:32Z INFO StepsRunner] Starting the step.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO StepsRunner] Which: 'chcp'
[2019-10-09 13:59:32Z INFO StepsRunner] Location: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   File name: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Arguments: '65001'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Require exit code zero: 'False'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Encoding web name:  ; code page: ''
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 13:59:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'a58c839c-fca8-464e-a1c4-d36e97252483', success rate: 1/1.
[2019-10-09 13:59:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper] Process started with process id 12656, waiting for process exit.
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper] Finished process 12656 with exit code 0, and elapsed time 00:00:00.0477509.
[2019-10-09 13:59:32Z INFO StepsRunner] Successfully returned to code page 65001 (UTF8)
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 13:59:32Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IWorkerCommandExtension'
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.TaskCommandExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.ArtifactCommandExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Build.BuildCommandExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.CodeCoverage.CodeCoverageCommandExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.TestResults.ResultsCommandExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Telemetry.TelemetryCommandExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.Release.ReleaseCommandExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO ExtensionManager] Creating instance: Microsoft.VisualStudio.Services.Agent.Worker.PluginInternalCommandExtension, Agent.Worker
[2019-10-09 13:59:32Z INFO WorkerCommandManager] Register command extension for area task
[2019-10-09 13:59:32Z INFO WorkerCommandManager] Register command extension for area artifact
[2019-10-09 13:59:32Z INFO WorkerCommandManager] Register command extension for area build
[2019-10-09 13:59:32Z INFO WorkerCommandManager] Register command extension for area codecoverage
[2019-10-09 13:59:32Z INFO WorkerCommandManager] Register command extension for area results
[2019-10-09 13:59:32Z INFO WorkerCommandManager] Register command extension for area telemetry
[2019-10-09 13:59:32Z INFO WorkerCommandManager] Register command extension for area release
[2019-10-09 13:59:32Z INFO WorkerCommandManager] Register command extension for area plugininternal
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.Repository.CheckoutTask, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id '6d15af64-176c-496d-b583-fd2ae21d4df4' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.Repository.CleanupTask, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id '6d15af64-176c-496d-b583-fd2ae21d4df4' (post).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.DownloadPipelineArtifactTask, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id '61f2a582-95ae-4948-b34d-a1b3c4f6a737' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.PublishPipelineArtifactTask, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id 'ecdc45f6-832d-4ad9-b52b-ee49e94659be' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.PublishPipelineArtifactTaskV1, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id 'ecdc45f6-832d-4ad9-b52b-ee49e94659be' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.DownloadPipelineArtifactTaskV1, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id '61f2a582-95ae-4948-b34d-a1b3c4f6a737' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.DownloadPipelineArtifactTaskV1_1_0, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id '61f2a582-95ae-4948-b34d-a1b3c4f6a737' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineCache.SavePipelineCacheV0, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id 'd53ccab4-555e-4494-9d06-11db043fb4a9' (post).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineCache.RestorePipelineCacheV0, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id 'd53ccab4-555e-4494-9d06-11db043fb4a9' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.DownloadPipelineArtifactTaskV1_1_1, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id '61f2a582-95ae-4948-b34d-a1b3c4f6a737' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.DownloadPipelineArtifactTaskV1_1_2, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id '61f2a582-95ae-4948-b34d-a1b3c4f6a737' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.DownloadPipelineArtifactTaskV1_1_3, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id '61f2a582-95ae-4948-b34d-a1b3c4f6a737' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.DownloadPipelineArtifactTaskV2_0_0, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id '61f2a582-95ae-4948-b34d-a1b3c4f6a737' (main).
[2019-10-09 13:59:32Z INFO AgentPluginManager] Load task plugin from 'Agent.Plugins.PipelineArtifact.PublishPipelineArtifactTaskV0_140_0, Agent.Plugins'.
[2019-10-09 13:59:32Z INFO AgentPluginManager] Loaded task plugin id 'ecdc45f6-832d-4ad9-b52b-ee49e94659be' (main).
[2019-10-09 13:59:32Z INFO WorkerCommandManager] Enable plugin internal command extension.
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   File name: 'C:\agent3\bin\Agent.PluginHost.exe'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Arguments: 'task "Agent.Plugins.Repository.CheckoutTask, Agent.Plugins"'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Require exit code zero: 'True'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Encoding web name: utf-8 ; code page: '65001'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'True'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Persist current code page: 'False'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper] Process started with process id 5780, waiting for process exit.
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper] Close STDIN after the first redirect finished.
[2019-10-09 13:59:32Z INFO ProcessInvokerWrapper] STDIN stream write finished.
[2019-10-09 13:59:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:32Z INFO JobServerQueue] Try to upload 1 log files or attachments, success rate: 1/1.
[2019-10-09 13:59:33Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:33Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:35Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:37Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:37Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:37Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:37Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:38Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:38Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:38Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:38Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:39Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:39Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:40Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:40Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:40Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:40Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:41Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:42Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:42Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:43Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:55Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:55Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:56Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:57Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:58Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:58Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 13:59:58Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:00Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:01Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:01Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:01Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:02Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:05Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:06Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:06Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:07Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:08Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:09Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:09Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:10Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:10Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:10Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:12Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:12Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:13Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:13Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:14Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:15Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:16Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:16Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:17Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:18Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:18Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:19Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:20Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:20Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:21Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:24Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:25Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:25Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:25Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:29Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:29Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:30Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:30Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:31Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Finished process 5780 with exit code 0, and elapsed time 00:00:59.5165339.
[2019-10-09 14:00:32Z INFO WorkerCommandManager] Disable plugin internal command extension.
[2019-10-09 14:00:32Z INFO StepsRunner] Step result: 
[2019-10-09 14:00:32Z INFO StepsRunner] No need for updating job result with current step result 'Succeeded'.
[2019-10-09 14:00:32Z INFO StepsRunner] Current state: job state = ''
[2019-10-09 14:00:32Z INFO StepsRunner] Processing step: DisplayName='NuGet 5.0.2 verwenden', ContinueOnError=False, Enabled=True
[2019-10-09 14:00:32Z INFO ExpressionManager] Evaluating: succeeded()
[2019-10-09 14:00:32Z INFO ExpressionManager] Result: True
[2019-10-09 14:00:32Z INFO StepsRunner] Starting the step.
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:00:32Z INFO StepsRunner] Which: 'chcp'
[2019-10-09 14:00:32Z INFO StepsRunner] Location: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   File name: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Arguments: '65001'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Require exit code zero: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Encoding web name:  ; code page: ''
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Process started with process id 10744, waiting for process exit.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Finished process 10744 with exit code 0, and elapsed time 00:00:00.0095520.
[2019-10-09 14:00:32Z INFO StepsRunner] Successfully returned to code page 65001 (UTF8)
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 14:00:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\NuGetToolInstaller_2c65196a-54fd-4a02-9be8-d9d1837b7c5d\1.153.0\task.json'.
[2019-10-09 14:00:32Z INFO NodeHandler] Inspect node_modules folder, make sure vsts-task-lib doesn't overwrite String.startsWith/endsWith.
[2019-10-09 14:00:32Z INFO NodeHandler] This task has already been scanned and corrected, no more operation needed.
[2019-10-09 14:00:32Z INFO NodeHandler] Task.json has node10 handler data: False, use node10 for node tasks: False
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Externals': 'C:\agent3\externals'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   File name: 'C:\agent3\externals\node\bin\node.exe'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Arguments: '"C:\agent3\_work\_tasks\NuGetToolInstaller_2c65196a-54fd-4a02-9be8-d9d1837b7c5d\1.153.0\nugettoolinstaller.js"'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work\1\s'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Require exit code zero: 'True'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Encoding web name: utf-8 ; code page: '65001'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Process started with process id 15720, waiting for process exit.
[2019-10-09 14:00:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'f03d4b0b-5c7f-5a3c-32ca-d79e6a87d689', success rate: 1/1.
[2019-10-09 14:00:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record '69023f78-fff8-5e58-bc46-5dd9b052fdab', success rate: 1/1.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Finished process 15720 with exit code 0, and elapsed time 00:00:00.2665651.
[2019-10-09 14:00:32Z INFO StepsRunner] Step result: 
[2019-10-09 14:00:32Z INFO StepsRunner] No need for updating job result with current step result 'Succeeded'.
[2019-10-09 14:00:32Z INFO StepsRunner] Current state: job state = ''
[2019-10-09 14:00:32Z INFO StepsRunner] Processing step: DisplayName='NuGet restore Servicecenter.sln', ContinueOnError=False, Enabled=True
[2019-10-09 14:00:32Z INFO ExpressionManager] Evaluating: succeeded()
[2019-10-09 14:00:32Z INFO ExpressionManager] Result: True
[2019-10-09 14:00:32Z INFO StepsRunner] Starting the step.
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:00:32Z INFO StepsRunner] Which: 'chcp'
[2019-10-09 14:00:32Z INFO StepsRunner] Location: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   File name: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Arguments: '65001'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Require exit code zero: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Encoding web name:  ; code page: ''
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Process started with process id 13728, waiting for process exit.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Finished process 13728 with exit code 0, and elapsed time 00:00:00.0085685.
[2019-10-09 14:00:32Z INFO StepsRunner] Successfully returned to code page 65001 (UTF8)
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 14:00:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\NuGetCommand_333b11bd-d341-40d9-afcf-b32d5ce6f23b\2.153.2\task.json'.
[2019-10-09 14:00:32Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 14:00:32Z INFO BuildJobExtension] Build JobExtension resolving path use source provide: Servicecenter.sln
[2019-10-09 14:00:32Z INFO BuildJobExtension] The Default Path Root of Build JobExtension is build.sourcesDirectory: C:\agent3\_work\1\s
[2019-10-09 14:00:32Z INFO BuildJobExtension] After prefix Default Path Root provide by JobExtension: C:\agent3\_work\1\s\Servicecenter.sln
[2019-10-09 14:00:32Z INFO BuildJobExtension] Return absolute path after prefix DefaultPathRoot: C:\agent3\_work\1\s\Servicecenter.sln
[2019-10-09 14:00:32Z INFO TaskRunner] Build JobExtension resolved a rooted path:: C:\agent3\_work\1\s\Servicecenter.sln
[2019-10-09 14:00:32Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 14:00:32Z INFO BuildJobExtension] Build JobExtension resolving path use source provide: 
[2019-10-09 14:00:32Z INFO BuildJobExtension] The Default Path Root of Build JobExtension is build.sourcesDirectory: C:\agent3\_work\1\s
[2019-10-09 14:00:32Z INFO BuildJobExtension] After prefix Default Path Root provide by JobExtension: C:\agent3\_work\1\s
[2019-10-09 14:00:32Z INFO BuildJobExtension] Return absolute path after prefix DefaultPathRoot: C:\agent3\_work\1\s
[2019-10-09 14:00:32Z INFO TaskRunner] Build JobExtension resolved a rooted path:: C:\agent3\_work\1\s
[2019-10-09 14:00:32Z INFO TaskRunner] The original input is a rooted path, return absolute path: C:\agent3\_work\1\a\**\*.nupkg;!C:\agent3\_work\1\a\**\*.symbols.nupkg
[2019-10-09 14:00:32Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 14:00:32Z INFO BuildJobExtension] Build JobExtension resolving path use source provide: **\*.csproj
[2019-10-09 14:00:32Z INFO BuildJobExtension] The Default Path Root of Build JobExtension is build.sourcesDirectory: C:\agent3\_work\1\s
[2019-10-09 14:00:32Z INFO BuildJobExtension] After prefix Default Path Root provide by JobExtension: C:\agent3\_work\1\s\**\*.csproj
[2019-10-09 14:00:32Z INFO BuildJobExtension] Return absolute path after prefix DefaultPathRoot: C:\agent3\_work\1\s\**\*.csproj
[2019-10-09 14:00:32Z INFO TaskRunner] Build JobExtension resolved a rooted path:: C:\agent3\_work\1\s\**\*.csproj
[2019-10-09 14:00:32Z INFO TaskRunner] The original input is a rooted path, return absolute path: C:\agent3\_work\1\a
[2019-10-09 14:00:32Z INFO NodeHandler] Inspect node_modules folder, make sure vsts-task-lib doesn't overwrite String.startsWith/endsWith.
[2019-10-09 14:00:32Z INFO NodeHandler] This task has already been scanned and corrected, no more operation needed.
[2019-10-09 14:00:32Z INFO NodeHandler] Task.json has node10 handler data: False, use node10 for node tasks: False
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:32Z INFO HostContext] Well known directory 'Externals': 'C:\agent3\externals'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   File name: 'C:\agent3\externals\node\bin\node.exe'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Arguments: '"C:\agent3\_work\_tasks\NuGetCommand_333b11bd-d341-40d9-afcf-b32d5ce6f23b\2.153.2\nugetcommandmain.js"'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work\1\s'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Require exit code zero: 'True'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Encoding web name: utf-8 ; code page: '65001'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:00:32Z INFO ProcessInvokerWrapper] Process started with process id 8116, waiting for process exit.
[2019-10-09 14:00:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record '69023f78-fff8-5e58-bc46-5dd9b052fdab', success rate: 1/1.
[2019-10-09 14:00:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record '2801dbb3-35e3-532e-5a2e-9b20885fa494', success rate: 1/1.
[2019-10-09 14:00:32Z INFO JobServerQueue] Try to upload 2 log files or attachments, success rate: 2/2.
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] Finished process 8116 with exit code 0, and elapsed time 00:00:09.0667313.
[2019-10-09 14:00:41Z INFO StepsRunner] Step result: Succeeded
[2019-10-09 14:00:41Z INFO StepsRunner] No need for updating job result with current step result 'Succeeded'.
[2019-10-09 14:00:41Z INFO StepsRunner] Current state: job state = ''
[2019-10-09 14:00:41Z INFO StepsRunner] Processing step: DisplayName='Prepare analysis on SonarQube', ContinueOnError=False, Enabled=True
[2019-10-09 14:00:41Z INFO ExpressionManager] Evaluating: succeeded()
[2019-10-09 14:00:41Z INFO ExpressionManager] Result: True
[2019-10-09 14:00:41Z INFO StepsRunner] Starting the step.
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:00:41Z INFO StepsRunner] Which: 'chcp'
[2019-10-09 14:00:41Z INFO StepsRunner] Location: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   File name: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Arguments: '65001'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Require exit code zero: 'False'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Encoding web name:  ; code page: ''
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] Process started with process id 4644, waiting for process exit.
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] Finished process 4644 with exit code 0, and elapsed time 00:00:00.0092505.
[2019-10-09 14:00:41Z INFO StepsRunner] Successfully returned to code page 65001 (UTF8)
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 14:00:41Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\SonarQubePrepare_15b84ca1-b62f-4a2a-a403-89b77a063157\4.8.0\task.json'.
[2019-10-09 14:00:41Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 14:00:41Z INFO BuildJobExtension] Build JobExtension resolving path use source provide: sonar-project.properties
[2019-10-09 14:00:41Z INFO BuildJobExtension] The Default Path Root of Build JobExtension is build.sourcesDirectory: C:\agent3\_work\1\s
[2019-10-09 14:00:41Z INFO BuildJobExtension] After prefix Default Path Root provide by JobExtension: C:\agent3\_work\1\s\sonar-project.properties
[2019-10-09 14:00:41Z INFO BuildJobExtension] Return absolute path after prefix DefaultPathRoot: C:\agent3\_work\1\s\sonar-project.properties
[2019-10-09 14:00:41Z INFO TaskRunner] Build JobExtension resolved a rooted path:: C:\agent3\_work\1\s\sonar-project.properties
[2019-10-09 14:00:41Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 14:00:41Z INFO BuildJobExtension] Build JobExtension resolving path use source provide: .
[2019-10-09 14:00:41Z INFO BuildJobExtension] The Default Path Root of Build JobExtension is build.sourcesDirectory: C:\agent3\_work\1\s
[2019-10-09 14:00:41Z INFO BuildJobExtension] After prefix Default Path Root provide by JobExtension: C:\agent3\_work\1\s\.
[2019-10-09 14:00:41Z INFO BuildJobExtension] Return absolute path after prefix DefaultPathRoot: C:\agent3\_work\1\s
[2019-10-09 14:00:41Z INFO TaskRunner] Build JobExtension resolved a rooted path:: C:\agent3\_work\1\s
[2019-10-09 14:00:41Z INFO NodeHandler] Inspect node_modules folder, make sure vsts-task-lib doesn't overwrite String.startsWith/endsWith.
[2019-10-09 14:00:41Z INFO NodeHandler] This task has already been scanned and corrected, no more operation needed.
[2019-10-09 14:00:41Z INFO NodeHandler] Task.json has node10 handler data: False, use node10 for node tasks: False
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:41Z INFO HostContext] Well known directory 'Externals': 'C:\agent3\externals'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   File name: 'C:\agent3\externals\node\bin\node.exe'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Arguments: '"C:\agent3\_work\_tasks\SonarQubePrepare_15b84ca1-b62f-4a2a-a403-89b77a063157\4.8.0\prepare.js"'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work\1\s'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Require exit code zero: 'True'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Encoding web name: utf-8 ; code page: '65001'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:00:41Z INFO ProcessInvokerWrapper] Process started with process id 3464, waiting for process exit.
[2019-10-09 14:00:50Z INFO JobServerQueue] Try to append 1 batches web console lines for record '2801dbb3-35e3-532e-5a2e-9b20885fa494', success rate: 1/1.
[2019-10-09 14:00:50Z INFO JobServerQueue] Try to upload 1 log files or attachments, success rate: 1/1.
[2019-10-09 14:00:50Z INFO JobServerQueue] Try to append 6 batches web console lines for record '2801dbb3-35e3-532e-5a2e-9b20885fa494', success rate: 6/6.
[2019-10-09 14:00:50Z INFO JobServerQueue] Try to append 6 batches web console lines for record '2801dbb3-35e3-532e-5a2e-9b20885fa494', success rate: 6/6.
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] Finished process 3464 with exit code 0, and elapsed time 00:00:09.3664989.
[2019-10-09 14:00:50Z INFO StepsRunner] Step result: 
[2019-10-09 14:00:50Z INFO StepsRunner] No need for updating job result with current step result 'Succeeded'.
[2019-10-09 14:00:50Z INFO StepsRunner] Current state: job state = ''
[2019-10-09 14:00:50Z INFO StepsRunner] Processing step: DisplayName='Projektmappe Servicecenter.sln erstellen', ContinueOnError=False, Enabled=True
[2019-10-09 14:00:50Z INFO ExpressionManager] Evaluating: succeeded()
[2019-10-09 14:00:50Z INFO ExpressionManager] Result: True
[2019-10-09 14:00:50Z INFO StepsRunner] Starting the step.
[2019-10-09 14:00:50Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:50Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:50Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:00:50Z INFO StepsRunner] Which: 'chcp'
[2019-10-09 14:00:50Z INFO StepsRunner] Location: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   File name: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Arguments: '65001'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Require exit code zero: 'False'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Encoding web name:  ; code page: ''
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] Process started with process id 15152, waiting for process exit.
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] Finished process 15152 with exit code 0, and elapsed time 00:00:00.0091817.
[2019-10-09 14:00:50Z INFO StepsRunner] Successfully returned to code page 65001 (UTF8)
[2019-10-09 14:00:50Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:00:50Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:00:50Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:00:50Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 14:00:50Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\VSBuild_71a9a2d3-a98a-4caa-96ab-affca411ecda\1.151.2\task.json'.
[2019-10-09 14:00:50Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 14:00:50Z INFO BuildJobExtension] Build JobExtension resolving path use source provide: Servicecenter.sln
[2019-10-09 14:00:50Z INFO BuildJobExtension] The Default Path Root of Build JobExtension is build.sourcesDirectory: C:\agent3\_work\1\s
[2019-10-09 14:00:50Z INFO BuildJobExtension] After prefix Default Path Root provide by JobExtension: C:\agent3\_work\1\s\Servicecenter.sln
[2019-10-09 14:00:50Z INFO BuildJobExtension] Return absolute path after prefix DefaultPathRoot: C:\agent3\_work\1\s\Servicecenter.sln
[2019-10-09 14:00:50Z INFO TaskRunner] Build JobExtension resolved a rooted path:: C:\agent3\_work\1\s\Servicecenter.sln
[2019-10-09 14:00:50Z INFO PowerShellExeUtil] Generation: '1'
[2019-10-09 14:00:50Z INFO PowerShellExeUtil] Key name 'HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\PowerShell\1', value name 'Install': '1'
[2019-10-09 14:00:50Z INFO PowerShellExeUtil] Key name 'HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\PowerShell\1\PowerShellEngine', value name 'PowerShellVersion': '2.0'
[2019-10-09 14:00:50Z INFO PowerShellExeUtil] Unsupported version. Skipping.
[2019-10-09 14:00:50Z INFO PowerShellExeUtil] Generation: '3'
[2019-10-09 14:00:50Z INFO PowerShellExeUtil] Key name 'HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\PowerShell\3', value name 'Install': '1'
[2019-10-09 14:00:50Z INFO PowerShellExeUtil] Key name 'HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\PowerShell\3\PowerShellEngine', value name 'PowerShellVersion': '5.1.18362.1'
[2019-10-09 14:00:50Z INFO PowerShellExeUtil] Key name 'HKEY_LOCAL_MACHINE\SOFTWARE\Microsoft\PowerShell\3\PowerShellEngine', value name 'ApplicationBase': 'C:\Windows\System32\WindowsPowerShell\v1.0'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   File name: 'C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Arguments: '-NoLogo -Sta -NoProfile -NonInteractive -ExecutionPolicy Unrestricted -Command ". ([scriptblock]::Create('if ([Console]::InputEncoding -is [Text.UTF8Encoding] -and [Console]::InputEncoding.GetPreamble().Length -ne 0) { [Console]::InputEncoding = New-Object Text.UTF8Encoding $false } if (!$PSHOME) { $null = Get-Item -LiteralPath ''variable:PSHOME'' } else { Import-Module -Name ([System.IO.Path]::Combine($PSHOME, ''Modules\Microsoft.PowerShell.Management\Microsoft.PowerShell.Management.psd1'')) ; Import-Module -Name ([System.IO.Path]::Combine($PSHOME, ''Modules\Microsoft.PowerShell.Utility\Microsoft.PowerShell.Utility.psd1'')) }')) 2>&1 | ForEach-Object { Write-Verbose $_.Exception.Message -Verbose } ; Import-Module -Name 'C:\agent3\_work\_tasks\VSBuild_71a9a2d3-a98a-4caa-96ab-affca411ecda\1.151.2\ps_modules\VstsTaskSdk\VstsTaskSdk.psd1' -ArgumentList @{ NonInteractive = $true } -ErrorAction Stop ; $VerbosePreference = 'SilentlyContinue' ; $DebugPreference = 'SilentlyContinue' ; Invoke-VstsTaskScript -ScriptBlock ([scriptblock]::Create('. ''C:\agent3\_work\_tasks\VSBuild_71a9a2d3-a98a-4caa-96ab-affca411ecda\1.151.2\VSBuild.ps1'''))"'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work\_tasks\VSBuild_71a9a2d3-a98a-4caa-96ab-affca411ecda\1.151.2'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Require exit code zero: 'True'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Encoding web name:  ; code page: ''
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:00:50Z INFO ProcessInvokerWrapper] Process started with process id 11060, waiting for process exit.
[2019-10-09 14:00:51Z INFO JobServerQueue] Try to upload 1 log files or attachments, success rate: 1/1.
[2019-10-09 14:00:51Z INFO JobServerQueue] Try to append 6 batches web console lines for record '2801dbb3-35e3-532e-5a2e-9b20885fa494', success rate: 6/6.
[2019-10-09 14:00:51Z INFO JobServerQueue] Try to append 6 batches web console lines for record '2801dbb3-35e3-532e-5a2e-9b20885fa494', success rate: 6/6.
[2019-10-09 14:00:51Z INFO JobServerQueue] Try to append 6 batches web console lines for record '2801dbb3-35e3-532e-5a2e-9b20885fa494', success rate: 6/6.
[2019-10-09 14:00:52Z INFO JobServerQueue] Try to append 2 batches web console lines for record '2801dbb3-35e3-532e-5a2e-9b20885fa494', success rate: 2/2.
[2019-10-09 14:00:52Z INFO JobServerQueue] Try to append 1 batches web console lines for record '88cad227-c762-5712-e58e-6ca7de6fa956', success rate: 1/1.
[2019-10-09 14:00:52Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:00:52Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:00:52Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:00:53Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:00:53Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:00:54Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:00:54Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:00:54Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 14:00:54Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:00:54Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:00:55Z INFO JobServerQueue] Stop aggressive process web console line queue.
[2019-10-09 14:01:18Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:01:18Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 14:01:18Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:59:31Z INFO Worker] Cancellation/Shutdown message received.
[2019-10-09 14:59:31Z INFO ExpressionManager] Evaluating: succeeded()
[2019-10-09 14:59:31Z INFO ExpressionManager] Result: False
[2019-10-09 14:59:31Z INFO StepsRunner] Cancel current running step.
[2019-10-09 14:59:31Z INFO ProcessInvokerWrapper] Sending CTRL_C to process 11060.
[2019-10-09 14:59:31Z INFO ProcessInvokerWrapper] Successfully send CTRL_C to process 11060.
[2019-10-09 14:59:31Z INFO ProcessInvokerWrapper] Waiting for process exit or 7,5 seconds after CTRL_C signal fired.
[2019-10-09 14:59:31Z INFO ProcessInvokerWrapper] Ignore Ctrl+C to current process.
[2019-10-09 14:59:31Z INFO ExtensionManager] Getting extensions for interface: 'Microsoft.VisualStudio.Services.Agent.Worker.IJobExtension'
[2019-10-09 14:59:31Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] Process exit successfully.
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] Process cancelled successfully through Ctrl+C/SIGINT.
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] Finished process 11060 with exit code 1, and elapsed time 00:58:41.8489689.
[2019-10-09 14:59:32Z ERR  StepsRunner] Caught cancellation exception from step: System.OperationCanceledException: The operation was canceled.
   at System.Threading.CancellationToken.ThrowOperationCanceledException()
   at Microsoft.VisualStudio.Services.Agent.Util.ProcessInvoker.ExecuteAsync(String workingDirectory, String fileName, String arguments, IDictionary`2 environment, Boolean requireExitCodeZero, Encoding outputEncoding, Boolean killProcessOnCancel, InputQueue`1 redirectStandardIn, Boolean inheritConsoleHandler, Boolean keepStandardInOpen, Boolean highPriorityProcess, CancellationToken cancellationToken)
   at Microsoft.VisualStudio.Services.Agent.ProcessInvokerWrapper.ExecuteAsync(String workingDirectory, String fileName, String arguments, IDictionary`2 environment, Boolean requireExitCodeZero, Encoding outputEncoding, Boolean killProcessOnCancel, InputQueue`1 redirectStandardIn, Boolean inheritConsoleHandler, Boolean keepStandardInOpen, Boolean highPriorityProcess, CancellationToken cancellationToken)
   at Microsoft.VisualStudio.Services.Agent.Worker.Handlers.DefaultStepHost.ExecuteAsync(String workingDirectory, String fileName, String arguments, IDictionary`2 environment, Boolean requireExitCodeZero, Encoding outputEncoding, Boolean killProcessOnCancel, Boolean inheritConsoleHandler, CancellationToken cancellationToken)
   at Microsoft.VisualStudio.Services.Agent.Worker.Handlers.PowerShell3Handler.RunAsync()
   at Microsoft.VisualStudio.Services.Agent.Worker.TaskRunner.RunAsync()
   at Microsoft.VisualStudio.Services.Agent.Worker.StepsRunner.RunStepAsync(IStep step, CancellationToken jobCancellationToken)
[2019-10-09 14:59:32Z INFO StepsRunner] Step result: Canceled
[2019-10-09 14:59:32Z INFO StepsRunner] No need for updating job result with current step result 'Canceled'.
[2019-10-09 14:59:32Z INFO StepsRunner] Current state: job state = 'Canceled'
[2019-10-09 14:59:32Z INFO StepsRunner] Processing step: DisplayName='Run Code Analysis', ContinueOnError=False, Enabled=True
[2019-10-09 14:59:32Z INFO ExpressionManager] Evaluating: succeeded()
[2019-10-09 14:59:32Z INFO ExpressionManager] Result: False
[2019-10-09 14:59:32Z INFO StepsRunner] Skipping step due to condition evaluation.
[2019-10-09 14:59:32Z INFO StepsRunner] Processing step: DisplayName='Publish Quality Gate Result', ContinueOnError=False, Enabled=True
[2019-10-09 14:59:32Z INFO ExpressionManager] Evaluating: succeeded()
[2019-10-09 14:59:32Z INFO ExpressionManager] Result: False
[2019-10-09 14:59:32Z INFO StepsRunner] Skipping step due to condition evaluation.
[2019-10-09 14:59:32Z INFO StepsRunner] Processing step: DisplayName='Clean Agent Directories', ContinueOnError=False, Enabled=True
[2019-10-09 14:59:32Z INFO ExpressionManager] Evaluating: succeeded()
[2019-10-09 14:59:32Z INFO ExpressionManager] Result: False
[2019-10-09 14:59:32Z INFO StepsRunner] Skipping step due to condition evaluation.
[2019-10-09 14:59:32Z INFO StepsRunner] Processing step: DisplayName='Clean Agent Directories', ContinueOnError=False, Enabled=True
[2019-10-09 14:59:32Z INFO ExpressionManager] Evaluating: AlwaysNode()
[2019-10-09 14:59:32Z INFO ExpressionManager] Result: True
[2019-10-09 14:59:32Z INFO StepsRunner] Starting the step.
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:59:32Z INFO StepsRunner] Which: 'chcp'
[2019-10-09 14:59:32Z INFO StepsRunner] Location: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   File name: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Arguments: '65001'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Require exit code zero: 'False'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Encoding web name:  ; code page: ''
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] Process started with process id 4880, waiting for process exit.
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] Finished process 4880 with exit code 0, and elapsed time 00:00:00.0407197.
[2019-10-09 14:59:32Z INFO StepsRunner] Successfully returned to code page 65001 (UTF8)
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 14:59:32Z INFO TaskManager] Loading task definition 'C:\agent3\_work\_tasks\PostBuildCleanup_175c8a10-0ef0-11e7-936d-2100de00518d\3.0.9\task.json'.
[2019-10-09 14:59:32Z INFO NodeHandler] Inspect node_modules folder, make sure vsts-task-lib doesn't overwrite String.startsWith/endsWith.
[2019-10-09 14:59:32Z INFO NodeHandler] This task has already been scanned and corrected, no more operation needed.
[2019-10-09 14:59:32Z INFO NodeHandler] Task.json has node10 handler data: False, use node10 for node tasks: False
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:59:32Z INFO HostContext] Well known directory 'Externals': 'C:\agent3\externals'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   File name: 'C:\agent3\externals\node\bin\node.exe'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Arguments: '"C:\agent3\_work\_tasks\PostBuildCleanup_175c8a10-0ef0-11e7-936d-2100de00518d\3.0.9\cleanup.js"'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work\1\s'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Require exit code zero: 'True'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Encoding web name: utf-8 ; code page: '65001'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:59:32Z INFO ProcessInvokerWrapper] Process started with process id 10176, waiting for process exit.
[2019-10-09 14:59:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record '6a7ac225-8257-51f6-8eed-20c2e5179b9e', success rate: 1/1.
[2019-10-09 14:59:32Z INFO JobServerQueue] Try to append 1 batches web console lines for record '3eb9ccad-8fa9-446e-b0df-2b8c1ea75c9f', success rate: 1/1.
[2019-10-09 14:59:33Z INFO JobServerQueue] Try to upload 1 log files or attachments, success rate: 1/1.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] Finished process 10176 with exit code 0, and elapsed time 00:00:00.6108452.
[2019-10-09 14:59:33Z INFO StepsRunner] Step result: 
[2019-10-09 14:59:33Z INFO StepsRunner] No need for updating job result with current step result 'Succeeded'.
[2019-10-09 14:59:33Z INFO StepsRunner] Current state: job state = 'Canceled'
[2019-10-09 14:59:33Z INFO StepsRunner] Processing step: DisplayName='Checkout', ContinueOnError=False, Enabled=True
[2019-10-09 14:59:33Z INFO ExpressionManager] Evaluating: AlwaysNode()
[2019-10-09 14:59:33Z INFO ExpressionManager] Result: True
[2019-10-09 14:59:33Z INFO StepsRunner] Starting the step.
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:59:33Z INFO StepsRunner] Which: 'chcp'
[2019-10-09 14:59:33Z INFO StepsRunner] Location: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   File name: 'C:\WINDOWS\system32\chcp.COM'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Arguments: '65001'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Require exit code zero: 'False'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Encoding web name:  ; code page: ''
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'False'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Persist current code page: 'True'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] Process started with process id 12148, waiting for process exit.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] Finished process 12148 with exit code 0, and elapsed time 00:00:00.0319331.
[2019-10-09 14:59:33Z INFO StepsRunner] Successfully returned to code page 65001 (UTF8)
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Tasks': 'C:\agent3\_work\_tasks'
[2019-10-09 14:59:33Z INFO WorkerCommandManager] Enable plugin internal command extension.
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Work': 'C:\agent3\_work'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] Starting process:
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   File name: 'C:\agent3\bin\Agent.PluginHost.exe'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Arguments: 'task "Agent.Plugins.Repository.CleanupTask, Agent.Plugins"'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Working directory: 'C:\agent3\_work'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Require exit code zero: 'True'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Encoding web name: utf-8 ; code page: '65001'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Force kill process on cancellation: 'False'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Redirected STDIN: 'True'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Persist current code page: 'False'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   Keep redirected STDIN open: 'False'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper]   High priority process: 'False'
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] Process started with process id 7904, waiting for process exit.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] Close STDIN after the first redirect finished.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] STDIN stream write finished.
[2019-10-09 14:59:33Z INFO JobServerQueue] Try to append 1 batches web console lines for record '3eb9ccad-8fa9-446e-b0df-2b8c1ea75c9f', success rate: 1/1.
[2019-10-09 14:59:33Z INFO JobServerQueue] Try to append 1 batches web console lines for record '830d9e42-e6aa-43fe-88cc-51bf625ed203', success rate: 1/1.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] STDOUT/STDERR stream read finished.
[2019-10-09 14:59:33Z INFO ProcessInvokerWrapper] Finished process 7904 with exit code 0, and elapsed time 00:00:00.4208770.
[2019-10-09 14:59:33Z INFO WorkerCommandManager] Disable plugin internal command extension.
[2019-10-09 14:59:33Z INFO StepsRunner] Step result: 
[2019-10-09 14:59:33Z INFO StepsRunner] No need for updating job result with current step result 'Succeeded'.
[2019-10-09 14:59:33Z INFO StepsRunner] Current state: job state = 'Canceled'
[2019-10-09 14:59:33Z INFO JobRunner] Finalize job.
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Bin': 'C:\agent3\bin'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Root': 'C:\agent3'
[2019-10-09 14:59:33Z INFO HostContext] Well known directory 'Diag': 'C:\agent3\_diag'
[2019-10-09 14:59:33Z INFO BuildJobExtension] Total accessible running process: 146.
[2019-10-09 14:59:33Z INFO JobRunner] Job result after all job steps finish: Canceled
[2019-10-09 14:59:33Z INFO JobRunner] Completing the job execution context.
[2019-10-09 14:59:34Z INFO JobRunner] Shutting down the job server queue.
[2019-10-09 14:59:34Z INFO JobServerQueue] Fire signal to shutdown all queues.
[2019-10-09 14:59:34Z INFO JobServerQueue] All queue process task stopped.
[2019-10-09 14:59:34Z INFO JobServerQueue] Try to append 1 batches web console lines for record '830d9e42-e6aa-43fe-88cc-51bf625ed203', success rate: 1/1.
[2019-10-09 14:59:34Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'e7432cb3-b093-40cb-9ca3-9725ae530ff2', success rate: 1/1.
[2019-10-09 14:59:34Z INFO JobServerQueue] Try to append 1 batches web console lines for record 'fd490c07-0b22-5182-fac9-6d67fe1e939b', success rate: 1/1.
[2019-10-09 14:59:34Z INFO JobServerQueue] Web console line queue drained.
[2019-10-09 14:59:34Z INFO JobServerQueue] Uploading 4 files in one shot.
[2019-10-09 14:59:34Z INFO JobServerQueue] Try to upload 4 log files or attachments, success rate: 4/4.
[2019-10-09 14:59:34Z INFO JobServerQueue] File upload queue drained.
[2019-10-09 14:59:34Z INFO JobServerQueue] Timeline update queue drained.
[2019-10-09 14:59:34Z INFO JobServerQueue] All queue process tasks have been stopped, and all queues are drained.
[2019-10-09 14:59:34Z INFO TempDirectoryManager] Cleaning agent temp folder: C:\agent3\_work\_temp
[2019-10-09 14:59:34Z INFO JobRunner] Skip raise job completed event call from worker because Plan version is 6