Status: SUCCEEDED
Triggered by: -
Duration: 3 hours
Actions:

Definition (rev 835dd06986af6863f902c628becb4df908d0fc20)

buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.chromium.ci"
  builder: "win-official"
>

Incoming triggers

Incoming properties

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/chromium/src",
  "revision": "ae887705b8b61607eedb3da3bad12d886c34cd88"
}

Incoming tags

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

Debug log (UTC)

[23:49:07.362] New invocation is queued and will start shortly
[23:49:09.114] Starting the invocation (attempt 1)
[23:49:09.155] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:49:09.155] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:49:09.156] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9021522680073950304",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ae887705b8b61607eedb3da3bad12d886c34cd88\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9021522680073950304",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/ae887705b8b61607eedb3da3bad12d886c34cd88",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ae887705b8b61607eedb3da3bad12d886c34cd88",
    "gitiles_ref:refs/heads/master"
  ]
}
[23:49:09.743] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1612568949247103",
    "id": "8856092617432502320",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ae887705b8b61607eedb3da3bad12d886c34cd88\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1612568949616702",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1545",
      "builder:win-official",
      "buildset:commit/git/ae887705b8b61607eedb3da3bad12d886c34cd88",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ae887705b8b61607eedb3da3bad12d886c34cd88",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021522680073950304",
      "scheduler_job_id:chromium/win-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856092617432502320/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612568949616809",
    "url": "https://ci.chromium.org/b/8856092617432502320",
    "utcnow_ts": "1612568949736924"
  }
}
[23:49:09.743] Task URL: https://ci.chromium.org/b/8856092617432502320
[23:49:09.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:2:0) after 1m0s
[23:49:53.959] Received PubSub notification, asking Buildbucket for the build status
[23:49:54.212] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:09.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:2:0)
[23:50:09.762] Timer tick, asking Buildbucket for the build status
[23:50:09.843] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:09.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:4:0) after 1m0s
[23:51:09.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:4:0)
[23:51:09.860] Timer tick, asking Buildbucket for the build status
[23:51:09.944] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:09.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:5:0) after 1m0s
[23:52:09.975] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:5:0)
[23:52:09.975] Timer tick, asking Buildbucket for the build status
[23:52:10.062] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:10.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:6:0) after 1m0s
[23:53:10.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:6:0)
[23:53:10.091] Timer tick, asking Buildbucket for the build status
[23:53:10.183] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:10.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:7:0) after 1m0s
[23:54:10.166] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:7:0)
[23:54:10.166] Timer tick, asking Buildbucket for the build status
[23:54:10.315] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:10.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:8:0) after 1m0s
[23:55:10.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:8:0)
[23:55:10.361] Timer tick, asking Buildbucket for the build status
[23:55:10.544] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:10.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:9:0) after 1m0s
[23:56:10.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:9:0)
[23:56:10.587] Timer tick, asking Buildbucket for the build status
[23:56:10.722] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:10.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:10:0) after 1m0s
[23:57:10.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:10:0)
[23:57:10.797] Timer tick, asking Buildbucket for the build status
[23:57:10.887] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:10.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:11:0) after 1m0s
[23:58:10.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:11:0)
[23:58:10.921] Timer tick, asking Buildbucket for the build status
[23:58:11.184] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:11.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:12:0) after 1m0s
[23:59:11.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:12:0)
[23:59:11.167] Timer tick, asking Buildbucket for the build status
[23:59:11.274] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:11.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:13:0) after 1m0s
[00:00:11.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:13:0)
[00:00:11.392] Timer tick, asking Buildbucket for the build status
[00:00:11.753] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:11.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:14:0) after 1m0s
[00:01:14.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:14:0)
[00:01:14.649] Timer tick, asking Buildbucket for the build status
[00:01:14.940] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:14.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:15:0) after 1m0s
[00:02:15.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:15:0)
[00:02:15.198] Timer tick, asking Buildbucket for the build status
[00:02:15.263] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:15.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:16:0) after 1m0s
[00:03:15.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:16:0)
[00:03:15.531] Timer tick, asking Buildbucket for the build status
[00:03:15.601] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:15.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:17:0) after 1m0s
[00:04:15.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:17:0)
[00:04:15.780] Timer tick, asking Buildbucket for the build status
[00:04:15.900] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:15.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:18:0) after 1m0s
[00:05:15.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:18:0)
[00:05:15.933] Timer tick, asking Buildbucket for the build status
[00:05:15.998] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:15.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:19:0) after 1m0s
[00:06:16.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:19:0)
[00:06:16.102] Timer tick, asking Buildbucket for the build status
[00:06:16.178] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:16.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:20:0) after 1m0s
[00:07:16.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:20:0)
[00:07:16.226] Timer tick, asking Buildbucket for the build status
[00:07:16.295] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:16.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:21:0) after 1m0s
[00:08:16.374] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:21:0)
[00:08:16.375] Timer tick, asking Buildbucket for the build status
[00:08:16.508] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:16.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:22:0) after 1m0s
[00:09:16.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:22:0)
[00:09:16.535] Timer tick, asking Buildbucket for the build status
[00:09:16.664] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:16.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:23:0) after 1m0s
[00:10:16.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:23:0)
[00:10:16.699] Timer tick, asking Buildbucket for the build status
[00:10:16.764] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:16.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:24:0) after 1m0s
[00:11:16.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:24:0)
[00:11:16.935] Timer tick, asking Buildbucket for the build status
[00:11:17.051] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:17.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:25:0) after 1m0s
[00:12:17.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:25:0)
[00:12:17.079] Timer tick, asking Buildbucket for the build status
[00:12:17.181] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:17.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:26:0) after 1m0s
[00:13:17.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:26:0)
[00:13:17.361] Timer tick, asking Buildbucket for the build status
[00:13:17.637] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:17.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:27:0) after 1m0s
[00:14:17.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:27:0)
[00:14:17.728] Timer tick, asking Buildbucket for the build status
[00:14:17.881] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:17.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:28:0) after 1m0s
[00:15:17.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:28:0)
[00:15:17.881] Timer tick, asking Buildbucket for the build status
[00:15:18.059] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:18.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:29:0) after 1m0s
[00:16:18.103] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:29:0)
[00:16:18.103] Timer tick, asking Buildbucket for the build status
[00:16:18.216] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:18.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:30:0) after 1m0s
[00:17:18.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:30:0)
[00:17:18.206] Timer tick, asking Buildbucket for the build status
[00:17:18.617] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:18.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:31:0) after 1m0s
[00:18:18.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:31:0)
[00:18:18.638] Timer tick, asking Buildbucket for the build status
[00:18:18.809] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:18.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:32:0) after 1m0s
[00:19:18.846] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:32:0)
[00:19:18.846] Timer tick, asking Buildbucket for the build status
[00:19:18.978] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:18.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:33:0) after 1m0s
[00:20:19.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:33:0)
[00:20:19.063] Timer tick, asking Buildbucket for the build status
[00:20:19.296] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:19.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:34:0) after 1m0s
[00:21:19.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:34:0)
[00:21:19.417] Timer tick, asking Buildbucket for the build status
[00:21:19.473] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:19.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:35:0) after 1m0s
[00:22:19.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:35:0)
[00:22:19.494] Timer tick, asking Buildbucket for the build status
[00:22:19.557] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:19.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:36:0) after 1m0s
[00:23:19.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:36:0)
[00:23:19.602] Timer tick, asking Buildbucket for the build status
[00:23:19.679] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:19.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:37:0) after 1m0s
[00:24:19.737] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:37:0)
[00:24:19.737] Timer tick, asking Buildbucket for the build status
[00:24:19.844] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:19.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:38:0) after 1m0s
[00:25:19.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:38:0)
[00:25:19.876] Timer tick, asking Buildbucket for the build status
[00:25:20.260] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:20.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:39:0) after 1m0s
[00:26:20.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:39:0)
[00:26:20.260] Timer tick, asking Buildbucket for the build status
[00:26:20.384] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:20.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:40:0) after 1m0s
[00:27:20.421] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:40:0)
[00:27:20.421] Timer tick, asking Buildbucket for the build status
[00:27:20.477] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:20.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:41:0) after 1m0s
[00:28:20.590] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:41:0)
[00:28:20.590] Timer tick, asking Buildbucket for the build status
[00:28:20.752] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:20.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:42:0) after 1m0s
[00:29:20.833] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:42:0)
[00:29:20.833] Timer tick, asking Buildbucket for the build status
[00:29:21.254] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:21.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:43:0) after 1m0s
[00:30:21.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:43:0)
[00:30:21.428] Timer tick, asking Buildbucket for the build status
[00:30:21.626] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:21.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:44:0) after 1m0s
[00:31:21.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:44:0)
[00:31:21.732] Timer tick, asking Buildbucket for the build status
[00:31:21.801] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:21.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:45:0) after 1m0s
[00:32:21.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:45:0)
[00:32:21.915] Timer tick, asking Buildbucket for the build status
[00:32:21.979] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:21.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:46:0) after 1m0s
[00:33:22.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:46:0)
[00:33:22.141] Timer tick, asking Buildbucket for the build status
[00:33:22.217] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:22.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:47:0) after 1m0s
[00:34:22.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:47:0)
[00:34:22.364] Timer tick, asking Buildbucket for the build status
[00:34:22.544] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:22.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:48:0) after 1m0s
[00:35:22.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:48:0)
[00:35:22.568] Timer tick, asking Buildbucket for the build status
[00:35:23.163] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:23.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:49:0) after 1m0s
[00:36:23.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:49:0)
[00:36:23.268] Timer tick, asking Buildbucket for the build status
[00:36:23.324] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:23.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:50:0) after 1m0s
[00:37:23.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:50:0)
[00:37:23.550] Timer tick, asking Buildbucket for the build status
[00:37:23.617] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:23.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:51:0) after 1m0s
[00:38:23.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:51:0)
[00:38:23.716] Timer tick, asking Buildbucket for the build status
[00:38:23.781] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:23.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:52:0) after 1m0s
[00:39:23.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:52:0)
[00:39:23.983] Timer tick, asking Buildbucket for the build status
[00:39:24.137] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:24.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:53:0) after 1m0s
[00:40:24.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:53:0)
[00:40:24.371] Timer tick, asking Buildbucket for the build status
[00:40:24.456] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:24.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:54:0) after 1m0s
[00:41:24.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:54:0)
[00:41:24.536] Timer tick, asking Buildbucket for the build status
[00:41:24.615] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:24.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:55:0) after 1m0s
[00:42:24.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:55:0)
[00:42:24.671] Timer tick, asking Buildbucket for the build status
[00:42:25.104] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:25.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:56:0) after 1m0s
[00:43:25.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:56:0)
[00:43:25.116] Timer tick, asking Buildbucket for the build status
[00:43:25.198] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:25.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:57:0) after 1m0s
[00:44:25.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:57:0)
[00:44:25.183] Timer tick, asking Buildbucket for the build status
[00:44:25.408] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:25.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:58:0) after 1m0s
[00:45:25.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:58:0)
[00:45:25.836] Timer tick, asking Buildbucket for the build status
[00:45:25.903] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:25.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:59:0) after 1m0s
[00:46:25.948] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:59:0)
[00:46:25.948] Timer tick, asking Buildbucket for the build status
[00:46:26.002] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:26.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:60:0) after 1m0s
[00:47:26.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:60:0)
[00:47:26.116] Timer tick, asking Buildbucket for the build status
[00:47:26.300] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:26.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:61:0) after 1m0s
[00:48:26.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:61:0)
[00:48:26.411] Timer tick, asking Buildbucket for the build status
[00:48:26.468] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:26.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:62:0) after 1m0s
[00:49:26.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:62:0)
[00:49:26.585] Timer tick, asking Buildbucket for the build status
[00:49:26.701] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:26.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:63:0) after 1m0s
[00:50:26.820] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:63:0)
[00:50:26.820] Timer tick, asking Buildbucket for the build status
[00:50:26.903] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:26.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:64:0) after 1m0s
[00:51:27.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:64:0)
[00:51:27.048] Timer tick, asking Buildbucket for the build status
[00:51:27.129] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:27.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:65:0) after 1m0s
[00:52:27.168] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:65:0)
[00:52:27.168] Timer tick, asking Buildbucket for the build status
[00:52:27.332] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:27.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:66:0) after 1m0s
[00:53:27.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:66:0)
[00:53:27.444] Timer tick, asking Buildbucket for the build status
[00:53:27.537] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:27.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:67:0) after 1m0s
[00:54:27.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:67:0)
[00:54:27.674] Timer tick, asking Buildbucket for the build status
[00:54:28.051] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:28.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:68:0) after 1m0s
[00:55:28.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:68:0)
[00:55:28.225] Timer tick, asking Buildbucket for the build status
[00:55:28.292] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:28.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:69:0) after 1m0s
[00:56:28.342] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:69:0)
[00:56:28.342] Timer tick, asking Buildbucket for the build status
[00:56:28.414] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:28.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:70:0) after 1m0s
[00:57:29.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:70:0)
[00:57:29.506] Timer tick, asking Buildbucket for the build status
[00:57:29.566] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:29.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:71:0) after 1m0s
[00:58:32.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:71:0)
[00:58:32.079] Timer tick, asking Buildbucket for the build status
[00:58:32.218] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:32.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:72:0) after 1m0s
[00:59:32.267] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:72:0)
[00:59:32.267] Timer tick, asking Buildbucket for the build status
[00:59:32.427] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:32.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:73:0) after 1m0s
[01:00:32.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:73:0)
[01:00:32.527] Timer tick, asking Buildbucket for the build status
[01:00:32.634] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:32.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:74:0) after 1m0s
[01:01:32.753] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:74:0)
[01:01:32.753] Timer tick, asking Buildbucket for the build status
[01:01:32.831] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:32.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:75:0) after 1m0s
[01:02:32.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:75:0)
[01:02:32.838] Timer tick, asking Buildbucket for the build status
[01:02:32.891] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:32.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:76:0) after 1m0s
[01:03:32.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:76:0)
[01:03:32.961] Timer tick, asking Buildbucket for the build status
[01:03:33.028] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:33.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:77:0) after 1m0s
[01:04:33.097] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:77:0)
[01:04:33.098] Timer tick, asking Buildbucket for the build status
[01:04:33.193] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:33.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:78:0) after 1m0s
[01:05:33.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:78:0)
[01:05:33.220] Timer tick, asking Buildbucket for the build status
[01:05:33.288] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:33.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:79:0) after 1m0s
[01:06:33.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:79:0)
[01:06:33.320] Timer tick, asking Buildbucket for the build status
[01:06:33.380] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:33.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:80:0) after 1m0s
[01:07:33.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:80:0)
[01:07:33.575] Timer tick, asking Buildbucket for the build status
[01:07:33.636] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:33.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:81:0) after 1m0s
[01:08:33.755] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:81:0)
[01:08:33.755] Timer tick, asking Buildbucket for the build status
[01:08:34.122] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:34.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:82:0) after 1m0s
[01:09:34.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:82:0)
[01:09:34.175] Timer tick, asking Buildbucket for the build status
[01:09:34.280] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:34.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:83:0) after 1m0s
[01:10:34.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:83:0)
[01:10:34.261] Timer tick, asking Buildbucket for the build status
[01:10:34.322] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:34.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:84:0) after 1m0s
[01:11:34.353] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:84:0)
[01:11:34.353] Timer tick, asking Buildbucket for the build status
[01:11:34.743] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:34.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:85:0) after 1m0s
[01:12:34.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:85:0)
[01:12:34.784] Timer tick, asking Buildbucket for the build status
[01:12:34.910] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:34.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:86:0) after 1m0s
[01:13:34.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:86:0)
[01:13:34.976] Timer tick, asking Buildbucket for the build status
[01:13:35.106] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:35.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:87:0) after 1m0s
[01:14:35.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:87:0)
[01:14:35.131] Timer tick, asking Buildbucket for the build status
[01:14:35.620] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:35.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:88:0) after 1m0s
[01:15:35.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:88:0)
[01:15:35.671] Timer tick, asking Buildbucket for the build status
[01:15:35.913] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:35.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:89:0) after 1m0s
[01:16:35.964] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:89:0)
[01:16:35.964] Timer tick, asking Buildbucket for the build status
[01:16:36.568] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:36.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:90:0) after 1m0s
[01:17:36.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:90:0)
[01:17:36.667] Timer tick, asking Buildbucket for the build status
[01:17:36.800] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:36.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:91:0) after 1m0s
[01:18:37.041] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:91:0)
[01:18:37.041] Timer tick, asking Buildbucket for the build status
[01:18:37.118] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:37.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:92:0) after 1m0s
[01:19:37.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:92:0)
[01:19:37.143] Timer tick, asking Buildbucket for the build status
[01:19:37.268] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:37.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:93:0) after 1m0s
[01:20:37.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:93:0)
[01:20:37.389] Timer tick, asking Buildbucket for the build status
[01:20:37.451] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:37.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:94:0) after 1m0s
[01:21:37.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:94:0)
[01:21:37.482] Timer tick, asking Buildbucket for the build status
[01:21:37.639] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:37.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:95:0) after 1m0s
[01:22:37.708] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:95:0)
[01:22:37.708] Timer tick, asking Buildbucket for the build status
[01:22:37.771] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:37.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:96:0) after 1m0s
[01:23:37.872] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:96:0)
[01:23:37.872] Timer tick, asking Buildbucket for the build status
[01:23:37.971] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:37.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:97:0) after 1m0s
[01:24:39.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:97:0)
[01:24:39.591] Timer tick, asking Buildbucket for the build status
[01:24:40.456] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:40.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:98:0) after 1m0s
[01:25:40.640] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:98:0)
[01:25:40.640] Timer tick, asking Buildbucket for the build status
[01:25:40.703] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:40.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:99:0) after 1m0s
[01:26:40.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:99:0)
[01:26:40.780] Timer tick, asking Buildbucket for the build status
[01:26:40.850] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:40.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:100:0) after 1m0s
[01:27:41.165] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:100:0)
[01:27:41.165] Timer tick, asking Buildbucket for the build status
[01:27:41.246] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:41.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:101:0) after 1m0s
[01:28:41.442] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:101:0)
[01:28:41.442] Timer tick, asking Buildbucket for the build status
[01:28:41.514] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:41.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:102:0) after 1m0s
[01:29:41.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:102:0)
[01:29:41.724] Timer tick, asking Buildbucket for the build status
[01:29:41.910] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:41.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:103:0) after 1m0s
[01:30:42.117] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:103:0)
[01:30:42.117] Timer tick, asking Buildbucket for the build status
[01:30:42.318] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:42.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:104:0) after 1m0s
[01:31:42.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:104:0)
[01:31:42.390] Timer tick, asking Buildbucket for the build status
[01:31:42.459] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:42.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:105:0) after 1m0s
[01:32:42.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:105:0)
[01:32:42.596] Timer tick, asking Buildbucket for the build status
[01:32:42.718] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:42.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:106:0) after 1m0s
[01:33:42.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:106:0)
[01:33:42.881] Timer tick, asking Buildbucket for the build status
[01:33:43.057] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:43.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:107:0) after 1m0s
[01:34:43.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:107:0)
[01:34:43.180] Timer tick, asking Buildbucket for the build status
[01:34:43.280] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:43.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:108:0) after 1m0s
[01:35:43.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:108:0)
[01:35:43.411] Timer tick, asking Buildbucket for the build status
[01:35:43.546] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:43.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:109:0) after 1m0s
[01:36:43.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:109:0)
[01:36:43.644] Timer tick, asking Buildbucket for the build status
[01:36:43.930] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:43.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:110:0) after 1m0s
[01:37:44.160] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:110:0)
[01:37:44.160] Timer tick, asking Buildbucket for the build status
[01:37:44.439] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:44.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:111:0) after 1m0s
[01:38:44.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:111:0)
[01:38:44.510] Timer tick, asking Buildbucket for the build status
[01:38:44.788] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:44.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:112:0) after 1m0s
[01:39:44.875] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:112:0)
[01:39:44.875] Timer tick, asking Buildbucket for the build status
[01:39:45.010] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:45.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:113:0) after 1m0s
[01:40:45.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:113:0)
[01:40:45.079] Timer tick, asking Buildbucket for the build status
[01:40:45.165] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:45.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:114:0) after 1m0s
[01:41:45.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:114:0)
[01:41:45.149] Timer tick, asking Buildbucket for the build status
[01:41:45.218] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:45.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:115:0) after 1m0s
[01:42:45.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:115:0)
[01:42:45.258] Timer tick, asking Buildbucket for the build status
[01:42:45.818] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:45.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:116:0) after 1m0s
[01:43:45.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:116:0)
[01:43:45.837] Timer tick, asking Buildbucket for the build status
[01:43:45.914] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:45.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:117:0) after 1m0s
[01:44:45.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:117:0)
[01:44:45.978] Timer tick, asking Buildbucket for the build status
[01:44:46.212] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:46.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:118:0) after 1m0s
[01:45:46.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:118:0)
[01:45:46.275] Timer tick, asking Buildbucket for the build status
[01:45:46.330] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:46.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:119:0) after 1m0s
[01:46:46.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:119:0)
[01:46:46.393] Timer tick, asking Buildbucket for the build status
[01:46:46.461] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:46.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:120:0) after 1m0s
[01:47:46.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:120:0)
[01:47:46.567] Timer tick, asking Buildbucket for the build status
[01:47:46.652] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:46.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:121:0) after 1m0s
[01:48:46.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:121:0)
[01:48:46.642] Timer tick, asking Buildbucket for the build status
[01:48:46.898] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:46.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:122:0) after 1m0s
[01:49:46.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:122:0)
[01:49:46.987] Timer tick, asking Buildbucket for the build status
[01:49:47.227] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:47.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:123:0) after 1m0s
[01:50:47.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:123:0)
[01:50:47.336] Timer tick, asking Buildbucket for the build status
[01:50:47.399] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:47.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:124:0) after 1m0s
[01:51:47.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:124:0)
[01:51:47.501] Timer tick, asking Buildbucket for the build status
[01:51:47.562] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:47.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:125:0) after 1m0s
[01:52:47.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:125:0)
[01:52:47.714] Timer tick, asking Buildbucket for the build status
[01:52:47.770] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:47.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:126:0) after 1m0s
[01:53:47.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:126:0)
[01:53:47.802] Timer tick, asking Buildbucket for the build status
[01:53:47.861] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:47.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:127:0) after 1m0s
[01:54:47.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:127:0)
[01:54:47.925] Timer tick, asking Buildbucket for the build status
[01:54:48.226] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:48.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:128:0) after 1m0s
[01:55:48.276] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:128:0)
[01:55:48.276] Timer tick, asking Buildbucket for the build status
[01:55:48.334] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:48.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:129:0) after 1m0s
[01:56:48.386] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:129:0)
[01:56:48.386] Timer tick, asking Buildbucket for the build status
[01:56:48.468] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:48.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:130:0) after 1m0s
[01:57:48.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:130:0)
[01:57:48.694] Timer tick, asking Buildbucket for the build status
[01:57:48.764] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:48.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:131:0) after 1m0s
[01:58:48.895] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:131:0)
[01:58:48.895] Timer tick, asking Buildbucket for the build status
[01:58:48.986] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:48.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:132:0) after 1m0s
[01:59:49.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:132:0)
[01:59:49.171] Timer tick, asking Buildbucket for the build status
[01:59:49.276] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:49.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:133:0) after 1m0s
[02:00:49.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:133:0)
[02:00:49.510] Timer tick, asking Buildbucket for the build status
[02:00:49.617] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:49.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:134:0) after 1m0s
[02:01:49.726] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:134:0)
[02:01:49.726] Timer tick, asking Buildbucket for the build status
[02:01:49.849] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:49.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:135:0) after 1m0s
[02:02:49.926] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:135:0)
[02:02:49.926] Timer tick, asking Buildbucket for the build status
[02:02:49.994] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:49.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:136:0) after 1m0s
[02:03:50.123] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:136:0)
[02:03:50.123] Timer tick, asking Buildbucket for the build status
[02:03:50.332] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:50.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:137:0) after 1m0s
[02:04:50.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:137:0)
[02:04:50.377] Timer tick, asking Buildbucket for the build status
[02:04:50.817] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:50.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:138:0) after 1m0s
[02:05:50.817] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:138:0)
[02:05:50.817] Timer tick, asking Buildbucket for the build status
[02:05:50.898] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:50.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:139:0) after 1m0s
[02:06:51.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:139:0)
[02:06:51.043] Timer tick, asking Buildbucket for the build status
[02:06:51.186] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:51.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:140:0) after 1m0s
[02:07:51.258] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:140:0)
[02:07:51.258] Timer tick, asking Buildbucket for the build status
[02:07:51.443] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:51.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:141:0) after 1m0s
[02:08:51.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:141:0)
[02:08:51.475] Timer tick, asking Buildbucket for the build status
[02:08:51.543] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:51.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:142:0) after 1m0s
[02:09:51.578] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:142:0)
[02:09:51.578] Timer tick, asking Buildbucket for the build status
[02:09:51.671] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:51.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:143:0) after 1m0s
[02:10:51.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:143:0)
[02:10:51.718] Timer tick, asking Buildbucket for the build status
[02:10:51.779] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:51.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:144:0) after 1m0s
[02:11:51.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:144:0)
[02:11:51.791] Timer tick, asking Buildbucket for the build status
[02:11:51.926] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:51.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:145:0) after 1m0s
[02:12:51.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:145:0)
[02:12:51.986] Timer tick, asking Buildbucket for the build status
[02:12:52.036] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:52.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:146:0) after 1m0s
[02:13:52.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:146:0)
[02:13:52.086] Timer tick, asking Buildbucket for the build status
[02:13:52.289] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:52.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:147:0) after 1m0s
[02:14:52.315] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:147:0)
[02:14:52.315] Timer tick, asking Buildbucket for the build status
[02:14:52.444] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:52.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:148:0) after 1m0s
[02:15:52.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:148:0)
[02:15:52.495] Timer tick, asking Buildbucket for the build status
[02:15:52.882] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:52.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:149:0) after 1m0s
[02:16:52.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:149:0)
[02:16:52.959] Timer tick, asking Buildbucket for the build status
[02:16:53.192] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:53.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:150:0) after 1m0s
[02:17:53.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:150:0)
[02:17:53.375] Timer tick, asking Buildbucket for the build status
[02:17:53.544] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:53.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:151:0) after 1m0s
[02:18:53.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:151:0)
[02:18:53.584] Timer tick, asking Buildbucket for the build status
[02:18:53.661] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:53.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:152:0) after 1m0s
[02:19:53.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:152:0)
[02:19:53.676] Timer tick, asking Buildbucket for the build status
[02:19:54.291] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:54.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:153:0) after 1m0s
[02:20:54.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:153:0)
[02:20:54.454] Timer tick, asking Buildbucket for the build status
[02:20:54.524] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:54.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:154:0) after 1m0s
[02:21:54.557] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:154:0)
[02:21:54.557] Timer tick, asking Buildbucket for the build status
[02:21:54.692] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:54.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:155:0) after 1m0s
[02:22:54.758] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:155:0)
[02:22:54.758] Timer tick, asking Buildbucket for the build status
[02:22:54.991] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:54.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:156:0) after 1m0s
[02:23:55.100] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:156:0)
[02:23:55.100] Timer tick, asking Buildbucket for the build status
[02:23:55.475] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:55.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:157:0) after 1m0s
[02:24:55.604] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:157:0)
[02:24:55.604] Timer tick, asking Buildbucket for the build status
[02:24:55.767] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:55.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:158:0) after 1m0s
[02:25:55.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:158:0)
[02:25:55.781] Timer tick, asking Buildbucket for the build status
[02:25:55.846] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:55.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:159:0) after 1m0s
[02:26:55.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:159:0)
[02:26:55.828] Timer tick, asking Buildbucket for the build status
[02:26:56.087] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:56.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:160:0) after 1m0s
[02:27:56.154] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:160:0)
[02:27:56.154] Timer tick, asking Buildbucket for the build status
[02:27:56.260] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:56.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:161:0) after 1m0s
[02:28:56.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:161:0)
[02:28:56.311] Timer tick, asking Buildbucket for the build status
[02:28:56.524] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:56.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:162:0) after 1m0s
[02:29:56.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:162:0)
[02:29:56.679] Timer tick, asking Buildbucket for the build status
[02:29:56.922] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:56.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:163:0) after 1m0s
[02:30:57.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:163:0)
[02:30:57.122] Timer tick, asking Buildbucket for the build status
[02:30:57.218] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:57.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:164:0) after 1m0s
[02:31:57.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:164:0)
[02:31:57.233] Timer tick, asking Buildbucket for the build status
[02:31:57.344] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:57.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:165:0) after 1m0s
[02:32:57.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:165:0)
[02:32:57.373] Timer tick, asking Buildbucket for the build status
[02:32:57.675] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:57.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:166:0) after 1m0s
[02:33:57.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:166:0)
[02:33:57.701] Timer tick, asking Buildbucket for the build status
[02:33:57.889] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:57.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:167:0) after 1m0s
[02:34:57.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:167:0)
[02:34:57.976] Timer tick, asking Buildbucket for the build status
[02:34:58.266] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:58.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:168:0) after 1m0s
[02:35:58.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:168:0)
[02:35:58.287] Timer tick, asking Buildbucket for the build status
[02:35:58.422] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:58.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:169:0) after 1m0s
[02:36:58.489] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:169:0)
[02:36:58.489] Timer tick, asking Buildbucket for the build status
[02:36:58.759] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:58.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:170:0) after 1m0s
[02:37:58.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:170:0)
[02:37:58.783] Timer tick, asking Buildbucket for the build status
[02:37:58.853] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:58.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:171:0) after 1m0s
[02:38:58.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:171:0)
[02:38:58.892] Timer tick, asking Buildbucket for the build status
[02:38:58.966] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:58.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:172:0) after 1m0s
[02:39:59.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:172:0)
[02:39:59.024] Timer tick, asking Buildbucket for the build status
[02:39:59.394] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:59.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:173:0) after 1m0s
[02:40:59.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:173:0)
[02:40:59.445] Timer tick, asking Buildbucket for the build status
[02:40:59.503] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:59.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:174:0) after 1m0s
[02:41:59.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:174:0)
[02:41:59.584] Timer tick, asking Buildbucket for the build status
[02:41:59.640] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:59.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:175:0) after 1m0s
[02:42:59.711] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:175:0)
[02:42:59.711] Timer tick, asking Buildbucket for the build status
[02:42:59.899] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:59.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:176:0) after 1m0s
[02:44:00.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:176:0)
[02:44:00.056] Timer tick, asking Buildbucket for the build status
[02:44:00.152] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:00.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:177:0) after 1m0s
[02:45:00.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:177:0)
[02:45:00.229] Timer tick, asking Buildbucket for the build status
[02:45:00.327] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:00.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:178:0) after 1m0s
[02:46:00.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:178:0)
[02:46:00.359] Timer tick, asking Buildbucket for the build status
[02:46:00.837] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:00.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:179:0) after 1m0s
[02:47:01.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:179:0)
[02:47:01.106] Timer tick, asking Buildbucket for the build status
[02:47:01.516] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:01.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:180:0) after 1m0s
[02:48:01.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:180:0)
[02:48:01.510] Timer tick, asking Buildbucket for the build status
[02:48:01.621] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:01.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:181:0) after 1m0s
[02:49:01.708] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:181:0)
[02:49:01.708] Timer tick, asking Buildbucket for the build status
[02:49:01.790] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:01.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:182:0) after 1m0s
[02:50:01.813] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:182:0)
[02:50:01.813] Timer tick, asking Buildbucket for the build status
[02:50:02.014] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:02.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:183:0) after 1m0s
[02:51:02.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:183:0)
[02:51:02.448] Timer tick, asking Buildbucket for the build status
[02:51:02.542] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:02.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:184:0) after 1m0s
[02:52:02.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:184:0)
[02:52:02.550] Timer tick, asking Buildbucket for the build status
[02:52:02.798] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:02.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:185:0) after 1m0s
[02:53:02.846] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:185:0)
[02:53:02.846] Timer tick, asking Buildbucket for the build status
[02:53:03.083] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:03.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:186:0) after 1m0s
[02:54:03.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:186:0)
[02:54:03.112] Timer tick, asking Buildbucket for the build status
[02:54:03.306] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:03.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:187:0) after 1m0s
[02:55:03.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:187:0)
[02:55:03.333] Timer tick, asking Buildbucket for the build status
[02:55:03.929] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:03.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:188:0) after 1m0s
[02:56:04.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:188:0)
[02:56:04.032] Timer tick, asking Buildbucket for the build status
[02:56:04.111] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:04.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:189:0) after 1m0s
[02:57:04.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:189:0)
[02:57:04.138] Timer tick, asking Buildbucket for the build status
[02:57:04.407] Build 8856092617432502320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:04.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9021522680073950304:190:0) after 1m0s
[02:57:23.147] Received PubSub notification, asking Buildbucket for the build status
[02:57:23.201] Build 8856092617432502320: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:57:23.201] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1612580242330982",
    "created_by": "project:chromium",
    "created_ts": "1612568949247103",
    "id": "8856092617432502320",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ae887705b8b61607eedb3da3bad12d886c34cd88\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"ae887705b8b61607eedb3da3bad12d886c34cd88\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-5-bpxy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1545, \"got_angle_revision\": \"d3c00f959f9d4c071143dbe36ba22f8de68d8c67\", \"got_dawn_revision\": \"14a2398e711f5df5dbb0ec45999d6b16c1e80304\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"ae887705b8b61607eedb3da3bad12d886c34cd88\", \"got_revision_cp\": \"refs/heads/master@{#851346}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"711403215714087a74f05b1382b18e4c318be936\", \"got_v8_revision_cp\": \"refs/heads/9.0.137@{#1}\", \"got_webrtc_revision\": \"1184b5537fdc37535cb3d099db6a49a2b759f20b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33176}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ae887705b8b61607eedb3da3bad12d886c34cd88\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-5-bpxy\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1612568992701170",
    "status": "COMPLETED",
    "status_changed_ts": "1612580242817031",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1545",
      "builder:win-official",
      "buildset:commit/git/ae887705b8b61607eedb3da3bad12d886c34cd88",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ae887705b8b61607eedb3da3bad12d886c34cd88",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021522680073950304",
      "scheduler_job_id:chromium/win-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856092617432502320/+/annotations",
      "swarming_tag:luci_project:chromium",
      "swarming_tag:os:Windows",
      "swarming_tag:recipe_name:chromium",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:518d6afc701cd910",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612580242846727",
    "url": "https://ci.chromium.org/b/8856092617432502320",
    "utcnow_ts": "1612580243194630"
  }
}
[02:57:23.202] Invocation finished in 3h8m15.857727613s with status SUCCEEDED