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

Incoming tags

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

Debug log (UTC)

[08:24:18.193] New invocation is queued and will start shortly
[08:24:19.412] Starting the invocation (attempt 1)
[08:24:19.475] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[08:24:19.482] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[08:24:19.482] Buildbucket request:
{
  "bucket": "luci.infra.ci",
  "client_operation_id": "9020403104122321888",
  "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\":\"fd10124659e991321df2f8a5d3749687b54ceb0a\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@fd10124659e991321df2f8a5d3749687b54ceb0a\",\"title\":\"fd10124659e991321df2f8a5d3749687b54ceb0a\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/fd10124659e991321df2f8a5d3749687b54ceb0a\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"fd10124659e991321df2f8a5d3749687b54ceb0a\"}}",
  "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:9020403104122321888",
    "scheduler_job_id:infra/infra-continuous-win10-64",
    "user_agent:luci-scheduler-dev",
    "buildset:commit/git/fd10124659e991321df2f8a5d3749687b54ceb0a",
    "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/fd10124659e991321df2f8a5d3749687b54ceb0a",
    "gitiles_ref:refs/heads/master"
  ]
}
[08:24:20.285] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1613636659582550",
    "id": "8854973042000720160",
    "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\": \"fd10124659e991321df2f8a5d3749687b54ceb0a\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@fd10124659e991321df2f8a5d3749687b54ceb0a\", \"title\": \"fd10124659e991321df2f8a5d3749687b54ceb0a\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/fd10124659e991321df2f8a5d3749687b54ceb0a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"fd10124659e991321df2f8a5d3749687b54ceb0a\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1613636660185560",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/18644",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/fd10124659e991321df2f8a5d3749687b54ceb0a",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/fd10124659e991321df2f8a5d3749687b54ceb0a",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020403104122321888",
      "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/8854973042000720160/+/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": "1613636660185676",
    "url": "https://luci-milo-dev.appspot.com/b/8854973042000720160",
    "utcnow_ts": "1613636660278643"
  }
}
[08:24:20.285] Task URL: https://luci-milo-dev.appspot.com/b/8854973042000720160
[08:24:20.285] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:2:0) after 1m0s
[08:25:20.410] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:2:0)
[08:25:20.410] Timer tick, asking Buildbucket for the build status
[08:25:20.536] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:25:20.536] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:3:0) after 1m0s
[08:26:20.613] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:3:0)
[08:26:20.613] Timer tick, asking Buildbucket for the build status
[08:26:20.713] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:26:20.713] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:4:0) after 1m0s
[08:27:20.804] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:4:0)
[08:27:20.804] Timer tick, asking Buildbucket for the build status
[08:27:20.932] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:27:20.932] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:5:0) after 1m0s
[08:28:20.994] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:5:0)
[08:28:20.994] Timer tick, asking Buildbucket for the build status
[08:28:21.068] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:28:21.068] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:6:0) after 1m0s
[08:29:21.119] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:6:0)
[08:29:21.119] Timer tick, asking Buildbucket for the build status
[08:29:21.186] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:29:21.186] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:7:0) after 1m0s
[08:30:21.302] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:7:0)
[08:30:21.302] Timer tick, asking Buildbucket for the build status
[08:30:21.410] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:30:21.410] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:8:0) after 1m0s
[08:31:21.504] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:8:0)
[08:31:21.504] Timer tick, asking Buildbucket for the build status
[08:31:21.592] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:31:21.592] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:9:0) after 1m0s
[08:32:21.728] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:9:0)
[08:32:21.728] Timer tick, asking Buildbucket for the build status
[08:32:21.820] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:32:21.820] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:10:0) after 1m0s
[08:33:21.894] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:10:0)
[08:33:21.894] Timer tick, asking Buildbucket for the build status
[08:33:21.974] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:33:21.974] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:11:0) after 1m0s
[08:34:22.005] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:11:0)
[08:34:22.005] Timer tick, asking Buildbucket for the build status
[08:34:22.102] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:34:22.102] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:12:0) after 1m0s
[08:35:22.207] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:12:0)
[08:35:22.207] Timer tick, asking Buildbucket for the build status
[08:35:22.291] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:22.291] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:13:0) after 1m0s
[08:36:22.327] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:13:0)
[08:36:22.327] Timer tick, asking Buildbucket for the build status
[08:36:22.445] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:22.445] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:14:0) after 1m0s
[08:37:22.505] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:14:0)
[08:37:22.505] Timer tick, asking Buildbucket for the build status
[08:37:22.590] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:37:22.590] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:15:0) after 1m0s
[08:38:22.620] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:15:0)
[08:38:22.620] Timer tick, asking Buildbucket for the build status
[08:38:22.705] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:38:22.705] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:16:0) after 1m0s
[08:39:22.805] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:16:0)
[08:39:22.805] Timer tick, asking Buildbucket for the build status
[08:39:22.883] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:39:22.883] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:17:0) after 1m0s
[08:40:22.907] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:17:0)
[08:40:22.907] Timer tick, asking Buildbucket for the build status
[08:40:23.000] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:40:23.000] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:18:0) after 1m0s
[08:41:23.093] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:18:0)
[08:41:23.093] Timer tick, asking Buildbucket for the build status
[08:41:23.169] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:41:23.169] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:19:0) after 1m0s
[08:42:23.203] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:19:0)
[08:42:23.203] Timer tick, asking Buildbucket for the build status
[08:42:23.281] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:42:23.281] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:20:0) after 1m0s
[08:43:23.302] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:20:0)
[08:43:23.302] Timer tick, asking Buildbucket for the build status
[08:43:23.370] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:43:23.370] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:21:0) after 1m0s
[08:44:23.394] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:21:0)
[08:44:23.394] Timer tick, asking Buildbucket for the build status
[08:44:23.473] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:44:23.473] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:22:0) after 1m0s
[08:45:23.507] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:22:0)
[08:45:23.507] Timer tick, asking Buildbucket for the build status
[08:45:23.580] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:45:23.580] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:23:0) after 1m0s
[08:46:23.603] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:23:0)
[08:46:23.603] Timer tick, asking Buildbucket for the build status
[08:46:23.683] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:46:23.683] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:24:0) after 1m0s
[08:47:23.707] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:24:0)
[08:47:23.708] Timer tick, asking Buildbucket for the build status
[08:47:23.779] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:47:23.779] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:25:0) after 1m0s
[08:48:23.808] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:25:0)
[08:48:23.808] Timer tick, asking Buildbucket for the build status
[08:48:23.888] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:23.888] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:26:0) after 1m0s
[08:49:24.009] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:26:0)
[08:49:24.009] Timer tick, asking Buildbucket for the build status
[08:49:24.408] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:49:24.408] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:27:0) after 1m0s
[08:50:24.510] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:27:0)
[08:50:24.510] Timer tick, asking Buildbucket for the build status
[08:50:24.871] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:50:24.871] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:28:0) after 1m0s
[08:51:24.909] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:28:0)
[08:51:24.909] Timer tick, asking Buildbucket for the build status
[08:51:25.219] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:51:25.219] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:29:0) after 1m0s
[08:52:25.295] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:29:0)
[08:52:25.295] Timer tick, asking Buildbucket for the build status
[08:52:25.813] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:52:25.813] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:30:0) after 1m0s
[08:53:25.837] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:30:0)
[08:53:25.837] Timer tick, asking Buildbucket for the build status
[08:53:26.201] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:53:26.201] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:31:0) after 1m0s
[08:54:26.295] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:31:0)
[08:54:26.295] Timer tick, asking Buildbucket for the build status
[08:54:26.593] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:54:26.593] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:32:0) after 1m0s
[08:55:26.694] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:32:0)
[08:55:26.694] Timer tick, asking Buildbucket for the build status
[08:55:27.019] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:55:27.019] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:33:0) after 1m0s
[08:56:27.107] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:33:0)
[08:56:27.107] Timer tick, asking Buildbucket for the build status
[08:56:27.264] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:56:27.264] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:34:0) after 1m0s
[08:57:27.304] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:34:0)
[08:57:27.304] Timer tick, asking Buildbucket for the build status
[08:57:27.371] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:57:27.371] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:35:0) after 1m0s
[08:58:27.390] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:35:0)
[08:58:27.390] Timer tick, asking Buildbucket for the build status
[08:58:27.560] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:58:27.560] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:36:0) after 1m0s
[08:59:27.622] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:36:0)
[08:59:27.622] Timer tick, asking Buildbucket for the build status
[08:59:27.692] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:59:27.692] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:37:0) after 1m0s
[09:00:27.817] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:37:0)
[09:00:27.817] Timer tick, asking Buildbucket for the build status
[09:00:27.917] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:00:27.917] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:38:0) after 1m0s
[09:01:28.017] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:38:0)
[09:01:28.017] Timer tick, asking Buildbucket for the build status
[09:01:28.106] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:01:28.106] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:39:0) after 1m0s
[09:02:28.210] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:39:0)
[09:02:28.210] Timer tick, asking Buildbucket for the build status
[09:02:28.282] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:02:28.282] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:40:0) after 1m0s
[09:03:28.316] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:40:0)
[09:03:28.316] Timer tick, asking Buildbucket for the build status
[09:03:28.439] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:03:28.439] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:41:0) after 1m0s
[09:04:28.460] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:41:0)
[09:04:28.460] Timer tick, asking Buildbucket for the build status
[09:04:28.533] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:04:28.533] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:42:0) after 1m0s
[09:05:28.614] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:42:0)
[09:05:28.614] Timer tick, asking Buildbucket for the build status
[09:05:28.680] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:05:28.680] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:43:0) after 1m0s
[09:06:28.711] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:43:0)
[09:06:28.711] Timer tick, asking Buildbucket for the build status
[09:06:28.780] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:06:28.780] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:44:0) after 1m0s
[09:07:28.804] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:44:0)
[09:07:28.804] Timer tick, asking Buildbucket for the build status
[09:07:28.878] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:07:28.878] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:45:0) after 1m0s
[09:08:29.008] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:45:0)
[09:08:29.008] Timer tick, asking Buildbucket for the build status
[09:08:29.140] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:08:29.141] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:46:0) after 1m0s
[09:09:29.215] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:46:0)
[09:09:29.215] Timer tick, asking Buildbucket for the build status
[09:09:29.282] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:09:29.282] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:47:0) after 1m0s
[09:10:29.308] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:47:0)
[09:10:29.308] Timer tick, asking Buildbucket for the build status
[09:10:29.403] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:10:29.403] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:48:0) after 1m0s
[09:11:29.502] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:48:0)
[09:11:29.502] Timer tick, asking Buildbucket for the build status
[09:11:29.576] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:11:29.576] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:49:0) after 1m0s
[09:12:29.608] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:49:0)
[09:12:29.608] Timer tick, asking Buildbucket for the build status
[09:12:29.693] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:12:29.693] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:50:0) after 1m0s
[09:13:29.722] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:50:0)
[09:13:29.722] Timer tick, asking Buildbucket for the build status
[09:13:29.849] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:13:29.849] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:51:0) after 1m0s
[09:14:29.909] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:51:0)
[09:14:29.909] Timer tick, asking Buildbucket for the build status
[09:14:30.017] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:30.017] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:52:0) after 1m0s
[09:15:30.043] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:52:0)
[09:15:30.043] Timer tick, asking Buildbucket for the build status
[09:15:30.108] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:15:30.108] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:53:0) after 1m0s
[09:16:30.208] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:53:0)
[09:16:30.208] Timer tick, asking Buildbucket for the build status
[09:16:30.282] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:16:30.282] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:54:0) after 1m0s
[09:17:30.305] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:54:0)
[09:17:30.305] Timer tick, asking Buildbucket for the build status
[09:17:30.362] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:17:30.362] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:55:0) after 1m0s
[09:18:30.387] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:55:0)
[09:18:30.387] Timer tick, asking Buildbucket for the build status
[09:18:30.470] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:18:30.470] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:56:0) after 1m0s
[09:19:30.496] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:56:0)
[09:19:30.496] Timer tick, asking Buildbucket for the build status
[09:19:30.565] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:19:30.565] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:57:0) after 1m0s
[09:20:30.600] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:57:0)
[09:20:30.600] Timer tick, asking Buildbucket for the build status
[09:20:30.671] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:20:30.671] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:58:0) after 1m0s
[09:21:30.708] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:58:0)
[09:21:30.708] Timer tick, asking Buildbucket for the build status
[09:21:30.783] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:21:30.783] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:59:0) after 1m0s
[09:22:30.913] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:59:0)
[09:22:30.913] Timer tick, asking Buildbucket for the build status
[09:22:31.018] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:22:31.018] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:60:0) after 1m0s
[09:23:31.117] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:60:0)
[09:23:31.117] Timer tick, asking Buildbucket for the build status
[09:23:31.187] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:23:31.187] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:61:0) after 1m0s
[09:24:31.296] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:61:0)
[09:24:31.296] Timer tick, asking Buildbucket for the build status
[09:24:31.364] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:24:31.364] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:62:0) after 1m0s
[09:25:31.414] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:62:0)
[09:25:31.414] Timer tick, asking Buildbucket for the build status
[09:25:31.496] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:25:31.496] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:63:0) after 1m0s
[09:26:31.605] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:63:0)
[09:26:31.605] Timer tick, asking Buildbucket for the build status
[09:26:31.726] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:26:31.726] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:64:0) after 1m0s
[09:27:31.810] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:64:0)
[09:27:31.810] Timer tick, asking Buildbucket for the build status
[09:27:31.907] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:27:31.907] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:65:0) after 1m0s
[09:28:31.995] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:65:0)
[09:28:31.995] Timer tick, asking Buildbucket for the build status
[09:28:32.129] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:28:32.129] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:66:0) after 1m0s
[09:29:32.209] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:66:0)
[09:29:32.209] Timer tick, asking Buildbucket for the build status
[09:29:32.290] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:29:32.290] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:67:0) after 1m0s
[09:30:32.410] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:67:0)
[09:30:32.410] Timer tick, asking Buildbucket for the build status
[09:30:32.534] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:30:32.534] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:68:0) after 1m0s
[09:31:32.615] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:68:0)
[09:31:32.615] Timer tick, asking Buildbucket for the build status
[09:31:32.752] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:31:32.752] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:69:0) after 1m0s
[09:32:32.844] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:69:0)
[09:32:32.844] Timer tick, asking Buildbucket for the build status
[09:32:32.928] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:32:32.928] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:70:0) after 1m0s
[09:33:33.012] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:70:0)
[09:33:33.012] Timer tick, asking Buildbucket for the build status
[09:33:33.152] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:33:33.153] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:71:0) after 1m0s
[09:34:33.197] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:71:0)
[09:34:33.197] Timer tick, asking Buildbucket for the build status
[09:34:33.278] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:34:33.278] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:72:0) after 1m0s
[09:35:33.307] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:72:0)
[09:35:33.307] Timer tick, asking Buildbucket for the build status
[09:35:33.456] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:33.456] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:73:0) after 1m0s
[09:36:33.503] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:73:0)
[09:36:33.503] Timer tick, asking Buildbucket for the build status
[09:36:33.581] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:33.581] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:74:0) after 1m0s
[09:37:33.611] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:74:0)
[09:37:33.611] Timer tick, asking Buildbucket for the build status
[09:37:33.710] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:33.710] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:75:0) after 1m0s
[09:38:33.796] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:75:0)
[09:38:33.796] Timer tick, asking Buildbucket for the build status
[09:38:33.892] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:33.892] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:76:0) after 1m0s
[09:39:33.996] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:76:0)
[09:39:33.996] Timer tick, asking Buildbucket for the build status
[09:39:34.079] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:34.079] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:77:0) after 1m0s
[09:40:34.107] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:77:0)
[09:40:34.107] Timer tick, asking Buildbucket for the build status
[09:40:34.177] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:34.177] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:78:0) after 1m0s
[09:41:34.199] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:78:0)
[09:41:34.199] Timer tick, asking Buildbucket for the build status
[09:41:34.331] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:34.331] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:79:0) after 1m0s
[09:42:34.353] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:79:0)
[09:42:34.353] Timer tick, asking Buildbucket for the build status
[09:42:34.464] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:34.464] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:80:0) after 1m0s
[09:43:34.512] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:80:0)
[09:43:34.512] Timer tick, asking Buildbucket for the build status
[09:43:34.587] Build 8854973042000720160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:34.587] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:81:0) after 1m0s
[09:44:12.410] Received PubSub notification, asking Buildbucket for the build status
[09:44:12.478] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:34.708] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:81:0)
[09:44:34.708] Timer tick, asking Buildbucket for the build status
[09:44:34.773] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:34.773] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:83:0) after 1m0s
[09:45:34.807] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:83:0)
[09:45:34.807] Timer tick, asking Buildbucket for the build status
[09:45:34.883] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:34.883] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:84:0) after 1m0s
[09:46:34.910] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:84:0)
[09:46:34.910] Timer tick, asking Buildbucket for the build status
[09:46:34.972] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:34.972] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:85:0) after 1m0s
[09:47:34.996] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:85:0)
[09:47:34.996] Timer tick, asking Buildbucket for the build status
[09:47:35.066] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:35.066] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:86:0) after 1m0s
[09:48:35.101] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:86:0)
[09:48:35.101] Timer tick, asking Buildbucket for the build status
[09:48:35.179] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:35.179] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:87:0) after 1m0s
[09:49:35.202] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:87:0)
[09:49:35.202] Timer tick, asking Buildbucket for the build status
[09:49:35.329] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:35.329] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:88:0) after 1m0s
[09:50:35.352] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:88:0)
[09:50:35.352] Timer tick, asking Buildbucket for the build status
[09:50:35.436] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:35.436] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:89:0) after 1m0s
[09:51:35.512] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:89:0)
[09:51:35.512] Timer tick, asking Buildbucket for the build status
[09:51:35.590] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:35.590] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:90:0) after 1m0s
[09:52:35.707] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:90:0)
[09:52:35.707] Timer tick, asking Buildbucket for the build status
[09:52:35.776] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:35.776] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:91:0) after 1m0s
[09:53:35.805] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:91:0)
[09:53:35.805] Timer tick, asking Buildbucket for the build status
[09:53:35.874] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:35.874] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:92:0) after 1m0s
[09:54:35.909] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:92:0)
[09:54:35.909] Timer tick, asking Buildbucket for the build status
[09:54:35.975] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:35.975] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:93:0) after 1m0s
[09:55:36.007] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:93:0)
[09:55:36.007] Timer tick, asking Buildbucket for the build status
[09:55:36.072] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:36.072] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:94:0) after 1m0s
[09:56:36.099] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:94:0)
[09:56:36.099] Timer tick, asking Buildbucket for the build status
[09:56:36.164] Build 8854973042000720160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:36.164] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020403104122321888:95:0) after 1m0s
[09:57:28.535] Received PubSub notification, asking Buildbucket for the build status
[09:57:28.610] Build 8854973042000720160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:57:28.610] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.ci",
    "canary_preference": "PROD",
    "completed_ts": "1613642248015974",
    "created_by": "project:infra",
    "created_ts": "1613636659582550",
    "id": "8854973042000720160",
    "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\": \"fd10124659e991321df2f8a5d3749687b54ceb0a\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@fd10124659e991321df2f8a5d3749687b54ceb0a\", \"title\": \"fd10124659e991321df2f8a5d3749687b54ceb0a\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/fd10124659e991321df2f8a5d3749687b54ceb0a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"fd10124659e991321df2f8a5d3749687b54ceb0a\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"got_revision\": \"fd10124659e991321df2f8a5d3749687b54ceb0a\", \"got_revision_cp\": \"refs/heads/master@{#38618}\"}, \"swarming\": {\"bot_dimensions\": {\"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-wzc0\"], \"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\": [\"5705-fd48c20\"], \"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": "1613641443365872",
    "status": "COMPLETED",
    "status_changed_ts": "1613641449983561",
    "tags": [
      "build_address:luci.infra.ci/infra-continuous-win10-64/18644",
      "builder:infra-continuous-win10-64",
      "buildset:commit/git/fd10124659e991321df2f8a5d3749687b54ceb0a",
      "buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/fd10124659e991321df2f8a5d3749687b54ceb0a",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020403104122321888",
      "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/8854973042000720160/+/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:51cd0ef54d2c0a10",
      "user_agent:luci-scheduler-dev"
    ],
    "updated_ts": "1613642247804412",
    "url": "https://luci-milo-dev.appspot.com/b/8854973042000720160",
    "utcnow_ts": "1613642248602840"
  }
}
[09:57:28.610] Invocation finished in 1h33m10.43491076s with status SUCCEEDED