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": "d6e6681a8827f1b7efaa76279c99bf3f9aaa07de"
}

Incoming tags

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

Debug log (UTC)

[23:45:38.228] New invocation is queued and will start shortly
[23:45:39.361] Starting the invocation (attempt 1)
[23:45:39.419] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[23:45:39.419] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[23:45:39.420] Buildbucket request:
{
  "bucket": "luci.infra.ci",
  "client_operation_id": "9021251108532099152",
  "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\":\"d1a000fa3c9a313323ff12189cb84d9c98666884\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d1a000fa3c9a313323ff12189cb84d9c98666884\",\"title\":\"d1a000fa3c9a313323ff12189cb84d9c98666884\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/d1a000fa3c9a313323ff12189cb84d9c98666884\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"61cd2b9f441fda4d9b239a267fa211977d78f5f2\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@61cd2b9f441fda4d9b239a267fa211977d78f5f2\",\"title\":\"61cd2b9f441fda4d9b239a267fa211977d78f5f2\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/61cd2b9f441fda4d9b239a267fa211977d78f5f2\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"f974c23e1e4762c09c38947d0f89877e04d819ed\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f974c23e1e4762c09c38947d0f89877e04d819ed\",\"title\":\"f974c23e1e4762c09c38947d0f89877e04d819ed\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/f974c23e1e4762c09c38947d0f89877e04d819ed\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"48aa51a8f2290a67188c4c1899fa31b6e097a1ba\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@48aa51a8f2290a67188c4c1899fa31b6e097a1ba\",\"title\":\"48aa51a8f2290a67188c4c1899fa31b6e097a1ba\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/48aa51a8f2290a67188c4c1899fa31b6e097a1ba\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\",\"title\":\"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\"}}",
  "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:9021251108532099152",
    "scheduler_job_id:infra/infra-continuous-win10-64",
    "user_agent:luci-scheduler-dev",
    "buildset:commit/git/d6e6681a8827f1b7efaa76279c99bf3f9aaa07de",
    "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/d6e6681a8827f1b7efaa76279c99bf3f9aaa07de",
    "gitiles_ref:refs/heads/master"
  ]
}
[23:45:40.259] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:infra",
    "created_ts": "1612827939647864",
    "id": "8855821046314455440",
    "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\": \"d1a000fa3c9a313323ff12189cb84d9c98666884\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d1a000fa3c9a313323ff12189cb84d9c98666884\", \"title\": \"d1a000fa3c9a313323ff12189cb84d9c98666884\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/d1a000fa3c9a313323ff12189cb84d9c98666884\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"61cd2b9f441fda4d9b239a267fa211977d78f5f2\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@61cd2b9f441fda4d9b239a267fa211977d78f5f2\", \"title\": \"61cd2b9f441fda4d9b239a267fa211977d78f5f2\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/61cd2b9f441fda4d9b239a267fa211977d78f5f2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f974c23e1e4762c09c38947d0f89877e04d819ed\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f974c23e1e4762c09c38947d0f89877e04d819ed\", \"title\": \"f974c23e1e4762c09c38947d0f89877e04d819ed\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f974c23e1e4762c09c38947d0f89877e04d819ed\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"48aa51a8f2290a67188c4c1899fa31b6e097a1ba\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@48aa51a8f2290a67188c4c1899fa31b6e097a1ba\", \"title\": \"48aa51a8f2290a67188c4c1899fa31b6e097a1ba\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/48aa51a8f2290a67188c4c1899fa31b6e097a1ba\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\", \"title\": \"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1612827940143386",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/18557",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/d6e6681a8827f1b7efaa76279c99bf3f9aaa07de",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/d6e6681a8827f1b7efaa76279c99bf3f9aaa07de",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021251108532099152",
      "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/8855821046314455440/+/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": "1612827940143494",
    "url": "https://luci-milo-dev.appspot.com/b/8855821046314455440",
    "utcnow_ts": "1612827940250134"
  }
}
[23:45:40.259] Task URL: https://luci-milo-dev.appspot.com/b/8855821046314455440
[23:45:40.259] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:2:0) after 1m0s
[23:46:40.290] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:2:0)
[23:46:40.290] Timer tick, asking Buildbucket for the build status
[23:46:40.408] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:40.408] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:3:0) after 1m0s
[23:47:40.436] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:3:0)
[23:47:40.436] Timer tick, asking Buildbucket for the build status
[23:47:40.523] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:40.523] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:4:0) after 1m0s
[23:48:40.544] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:4:0)
[23:48:40.544] Timer tick, asking Buildbucket for the build status
[23:48:40.624] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:40.624] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:5:0) after 1m0s
[23:49:40.650] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:5:0)
[23:49:40.650] Timer tick, asking Buildbucket for the build status
[23:49:40.741] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:40.741] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:6:0) after 1m0s
[23:50:40.760] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:6:0)
[23:50:40.760] Timer tick, asking Buildbucket for the build status
[23:50:40.848] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:40.848] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:7:0) after 1m0s
[23:51:40.897] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:7:0)
[23:51:40.897] Timer tick, asking Buildbucket for the build status
[23:51:40.973] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:40.973] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:8:0) after 1m0s
[23:52:41.001] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:8:0)
[23:52:41.001] Timer tick, asking Buildbucket for the build status
[23:52:41.088] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:41.088] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:9:0) after 1m0s
[23:53:41.199] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:9:0)
[23:53:41.199] Timer tick, asking Buildbucket for the build status
[23:53:41.304] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:41.304] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:10:0) after 1m0s
[23:54:41.338] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:10:0)
[23:54:41.338] Timer tick, asking Buildbucket for the build status
[23:54:41.543] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:41.543] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:11:0) after 1m0s
[23:55:41.582] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:11:0)
[23:55:41.582] Timer tick, asking Buildbucket for the build status
[23:55:41.675] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:41.675] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:12:0) after 1m0s
[23:56:41.818] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:12:0)
[23:56:41.818] Timer tick, asking Buildbucket for the build status
[23:56:41.958] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:41.958] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:13:0) after 1m0s
[23:57:41.992] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:13:0)
[23:57:41.992] Timer tick, asking Buildbucket for the build status
[23:57:42.076] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:42.076] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:14:0) after 1m0s
[23:58:42.103] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:14:0)
[23:58:42.103] Timer tick, asking Buildbucket for the build status
[23:58:42.232] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:42.232] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:15:0) after 1m0s
[23:59:42.263] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:15:0)
[23:59:42.263] Timer tick, asking Buildbucket for the build status
[23:59:42.357] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:42.357] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:16:0) after 1m0s
[00:00:42.391] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:16:0)
[00:00:42.391] Timer tick, asking Buildbucket for the build status
[00:00:42.586] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:42.586] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:17:0) after 1m0s
[00:01:42.610] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:17:0)
[00:01:42.610] Timer tick, asking Buildbucket for the build status
[00:01:42.697] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:42.697] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:18:0) after 1m0s
[00:02:42.805] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:18:0)
[00:02:42.805] Timer tick, asking Buildbucket for the build status
[00:02:42.925] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:42.925] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:19:0) after 1m0s
[00:03:42.947] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:19:0)
[00:03:42.947] Timer tick, asking Buildbucket for the build status
[00:03:43.028] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:43.028] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:20:0) after 1m0s
[00:04:43.112] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:20:0)
[00:04:43.112] Timer tick, asking Buildbucket for the build status
[00:04:43.205] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:43.205] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:21:0) after 1m0s
[00:05:43.299] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:21:0)
[00:05:43.299] Timer tick, asking Buildbucket for the build status
[00:05:43.383] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:43.383] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:22:0) after 1m0s
[00:06:43.504] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:22:0)
[00:06:43.504] Timer tick, asking Buildbucket for the build status
[00:06:43.594] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:43.594] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:23:0) after 1m0s
[00:07:43.692] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:23:0)
[00:07:43.692] Timer tick, asking Buildbucket for the build status
[00:07:43.779] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:43.779] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:24:0) after 1m0s
[00:08:43.877] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:24:0)
[00:08:43.877] Timer tick, asking Buildbucket for the build status
[00:08:43.965] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:43.965] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:25:0) after 1m0s
[00:09:43.987] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:25:0)
[00:09:43.987] Timer tick, asking Buildbucket for the build status
[00:09:44.118] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:44.118] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:26:0) after 1m0s
[00:10:44.185] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:26:0)
[00:10:44.185] Timer tick, asking Buildbucket for the build status
[00:10:44.279] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:44.279] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:27:0) after 1m0s
[00:11:44.376] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:27:0)
[00:11:44.376] Timer tick, asking Buildbucket for the build status
[00:11:44.463] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:44.463] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:28:0) after 1m0s
[00:12:44.500] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:28:0)
[00:12:44.500] Timer tick, asking Buildbucket for the build status
[00:12:44.592] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:44.592] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:29:0) after 1m0s
[00:13:44.623] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:29:0)
[00:13:44.623] Timer tick, asking Buildbucket for the build status
[00:13:44.711] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:44.711] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:30:0) after 1m0s
[00:14:44.809] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:30:0)
[00:14:44.809] Timer tick, asking Buildbucket for the build status
[00:14:44.915] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:44.915] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:31:0) after 1m0s
[00:15:44.937] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:31:0)
[00:15:44.937] Timer tick, asking Buildbucket for the build status
[00:15:45.023] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:45.023] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:32:0) after 1m0s
[00:16:45.089] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:32:0)
[00:16:45.089] Timer tick, asking Buildbucket for the build status
[00:16:45.169] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:45.169] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:33:0) after 1m0s
[00:17:45.203] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:33:0)
[00:17:45.203] Timer tick, asking Buildbucket for the build status
[00:17:45.317] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:45.317] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:34:0) after 1m0s
[00:18:45.382] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:34:0)
[00:18:45.382] Timer tick, asking Buildbucket for the build status
[00:18:45.473] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:45.473] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:35:0) after 1m0s
[00:19:45.510] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:35:0)
[00:19:45.510] Timer tick, asking Buildbucket for the build status
[00:19:45.592] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:45.592] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:36:0) after 1m0s
[00:20:45.686] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:36:0)
[00:20:45.686] Timer tick, asking Buildbucket for the build status
[00:20:45.775] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:45.775] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:37:0) after 1m0s
[00:21:45.796] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:37:0)
[00:21:45.796] Timer tick, asking Buildbucket for the build status
[00:21:45.892] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:45.892] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:38:0) after 1m0s
[00:22:46.000] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:38:0)
[00:22:46.000] Timer tick, asking Buildbucket for the build status
[00:22:46.100] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:46.100] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:39:0) after 1m0s
[00:23:46.127] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:39:0)
[00:23:46.127] Timer tick, asking Buildbucket for the build status
[00:23:46.208] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:46.208] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:40:0) after 1m0s
[00:24:46.255] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:40:0)
[00:24:46.255] Timer tick, asking Buildbucket for the build status
[00:24:46.342] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:46.342] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:41:0) after 1m0s
[00:25:46.360] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:41:0)
[00:25:46.360] Timer tick, asking Buildbucket for the build status
[00:25:46.438] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:46.438] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:42:0) after 1m0s
[00:26:46.464] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:42:0)
[00:26:46.464] Timer tick, asking Buildbucket for the build status
[00:26:46.597] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:46.597] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:43:0) after 1m0s
[00:27:46.698] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:43:0)
[00:27:46.698] Timer tick, asking Buildbucket for the build status
[00:27:46.812] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:46.812] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:44:0) after 1m0s
[00:28:46.899] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:44:0)
[00:28:46.899] Timer tick, asking Buildbucket for the build status
[00:28:47.012] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:47.012] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:45:0) after 1m0s
[00:29:47.107] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:45:0)
[00:29:47.107] Timer tick, asking Buildbucket for the build status
[00:29:47.196] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:47.196] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:46:0) after 1m0s
[00:30:47.306] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:46:0)
[00:30:47.306] Timer tick, asking Buildbucket for the build status
[00:30:47.434] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:47.434] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:47:0) after 1m0s
[00:31:47.496] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:47:0)
[00:31:47.496] Timer tick, asking Buildbucket for the build status
[00:31:47.586] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:47.586] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:48:0) after 1m0s
[00:32:47.611] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:48:0)
[00:32:47.611] Timer tick, asking Buildbucket for the build status
[00:32:47.697] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:47.697] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:49:0) after 1m0s
[00:33:47.805] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:49:0)
[00:33:47.805] Timer tick, asking Buildbucket for the build status
[00:33:47.887] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:47.887] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:50:0) after 1m0s
[00:34:48.008] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:50:0)
[00:34:48.009] Timer tick, asking Buildbucket for the build status
[00:34:48.106] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:48.106] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:51:0) after 1m0s
[00:35:48.127] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:51:0)
[00:35:48.127] Timer tick, asking Buildbucket for the build status
[00:35:48.224] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:48.224] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:52:0) after 1m0s
[00:36:48.306] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:52:0)
[00:36:48.306] Timer tick, asking Buildbucket for the build status
[00:36:48.418] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:48.419] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:53:0) after 1m0s
[00:37:48.495] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:53:0)
[00:37:48.495] Timer tick, asking Buildbucket for the build status
[00:37:48.584] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:48.584] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:54:0) after 1m0s
[00:38:48.627] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:54:0)
[00:38:48.627] Timer tick, asking Buildbucket for the build status
[00:38:48.799] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:48.799] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:55:0) after 1m0s
[00:39:48.825] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:55:0)
[00:39:48.825] Timer tick, asking Buildbucket for the build status
[00:39:48.897] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:48.897] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:56:0) after 1m0s
[00:40:48.996] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:56:0)
[00:40:48.996] Timer tick, asking Buildbucket for the build status
[00:40:49.082] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:49.082] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:57:0) after 1m0s
[00:41:49.102] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:57:0)
[00:41:49.102] Timer tick, asking Buildbucket for the build status
[00:41:49.193] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:49.193] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:58:0) after 1m0s
[00:42:49.305] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:58:0)
[00:42:49.305] Timer tick, asking Buildbucket for the build status
[00:42:49.377] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:49.377] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:59:0) after 1m0s
[00:43:49.417] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:59:0)
[00:43:49.417] Timer tick, asking Buildbucket for the build status
[00:43:49.516] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:49.516] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:60:0) after 1m0s
[00:44:49.604] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:60:0)
[00:44:49.604] Timer tick, asking Buildbucket for the build status
[00:44:49.692] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:49.692] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:61:0) after 1m0s
[00:45:49.803] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:61:0)
[00:45:49.803] Timer tick, asking Buildbucket for the build status
[00:45:49.892] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:49.892] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:62:0) after 1m0s
[00:46:50.011] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:62:0)
[00:46:50.011] Timer tick, asking Buildbucket for the build status
[00:46:50.096] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:50.096] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:63:0) after 1m0s
[00:47:50.205] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:63:0)
[00:47:50.205] Timer tick, asking Buildbucket for the build status
[00:47:50.289] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:50.289] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:64:0) after 1m0s
[00:48:50.413] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:64:0)
[00:48:50.413] Timer tick, asking Buildbucket for the build status
[00:48:50.497] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:50.497] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:65:0) after 1m0s
[00:49:50.522] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:65:0)
[00:49:50.522] Timer tick, asking Buildbucket for the build status
[00:49:50.593] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:50.593] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:66:0) after 1m0s
[00:50:50.619] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:66:0)
[00:50:50.619] Timer tick, asking Buildbucket for the build status
[00:50:50.693] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:50.693] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:67:0) after 1m0s
[00:51:50.719] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:67:0)
[00:51:50.719] Timer tick, asking Buildbucket for the build status
[00:51:50.832] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:50.832] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:68:0) after 1m0s
[00:52:50.899] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:68:0)
[00:52:50.899] Timer tick, asking Buildbucket for the build status
[00:52:51.001] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:51.001] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:69:0) after 1m0s
[00:53:51.095] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:69:0)
[00:53:51.095] Timer tick, asking Buildbucket for the build status
[00:53:51.207] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:51.207] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:70:0) after 1m0s
[00:54:51.232] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:70:0)
[00:54:51.232] Timer tick, asking Buildbucket for the build status
[00:54:51.338] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:51.338] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:71:0) after 1m0s
[00:55:51.366] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:71:0)
[00:55:51.366] Timer tick, asking Buildbucket for the build status
[00:55:51.464] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:51.464] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:72:0) after 1m0s
[00:56:51.504] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:72:0)
[00:56:51.504] Timer tick, asking Buildbucket for the build status
[00:56:51.611] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:51.611] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:73:0) after 1m0s
[00:57:51.710] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:73:0)
[00:57:51.710] Timer tick, asking Buildbucket for the build status
[00:57:51.808] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:51.808] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:74:0) after 1m0s
[00:58:51.898] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:74:0)
[00:58:51.898] Timer tick, asking Buildbucket for the build status
[00:58:52.032] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:52.032] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:75:0) after 1m0s
[00:59:52.095] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:75:0)
[00:59:52.095] Timer tick, asking Buildbucket for the build status
[00:59:52.198] Build 8855821046314455440: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:52.198] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:76:0) after 1m0s
[01:00:07.099] Received PubSub notification, asking Buildbucket for the build status
[01:00:07.213] Build 8855821046314455440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:52.314] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:76:0)
[01:00:52.314] Timer tick, asking Buildbucket for the build status
[01:00:52.515] Build 8855821046314455440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:52.515] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:78:0) after 1m0s
[01:01:52.611] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:78:0)
[01:01:52.611] Timer tick, asking Buildbucket for the build status
[01:01:52.735] Build 8855821046314455440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:52.735] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:79:0) after 1m0s
[01:02:52.809] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:79:0)
[01:02:52.809] Timer tick, asking Buildbucket for the build status
[01:02:52.942] Build 8855821046314455440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:52.942] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:80:0) after 1m0s
[01:03:52.971] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:80:0)
[01:03:52.971] Timer tick, asking Buildbucket for the build status
[01:03:53.101] Build 8855821046314455440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:53.101] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:81:0) after 1m0s
[01:04:53.196] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:81:0)
[01:04:53.196] Timer tick, asking Buildbucket for the build status
[01:04:53.298] Build 8855821046314455440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:53.298] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:82:0) after 1m0s
[01:05:53.333] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:82:0)
[01:05:53.333] Timer tick, asking Buildbucket for the build status
[01:05:53.505] Build 8855821046314455440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:53.505] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:83:0) after 1m0s
[01:06:53.597] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:83:0)
[01:06:53.597] Timer tick, asking Buildbucket for the build status
[01:06:53.696] Build 8855821046314455440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:53.696] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021251108532099152:84:0) after 1m0s
[01:07:06.715] Received PubSub notification, asking Buildbucket for the build status
[01:07:06.812] Build 8855821046314455440: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:07:06.812] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1612832825429223",
    "created_by": "project:infra",
    "created_ts": "1612827939647864",
    "id": "8855821046314455440",
    "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\": \"d1a000fa3c9a313323ff12189cb84d9c98666884\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d1a000fa3c9a313323ff12189cb84d9c98666884\", \"title\": \"d1a000fa3c9a313323ff12189cb84d9c98666884\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/d1a000fa3c9a313323ff12189cb84d9c98666884\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"61cd2b9f441fda4d9b239a267fa211977d78f5f2\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@61cd2b9f441fda4d9b239a267fa211977d78f5f2\", \"title\": \"61cd2b9f441fda4d9b239a267fa211977d78f5f2\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/61cd2b9f441fda4d9b239a267fa211977d78f5f2\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f974c23e1e4762c09c38947d0f89877e04d819ed\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f974c23e1e4762c09c38947d0f89877e04d819ed\", \"title\": \"f974c23e1e4762c09c38947d0f89877e04d819ed\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f974c23e1e4762c09c38947d0f89877e04d819ed\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"48aa51a8f2290a67188c4c1899fa31b6e097a1ba\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@48aa51a8f2290a67188c4c1899fa31b6e097a1ba\", \"title\": \"48aa51a8f2290a67188c4c1899fa31b6e097a1ba\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/48aa51a8f2290a67188c4c1899fa31b6e097a1ba\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\", \"title\": \"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"got_revision\": \"d6e6681a8827f1b7efaa76279c99bf3f9aaa07de\", \"got_revision_cp\": \"refs/heads/master@{#38337}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_v2\", \"builder_82ed111fed7ea8169e482f00b5f3e5338a65daa41208585de67cb0a736b1d538_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"builder_d38bdc976f893fc6930479dce8a6d7dc793b2a74fe1392d4af00713a5c0bb46e_v2\", \"git\", \"goma\", \"infra_gclient_with_go\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-4zxr\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5685-1877293\"], \"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": "1612832400867373",
    "status": "COMPLETED",
    "status_changed_ts": "1612832405249812",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/18557",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/d6e6681a8827f1b7efaa76279c99bf3f9aaa07de",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/d6e6681a8827f1b7efaa76279c99bf3f9aaa07de",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021251108532099152",
      "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/8855821046314455440/+/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:519cdade316cfa10",
      "user_agent:luci-scheduler-dev"
    ],
    "updated_ts": "1612832825471894",
    "url": "https://luci-milo-dev.appspot.com/b/8855821046314455440",
    "utcnow_ts": "1612832826798624"
  }
}
[01:07:06.812] Invocation finished in 1h21m28.663420139s with status SUCCEEDED