Status: SUCCEEDED
Triggered by: -
Duration: 1 hour
Actions:

Definition (rev db79390766c74b5c78e905f2f711f95842d49a9d)

buildbucket: <
  server: "cr-buildbucket-dev.appspot.com"
  bucket: "luci.infra.ci"
  builder: "infra-continuous-win10-64"
>

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/infra/infra",
  "revision": "0dafd015355a9d91d82f54b1ffe9adfbf066a980"
}

Incoming tags

  • buildset:commit/git/0dafd015355a9d91d82f54b1ffe9adfbf066a980
  • buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/0dafd015355a9d91d82f54b1ffe9adfbf066a980
  • gitiles_ref:refs/heads/master

Debug log (UTC)

[19:43:56.452] New invocation is queued and will start shortly
[19:43:57.601] Starting the invocation (attempt 1)
[19:43:57.671] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[19:43:57.671] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[19:43:57.671] Buildbucket request:
{
  "bucket": "luci.infra.ci",
  "client_operation_id": "9036848992909794416",
  "parameters_json": "{\"builder_name\":\"infra-continuous-win10-64\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler-dev.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\",\"title\":\"739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"827aceb257188149c46b5b2a2fb142d88d3b9410\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@827aceb257188149c46b5b2a2fb142d88d3b9410\",\"title\":\"827aceb257188149c46b5b2a2fb142d88d3b9410\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/827aceb257188149c46b5b2a2fb142d88d3b9410\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\",\"title\":\"7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"c8f13c3233a13d8320b7881addd0db48491e5dd3\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c8f13c3233a13d8320b7881addd0db48491e5dd3\",\"title\":\"c8f13c3233a13d8320b7881addd0db48491e5dd3\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/c8f13c3233a13d8320b7881addd0db48491e5dd3\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"a9e93c5c0533156d240bd5e80a89f9ed280b10a3\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@a9e93c5c0533156d240bd5e80a89f9ed280b10a3\",\"title\":\"a9e93c5c0533156d240bd5e80a89f9ed280b10a3\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/a9e93c5c0533156d240bd5e80a89f9ed280b10a3\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"d827068436ad0ab514ced33867b6c0af51ada01b\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d827068436ad0ab514ced33867b6c0af51ada01b\",\"title\":\"d827068436ad0ab514ced33867b6c0af51ada01b\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/d827068436ad0ab514ced33867b6c0af51ada01b\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"0dafd015355a9d91d82f54b1ffe9adfbf066a980\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@0dafd015355a9d91d82f54b1ffe9adfbf066a980\",\"title\":\"0dafd015355a9d91d82f54b1ffe9adfbf066a980\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/0dafd015355a9d91d82f54b1ffe9adfbf066a980\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"0dafd015355a9d91d82f54b1ffe9adfbf066a980\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:infra-continuous-win10-64",
    "scheduler_invocation_id:9036848992909794416",
    "scheduler_job_id:infra/infra-continuous-win10-64",
    "user_agent:luci-scheduler-dev",
    "buildset:commit/git/0dafd015355a9d91d82f54b1ffe9adfbf066a980",
    "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/0dafd015355a9d91d82f54b1ffe9adfbf066a980",
    "gitiles_ref:refs/heads/master"
  ]
}
[19:43:58.609] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1597952637800271",
    "id": "8871418930824959776",
    "parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\", \"title\": \"739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"827aceb257188149c46b5b2a2fb142d88d3b9410\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@827aceb257188149c46b5b2a2fb142d88d3b9410\", \"title\": \"827aceb257188149c46b5b2a2fb142d88d3b9410\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/827aceb257188149c46b5b2a2fb142d88d3b9410\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\", \"title\": \"7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c8f13c3233a13d8320b7881addd0db48491e5dd3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c8f13c3233a13d8320b7881addd0db48491e5dd3\", \"title\": \"c8f13c3233a13d8320b7881addd0db48491e5dd3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c8f13c3233a13d8320b7881addd0db48491e5dd3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"a9e93c5c0533156d240bd5e80a89f9ed280b10a3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@a9e93c5c0533156d240bd5e80a89f9ed280b10a3\", \"title\": \"a9e93c5c0533156d240bd5e80a89f9ed280b10a3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/a9e93c5c0533156d240bd5e80a89f9ed280b10a3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"d827068436ad0ab514ced33867b6c0af51ada01b\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d827068436ad0ab514ced33867b6c0af51ada01b\", \"title\": \"d827068436ad0ab514ced33867b6c0af51ada01b\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/d827068436ad0ab514ced33867b6c0af51ada01b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"0dafd015355a9d91d82f54b1ffe9adfbf066a980\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@0dafd015355a9d91d82f54b1ffe9adfbf066a980\", \"title\": \"0dafd015355a9d91d82f54b1ffe9adfbf066a980\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/0dafd015355a9d91d82f54b1ffe9adfbf066a980\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"0dafd015355a9d91d82f54b1ffe9adfbf066a980\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1597952638452731",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/17549",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/0dafd015355a9d91d82f54b1ffe9adfbf066a980",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/0dafd015355a9d91d82f54b1ffe9adfbf066a980",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9036848992909794416",
      "scheduler_job_id:infra/infra-continuous-win10-64",
      "swarming_hostname:chromium-swarm-dev.appspot.com",
      "swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8871418930824959776/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:recipe_name:infra_continuous",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:",
      "user_agent:luci-scheduler-dev"
    ],
    "updated_ts": "1597952638452851",
    "url": "https://luci-milo-dev.appspot.com/b/8871418930824959776",
    "utcnow_ts": "1597952638597204"
  }
}
[19:43:58.609] Task URL: https://luci-milo-dev.appspot.com/b/8871418930824959776
[19:43:58.609] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:2:0) after 1m0s
[19:44:58.630] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:2:0)
[19:44:58.630] Timer tick, asking Buildbucket for the build status
[19:44:58.806] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:58.806] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:3:0) after 1m0s
[19:45:58.831] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:3:0)
[19:45:58.831] Timer tick, asking Buildbucket for the build status
[19:45:58.946] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:58.946] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:4:0) after 1m0s
[19:46:58.988] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:4:0)
[19:46:58.988] Timer tick, asking Buildbucket for the build status
[19:46:59.113] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:59.113] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:5:0) after 1m0s
[19:47:59.195] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:5:0)
[19:47:59.195] Timer tick, asking Buildbucket for the build status
[19:47:59.337] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:59.337] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:6:0) after 1m0s
[19:48:59.362] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:6:0)
[19:48:59.362] Timer tick, asking Buildbucket for the build status
[19:48:59.519] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:59.519] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:7:0) after 1m0s
[19:49:59.593] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:7:0)
[19:49:59.593] Timer tick, asking Buildbucket for the build status
[19:49:59.774] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:59.774] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:8:0) after 1m0s
[19:50:59.813] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:8:0)
[19:50:59.815] Timer tick, asking Buildbucket for the build status
[19:50:59.940] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:59.940] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:9:0) after 1m0s
[19:51:59.963] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:9:0)
[19:51:59.963] Timer tick, asking Buildbucket for the build status
[19:52:00.126] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:00.126] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:10:0) after 1m0s
[19:53:00.151] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:10:0)
[19:53:00.151] Timer tick, asking Buildbucket for the build status
[19:53:00.275] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:00.275] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:11:0) after 1m0s
[19:54:00.302] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:11:0)
[19:54:00.302] Timer tick, asking Buildbucket for the build status
[19:54:00.543] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:00.543] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:12:0) after 1m0s
[19:55:00.583] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:12:0)
[19:55:00.583] Timer tick, asking Buildbucket for the build status
[19:55:00.689] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:00.689] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:13:0) after 1m0s
[19:56:00.738] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:13:0)
[19:56:00.738] Timer tick, asking Buildbucket for the build status
[19:56:00.951] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:00.951] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:14:0) after 1m0s
[19:57:00.974] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:14:0)
[19:57:00.974] Timer tick, asking Buildbucket for the build status
[19:57:01.202] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:01.202] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:15:0) after 1m0s
[19:58:01.293] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:15:0)
[19:58:01.293] Timer tick, asking Buildbucket for the build status
[19:58:01.426] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:01.426] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:16:0) after 1m0s
[19:59:01.448] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:16:0)
[19:59:01.448] Timer tick, asking Buildbucket for the build status
[19:59:01.622] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:01.622] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:17:0) after 1m0s
[20:00:01.648] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:17:0)
[20:00:01.648] Timer tick, asking Buildbucket for the build status
[20:00:01.812] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:01.812] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:18:0) after 1m0s
[20:01:01.937] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:18:0)
[20:01:01.937] Timer tick, asking Buildbucket for the build status
[20:01:02.147] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:02.147] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:19:0) after 1m0s
[20:02:02.168] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:19:0)
[20:02:02.168] Timer tick, asking Buildbucket for the build status
[20:02:02.393] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:02.394] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:20:0) after 1m0s
[20:03:02.422] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:20:0)
[20:03:02.422] Timer tick, asking Buildbucket for the build status
[20:03:02.607] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:02.607] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:21:0) after 1m0s
[20:04:02.631] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:21:0)
[20:04:02.631] Timer tick, asking Buildbucket for the build status
[20:04:02.825] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:02.825] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:22:0) after 1m0s
[20:05:02.905] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:22:0)
[20:05:02.905] Timer tick, asking Buildbucket for the build status
[20:05:03.074] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:03.081] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:23:0) after 1m0s
[20:06:03.120] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:23:0)
[20:06:03.120] Timer tick, asking Buildbucket for the build status
[20:06:03.570] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:03.570] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:24:0) after 1m0s
[20:07:03.597] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:24:0)
[20:07:03.597] Timer tick, asking Buildbucket for the build status
[20:07:03.736] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:03.736] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:25:0) after 1m0s
[20:08:03.798] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:25:0)
[20:08:03.798] Timer tick, asking Buildbucket for the build status
[20:08:03.966] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:03.966] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:26:0) after 1m0s
[20:09:04.087] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:26:0)
[20:09:04.087] Timer tick, asking Buildbucket for the build status
[20:09:04.314] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:04.314] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:27:0) after 1m0s
[20:10:04.336] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:27:0)
[20:10:04.336] Timer tick, asking Buildbucket for the build status
[20:10:04.502] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:04.502] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:28:0) after 1m0s
[20:11:04.610] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:28:0)
[20:11:04.610] Timer tick, asking Buildbucket for the build status
[20:11:04.744] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:04.744] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:29:0) after 1m0s
[20:12:04.782] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:29:0)
[20:12:04.782] Timer tick, asking Buildbucket for the build status
[20:12:04.931] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:04.931] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:30:0) after 1m0s
[20:13:04.970] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:30:0)
[20:13:04.970] Timer tick, asking Buildbucket for the build status
[20:13:05.163] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:05.163] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:31:0) after 1m0s
[20:14:05.233] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:31:0)
[20:14:05.235] Timer tick, asking Buildbucket for the build status
[20:14:05.497] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:05.497] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:32:0) after 1m0s
[20:15:05.520] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:32:0)
[20:15:05.520] Timer tick, asking Buildbucket for the build status
[20:15:05.675] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:05.675] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:33:0) after 1m0s
[20:16:05.696] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:33:0)
[20:16:05.696] Timer tick, asking Buildbucket for the build status
[20:16:05.843] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:05.843] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:34:0) after 1m0s
[20:17:05.888] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:34:0)
[20:17:05.888] Timer tick, asking Buildbucket for the build status
[20:17:06.014] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:06.014] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:35:0) after 1m0s
[20:18:06.039] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:35:0)
[20:18:06.039] Timer tick, asking Buildbucket for the build status
[20:18:06.225] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:06.225] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:36:0) after 1m0s
[20:19:06.252] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:36:0)
[20:19:06.252] Timer tick, asking Buildbucket for the build status
[20:19:06.454] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:06.454] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:37:0) after 1m0s
[20:20:06.477] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:37:0)
[20:20:06.477] Timer tick, asking Buildbucket for the build status
[20:20:06.619] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:06.619] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:38:0) after 1m0s
[20:21:06.648] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:38:0)
[20:21:06.648] Timer tick, asking Buildbucket for the build status
[20:21:06.776] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:06.776] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:39:0) after 1m0s
[20:22:06.801] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:39:0)
[20:22:06.801] Timer tick, asking Buildbucket for the build status
[20:22:06.928] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:06.928] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:40:0) after 1m0s
[20:23:06.958] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:40:0)
[20:23:06.958] Timer tick, asking Buildbucket for the build status
[20:23:07.125] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:07.125] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:41:0) after 1m0s
[20:24:07.207] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:41:0)
[20:24:07.207] Timer tick, asking Buildbucket for the build status
[20:24:07.416] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:07.416] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:42:0) after 1m0s
[20:25:07.490] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:42:0)
[20:25:07.490] Timer tick, asking Buildbucket for the build status
[20:25:07.726] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:07.726] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:43:0) after 1m0s
[20:26:07.753] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:43:0)
[20:26:07.753] Timer tick, asking Buildbucket for the build status
[20:26:07.902] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:07.902] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:44:0) after 1m0s
[20:27:07.991] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:44:0)
[20:27:07.991] Timer tick, asking Buildbucket for the build status
[20:27:08.134] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:08.134] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:45:0) after 1m0s
[20:28:08.188] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:45:0)
[20:28:08.188] Timer tick, asking Buildbucket for the build status
[20:28:08.572] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:08.572] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:46:0) after 1m0s
[20:29:08.602] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:46:0)
[20:29:08.602] Timer tick, asking Buildbucket for the build status
[20:29:09.087] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:09.087] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:47:0) after 1m0s
[20:30:09.179] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:47:0)
[20:30:09.179] Timer tick, asking Buildbucket for the build status
[20:30:09.607] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:09.607] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:48:0) after 1m0s
[20:31:09.720] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:48:0)
[20:31:09.720] Timer tick, asking Buildbucket for the build status
[20:31:10.274] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:10.274] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:49:0) after 1m0s
[20:32:10.391] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:49:0)
[20:32:10.391] Timer tick, asking Buildbucket for the build status
[20:32:10.936] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:10.936] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:50:0) after 1m0s
[20:33:10.964] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:50:0)
[20:33:10.964] Timer tick, asking Buildbucket for the build status
[20:33:11.537] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:11.537] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:51:0) after 1m0s
[20:34:11.600] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:51:0)
[20:34:11.600] Timer tick, asking Buildbucket for the build status
[20:34:11.942] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:11.942] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:52:0) after 1m0s
[20:35:11.948] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:52:0)
[20:35:11.948] Timer tick, asking Buildbucket for the build status
[20:35:12.361] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:12.361] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:53:0) after 1m0s
[20:36:12.388] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:53:0)
[20:36:12.388] Timer tick, asking Buildbucket for the build status
[20:36:12.877] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:12.877] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:54:0) after 1m0s
[20:37:12.989] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:54:0)
[20:37:12.989] Timer tick, asking Buildbucket for the build status
[20:37:13.429] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:13.429] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:55:0) after 1m0s
[20:38:13.524] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:55:0)
[20:38:13.524] Timer tick, asking Buildbucket for the build status
[20:38:13.938] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:38:13.938] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:56:0) after 1m0s
[20:39:14.003] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:56:0)
[20:39:14.003] Timer tick, asking Buildbucket for the build status
[20:39:14.338] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:14.338] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:57:0) after 1m0s
[20:40:14.367] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:57:0)
[20:40:14.367] Timer tick, asking Buildbucket for the build status
[20:40:14.749] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:40:14.749] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:58:0) after 1m0s
[20:41:14.775] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:58:0)
[20:41:14.775] Timer tick, asking Buildbucket for the build status
[20:41:15.250] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:15.250] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:59:0) after 1m0s
[20:42:15.284] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:59:0)
[20:42:15.284] Timer tick, asking Buildbucket for the build status
[20:42:15.656] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:15.656] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:60:0) after 1m0s
[20:43:15.696] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:60:0)
[20:43:15.696] Timer tick, asking Buildbucket for the build status
[20:43:16.084] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:16.084] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:61:0) after 1m0s
[20:44:16.118] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:61:0)
[20:44:16.118] Timer tick, asking Buildbucket for the build status
[20:44:16.542] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:16.542] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:62:0) after 1m0s
[20:45:16.567] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:62:0)
[20:45:16.567] Timer tick, asking Buildbucket for the build status
[20:45:17.066] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:17.066] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:63:0) after 1m0s
[20:46:17.176] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:63:0)
[20:46:17.176] Timer tick, asking Buildbucket for the build status
[20:46:17.556] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:17.556] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:64:0) after 1m0s
[20:47:17.596] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:64:0)
[20:47:17.596] Timer tick, asking Buildbucket for the build status
[20:47:18.118] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:18.118] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:65:0) after 1m0s
[20:48:18.147] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:65:0)
[20:48:18.147] Timer tick, asking Buildbucket for the build status
[20:48:18.757] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:18.757] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:66:0) after 1m0s
[20:49:18.891] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:66:0)
[20:49:18.891] Timer tick, asking Buildbucket for the build status
[20:49:19.365] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:19.365] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:67:0) after 1m0s
[20:50:19.392] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:67:0)
[20:50:19.392] Timer tick, asking Buildbucket for the build status
[20:50:19.737] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:19.737] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:68:0) after 1m0s
[20:51:19.765] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:68:0)
[20:51:19.765] Timer tick, asking Buildbucket for the build status
[20:51:21.104] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:21.104] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:69:0) after 1m0s
[20:52:21.131] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:69:0)
[20:52:21.131] Timer tick, asking Buildbucket for the build status
[20:52:21.507] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:21.507] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:70:0) after 1m0s
[20:53:21.561] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:70:0)
[20:53:21.561] Timer tick, asking Buildbucket for the build status
[20:53:21.955] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:21.955] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:71:0) after 1m0s
[20:54:21.989] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:71:0)
[20:54:21.989] Timer tick, asking Buildbucket for the build status
[20:54:22.451] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:22.451] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:72:0) after 1m0s
[20:55:22.481] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:72:0)
[20:55:22.481] Timer tick, asking Buildbucket for the build status
[20:55:22.925] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:22.925] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:73:0) after 1m0s
[20:56:23.008] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:73:0)
[20:56:23.008] Timer tick, asking Buildbucket for the build status
[20:56:23.457] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:23.457] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:74:0) after 1m0s
[20:57:23.489] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:74:0)
[20:57:23.489] Timer tick, asking Buildbucket for the build status
[20:57:24.644] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:24.644] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:75:0) after 1m0s
[20:58:24.701] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:75:0)
[20:58:24.701] Timer tick, asking Buildbucket for the build status
[20:58:25.092] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:25.092] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:76:0) after 1m0s
[20:59:25.135] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:76:0)
[20:59:25.135] Timer tick, asking Buildbucket for the build status
[20:59:25.736] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:25.736] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:77:0) after 1m0s
[21:00:25.784] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:77:0)
[21:00:25.784] Timer tick, asking Buildbucket for the build status
[21:00:26.470] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:26.470] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:78:0) after 1m0s
[21:01:26.507] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:78:0)
[21:01:26.507] Timer tick, asking Buildbucket for the build status
[21:01:26.947] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:26.947] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:79:0) after 1m0s
[21:02:26.979] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:79:0)
[21:02:26.979] Timer tick, asking Buildbucket for the build status
[21:02:27.402] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:27.402] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:80:0) after 1m0s
[21:03:27.488] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:80:0)
[21:03:27.488] Timer tick, asking Buildbucket for the build status
[21:03:27.886] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:27.886] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:81:0) after 1m0s
[21:04:27.927] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:81:0)
[21:04:27.927] Timer tick, asking Buildbucket for the build status
[21:04:28.294] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:28.294] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:82:0) after 1m0s
[21:05:28.318] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:82:0)
[21:05:28.318] Timer tick, asking Buildbucket for the build status
[21:05:28.797] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:28.797] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:83:0) after 1m0s
[21:06:28.833] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:83:0)
[21:06:28.833] Timer tick, asking Buildbucket for the build status
[21:06:29.276] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:29.276] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:84:0) after 1m0s
[21:07:29.308] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:84:0)
[21:07:29.308] Timer tick, asking Buildbucket for the build status
[21:07:29.738] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:29.738] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:85:0) after 1m0s
[21:08:29.771] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:85:0)
[21:08:29.771] Timer tick, asking Buildbucket for the build status
[21:08:30.213] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:30.213] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:86:0) after 1m0s
[21:09:30.292] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:86:0)
[21:09:30.292] Timer tick, asking Buildbucket for the build status
[21:09:30.591] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:30.591] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:87:0) after 1m0s
[21:10:30.624] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:87:0)
[21:10:30.624] Timer tick, asking Buildbucket for the build status
[21:10:31.133] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:31.134] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:88:0) after 1m0s
[21:11:31.211] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:88:0)
[21:11:31.211] Timer tick, asking Buildbucket for the build status
[21:11:31.544] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:31.545] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:89:0) after 1m0s
[21:12:31.579] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:89:0)
[21:12:31.579] Timer tick, asking Buildbucket for the build status
[21:12:32.057] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:32.057] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:90:0) after 1m0s
[21:13:32.186] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:90:0)
[21:13:32.186] Timer tick, asking Buildbucket for the build status
[21:13:32.405] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:32.405] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:91:0) after 1m0s
[21:14:32.438] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:91:0)
[21:14:32.438] Timer tick, asking Buildbucket for the build status
[21:14:32.944] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:32.944] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:92:0) after 1m0s
[21:15:33.030] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:92:0)
[21:15:33.030] Timer tick, asking Buildbucket for the build status
[21:15:33.927] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:33.927] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:93:0) after 1m0s
[21:16:33.958] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:93:0)
[21:16:33.958] Timer tick, asking Buildbucket for the build status
[21:16:34.365] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:34.365] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:94:0) after 1m0s
[21:17:34.411] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:94:0)
[21:17:34.411] Timer tick, asking Buildbucket for the build status
[21:17:34.884] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:34.884] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:95:0) after 1m0s
[21:18:34.917] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:95:0)
[21:18:34.917] Timer tick, asking Buildbucket for the build status
[21:18:35.358] Build 8871418930824959776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:35.358] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:96:0) after 1m0s
[21:18:45.129] Received PubSub notification, asking Buildbucket for the build status
[21:18:45.278] Build 8871418930824959776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:35.412] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:96:0)
[21:19:35.412] Timer tick, asking Buildbucket for the build status
[21:19:35.798] Build 8871418930824959776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:35.798] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:98:0) after 1m0s
[21:20:35.849] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:98:0)
[21:20:35.849] Timer tick, asking Buildbucket for the build status
[21:20:36.350] Build 8871418930824959776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:36.350] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:99:0) after 1m0s
[21:21:36.379] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:99:0)
[21:21:36.379] Timer tick, asking Buildbucket for the build status
[21:21:36.832] Build 8871418930824959776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:36.832] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:100:0) after 1m0s
[21:22:36.918] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:100:0)
[21:22:36.918] Timer tick, asking Buildbucket for the build status
[21:22:37.373] Build 8871418930824959776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:37.373] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:101:0) after 1m0s
[21:23:37.495] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:101:0)
[21:23:37.495] Timer tick, asking Buildbucket for the build status
[21:23:37.843] Build 8871418930824959776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:37.843] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:102:0) after 1m0s
[21:24:37.877] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:102:0)
[21:24:37.877] Timer tick, asking Buildbucket for the build status
[21:24:38.246] Build 8871418930824959776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:38.246] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:103:0) after 1m0s
[21:25:38.276] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:103:0)
[21:25:38.276] Timer tick, asking Buildbucket for the build status
[21:25:38.651] Build 8871418930824959776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:38.651] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:104:0) after 1m0s
[21:26:38.689] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:104:0)
[21:26:38.689] Timer tick, asking Buildbucket for the build status
[21:26:39.120] Build 8871418930824959776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:39.120] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9036848992909794416:105:0) after 1m0s
[21:26:47.585] Received PubSub notification, asking Buildbucket for the build status
[21:26:47.705] Build 8871418930824959776: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:26:47.705] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary_preference": "PROD",
    "completed_ts": "1597958805975359",
    "created_by": "project:infra",
    "created_ts": "1597952637800271",
    "id": "8871418930824959776",
    "parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\", \"title\": \"739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/739d3b4a2cb27ae2a0ddaf591f8db0c88692c9fc\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"827aceb257188149c46b5b2a2fb142d88d3b9410\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@827aceb257188149c46b5b2a2fb142d88d3b9410\", \"title\": \"827aceb257188149c46b5b2a2fb142d88d3b9410\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/827aceb257188149c46b5b2a2fb142d88d3b9410\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\", \"title\": \"7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/7f711ce1ea071b2f3d804396bd3b15a0b92c39b1\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c8f13c3233a13d8320b7881addd0db48491e5dd3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c8f13c3233a13d8320b7881addd0db48491e5dd3\", \"title\": \"c8f13c3233a13d8320b7881addd0db48491e5dd3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c8f13c3233a13d8320b7881addd0db48491e5dd3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"a9e93c5c0533156d240bd5e80a89f9ed280b10a3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@a9e93c5c0533156d240bd5e80a89f9ed280b10a3\", \"title\": \"a9e93c5c0533156d240bd5e80a89f9ed280b10a3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/a9e93c5c0533156d240bd5e80a89f9ed280b10a3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"d827068436ad0ab514ced33867b6c0af51ada01b\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d827068436ad0ab514ced33867b6c0af51ada01b\", \"title\": \"d827068436ad0ab514ced33867b6c0af51ada01b\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/d827068436ad0ab514ced33867b6c0af51ada01b\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"0dafd015355a9d91d82f54b1ffe9adfbf066a980\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@0dafd015355a9d91d82f54b1ffe9adfbf066a980\", \"title\": \"0dafd015355a9d91d82f54b1ffe9adfbf066a980\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/0dafd015355a9d91d82f54b1ffe9adfbf066a980\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"0dafd015355a9d91d82f54b1ffe9adfbf066a980\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"got_revision\": \"0dafd015355a9d91d82f54b1ffe9adfbf066a980\", \"got_revision_cp\": \"refs/heads/master@{#34414}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_82ed111fed7ea8169e482f00b5f3e5338a65daa41208585de67cb0a736b1d538_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"git\", \"goma\", \"infra_gclient_with_go\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-p0tj\"], \"image\": [\"chrome-win10-1703-20081700-d9392568d25\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5498-3454aa6\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
    "service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
    "started_ts": "1597958322068361",
    "status": "COMPLETED",
    "status_changed_ts": "1597958806305884",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/17549",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/0dafd015355a9d91d82f54b1ffe9adfbf066a980",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/0dafd015355a9d91d82f54b1ffe9adfbf066a980",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9036848992909794416",
      "scheduler_job_id:infra/infra-continuous-win10-64",
      "swarming_hostname:chromium-swarm-dev.appspot.com",
      "swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8871418930824959776/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:os:Windows",
      "swarming_tag:recipe_name:infra_continuous",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_task_id:4e2637c7bfded810",
      "user_agent:luci-scheduler-dev"
    ],
    "updated_ts": "1597958806350216",
    "url": "https://luci-milo-dev.appspot.com/b/8871418930824959776",
    "utcnow_ts": "1597958807689723"
  }
}
[21:26:47.705] Invocation finished in 1h42m51.278044679s with status SUCCEEDED