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

Definition (rev 61da5958bb1bf61dc6dab9a9ab14fa46798b5d0f)

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

Incoming tags

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

Debug log (UTC)

[00:02:53.540] New invocation is queued and will start shortly
[00:02:56.306] Starting the invocation (attempt 1)
[00:02:56.343] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:02:56.343] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:02:56.343] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9035836134459726416",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e4e25208b29420190e4c9aec56835551615141d3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9035836134459726416",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/e4e25208b29420190e4c9aec56835551615141d3",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4e25208b29420190e4c9aec56835551615141d3",
    "gitiles_ref:refs/heads/master"
  ]
}
[00:02:58.029] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1598918576469923",
    "id": "8870406070718515024",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4e25208b29420190e4c9aec56835551615141d3\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1598918577441485",
    "tags": [
      "build_address:luci.chromium.ci/win-official/475",
      "builder:win-official",
      "buildset:commit/git/e4e25208b29420190e4c9aec56835551615141d3",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4e25208b29420190e4c9aec56835551615141d3",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9035836134459726416",
      "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/8870406070718515024/+/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": "1598918577441664",
    "url": "https://ci.chromium.org/b/8870406070718515024",
    "utcnow_ts": "1598918577987970"
  }
}
[00:02:58.029] Task URL: https://ci.chromium.org/b/8870406070718515024
[00:02:58.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:2:0) after 1m0s
[00:03:58.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:2:0)
[00:03:58.209] Timer tick, asking Buildbucket for the build status
[00:03:58.328] Build 8870406070718515024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:58.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:3:0) after 1m0s
[00:04:58.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:3:0)
[00:04:58.381] Timer tick, asking Buildbucket for the build status
[00:04:58.507] Build 8870406070718515024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:58.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:4:0) after 1m0s
[00:05:58.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:4:0)
[00:05:58.587] Timer tick, asking Buildbucket for the build status
[00:05:58.700] Build 8870406070718515024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:58.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:5:0) after 1m0s
[00:06:58.713] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:5:0)
[00:06:58.713] Timer tick, asking Buildbucket for the build status
[00:06:58.982] Build 8870406070718515024: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:58.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:6:0) after 1m0s
[00:07:34.149] Received PubSub notification, asking Buildbucket for the build status
[00:07:34.264] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:59.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:6:0)
[00:07:59.005] Timer tick, asking Buildbucket for the build status
[00:07:59.226] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:59.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:8:0) after 1m0s
[00:08:59.330] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:8:0)
[00:08:59.330] Timer tick, asking Buildbucket for the build status
[00:08:59.448] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:59.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:9:0) after 1m0s
[00:09:59.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:9:0)
[00:09:59.560] Timer tick, asking Buildbucket for the build status
[00:09:59.707] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:59.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:10:0) after 1m0s
[00:10:59.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:10:0)
[00:10:59.749] Timer tick, asking Buildbucket for the build status
[00:10:59.859] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:59.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:11:0) after 1m0s
[00:11:59.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:11:0)
[00:11:59.941] Timer tick, asking Buildbucket for the build status
[00:12:02.446] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:02.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:12:0) after 1m0s
[00:13:02.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:12:0)
[00:13:02.546] Timer tick, asking Buildbucket for the build status
[00:13:02.752] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:02.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:13:0) after 1m0s
[00:14:02.906] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:13:0)
[00:14:02.906] Timer tick, asking Buildbucket for the build status
[00:14:02.965] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:02.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:14:0) after 1m0s
[00:15:03.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:14:0)
[00:15:03.265] Timer tick, asking Buildbucket for the build status
[00:15:03.402] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:03.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:15:0) after 1m0s
[00:16:03.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:15:0)
[00:16:03.450] Timer tick, asking Buildbucket for the build status
[00:16:03.765] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:03.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:16:0) after 1m0s
[00:17:03.801] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:16:0)
[00:17:03.801] Timer tick, asking Buildbucket for the build status
[00:17:03.930] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:03.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:17:0) after 1m0s
[00:18:03.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:17:0)
[00:18:03.940] Timer tick, asking Buildbucket for the build status
[00:18:04.236] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:04.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:18:0) after 1m0s
[00:19:04.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:18:0)
[00:19:04.307] Timer tick, asking Buildbucket for the build status
[00:19:04.744] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:04.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:19:0) after 1m0s
[00:20:04.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:19:0)
[00:20:04.815] Timer tick, asking Buildbucket for the build status
[00:20:05.332] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:05.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:20:0) after 1m0s
[00:21:05.632] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:20:0)
[00:21:05.632] Timer tick, asking Buildbucket for the build status
[00:21:06.173] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:06.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:21:0) after 1m0s
[00:22:06.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:21:0)
[00:22:06.261] Timer tick, asking Buildbucket for the build status
[00:22:06.362] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:06.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:22:0) after 1m0s
[00:23:06.418] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:22:0)
[00:23:06.418] Timer tick, asking Buildbucket for the build status
[00:23:06.573] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:06.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:23:0) after 1m0s
[00:24:06.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:23:0)
[00:24:06.614] Timer tick, asking Buildbucket for the build status
[00:24:07.391] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:07.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:24:0) after 1m0s
[00:25:07.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:24:0)
[00:25:07.525] Timer tick, asking Buildbucket for the build status
[00:25:07.704] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:07.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:25:0) after 1m0s
[00:26:07.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:25:0)
[00:26:07.807] Timer tick, asking Buildbucket for the build status
[00:26:07.958] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:07.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:26:0) after 1m0s
[00:27:08.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:26:0)
[00:27:08.002] Timer tick, asking Buildbucket for the build status
[00:27:08.081] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:08.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:27:0) after 1m0s
[00:28:08.142] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:27:0)
[00:28:08.143] Timer tick, asking Buildbucket for the build status
[00:28:08.273] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:08.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:28:0) after 1m0s
[00:29:08.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:28:0)
[00:29:08.320] Timer tick, asking Buildbucket for the build status
[00:29:09.415] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:09.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:29:0) after 1m0s
[00:30:09.545] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:29:0)
[00:30:09.545] Timer tick, asking Buildbucket for the build status
[00:30:09.872] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:09.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:30:0) after 1m0s
[00:31:10.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:30:0)
[00:31:10.005] Timer tick, asking Buildbucket for the build status
[00:31:10.214] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:10.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:31:0) after 1m0s
[00:32:10.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:31:0)
[00:32:10.383] Timer tick, asking Buildbucket for the build status
[00:32:10.652] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:10.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:32:0) after 1m0s
[00:33:10.767] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:32:0)
[00:33:10.767] Timer tick, asking Buildbucket for the build status
[00:33:11.018] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:11.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:33:0) after 1m0s
[00:34:11.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:33:0)
[00:34:11.157] Timer tick, asking Buildbucket for the build status
[00:34:11.274] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:11.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:34:0) after 1m0s
[00:35:11.374] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:34:0)
[00:35:11.374] Timer tick, asking Buildbucket for the build status
[00:35:11.620] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:11.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:35:0) after 1m0s
[00:36:11.725] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:35:0)
[00:36:11.725] Timer tick, asking Buildbucket for the build status
[00:36:12.153] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:12.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:36:0) after 1m0s
[00:37:12.160] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:36:0)
[00:37:12.160] Timer tick, asking Buildbucket for the build status
[00:37:12.316] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:12.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:37:0) after 1m0s
[00:38:12.342] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:37:0)
[00:38:12.342] Timer tick, asking Buildbucket for the build status
[00:38:12.664] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:12.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:38:0) after 1m0s
[00:39:12.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:38:0)
[00:39:12.696] Timer tick, asking Buildbucket for the build status
[00:39:12.794] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:12.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:39:0) after 1m0s
[00:40:12.839] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:39:0)
[00:40:12.839] Timer tick, asking Buildbucket for the build status
[00:40:13.017] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:13.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:40:0) after 1m0s
[00:41:13.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:40:0)
[00:41:13.274] Timer tick, asking Buildbucket for the build status
[00:41:13.685] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:13.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:41:0) after 1m0s
[00:42:13.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:41:0)
[00:42:13.759] Timer tick, asking Buildbucket for the build status
[00:42:13.921] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:13.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:42:0) after 1m0s
[00:43:13.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:42:0)
[00:43:13.970] Timer tick, asking Buildbucket for the build status
[00:43:14.124] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:14.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:43:0) after 1m0s
[00:44:14.222] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:43:0)
[00:44:14.222] Timer tick, asking Buildbucket for the build status
[00:44:14.367] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:14.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:44:0) after 1m0s
[00:45:14.467] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:44:0)
[00:45:14.467] Timer tick, asking Buildbucket for the build status
[00:45:14.569] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:14.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:45:0) after 1m0s
[00:46:14.600] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:45:0)
[00:46:14.600] Timer tick, asking Buildbucket for the build status
[00:46:14.667] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:14.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:46:0) after 1m0s
[00:47:14.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:46:0)
[00:47:14.728] Timer tick, asking Buildbucket for the build status
[00:47:14.844] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:14.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:47:0) after 1m0s
[00:48:15.091] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:47:0)
[00:48:15.091] Timer tick, asking Buildbucket for the build status
[00:48:15.311] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:15.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:48:0) after 1m0s
[00:49:15.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:48:0)
[00:49:15.338] Timer tick, asking Buildbucket for the build status
[00:49:15.410] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:15.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:49:0) after 1m0s
[00:50:15.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:49:0)
[00:50:15.530] Timer tick, asking Buildbucket for the build status
[00:50:15.681] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:15.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:50:0) after 1m0s
[00:51:15.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:50:0)
[00:51:15.924] Timer tick, asking Buildbucket for the build status
[00:51:16.024] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:16.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:51:0) after 1m0s
[00:52:16.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:51:0)
[00:52:16.065] Timer tick, asking Buildbucket for the build status
[00:52:16.186] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:16.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:52:0) after 1m0s
[00:53:16.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:52:0)
[00:53:16.311] Timer tick, asking Buildbucket for the build status
[00:53:16.524] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:16.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:53:0) after 1m0s
[00:54:16.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:53:0)
[00:54:16.760] Timer tick, asking Buildbucket for the build status
[00:54:16.887] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:16.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:54:0) after 1m0s
[00:55:16.977] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:54:0)
[00:55:16.977] Timer tick, asking Buildbucket for the build status
[00:55:17.232] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:17.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:55:0) after 1m0s
[00:56:17.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:55:0)
[00:56:17.257] Timer tick, asking Buildbucket for the build status
[00:56:17.335] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:17.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:56:0) after 1m0s
[00:57:17.496] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:56:0)
[00:57:17.496] Timer tick, asking Buildbucket for the build status
[00:57:17.733] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:17.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:57:0) after 1m0s
[00:58:17.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:57:0)
[00:58:17.823] Timer tick, asking Buildbucket for the build status
[00:58:18.066] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:18.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:58:0) after 1m0s
[00:59:18.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:58:0)
[00:59:18.066] Timer tick, asking Buildbucket for the build status
[00:59:18.244] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:18.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:59:0) after 1m0s
[01:00:18.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:59:0)
[01:00:18.295] Timer tick, asking Buildbucket for the build status
[01:00:18.559] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:18.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:60:0) after 1m0s
[01:01:18.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:60:0)
[01:01:18.654] Timer tick, asking Buildbucket for the build status
[01:01:19.531] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:19.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:61:0) after 1m0s
[01:02:19.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:61:0)
[01:02:19.580] Timer tick, asking Buildbucket for the build status
[01:02:19.797] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:19.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:62:0) after 1m0s
[01:03:19.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:62:0)
[01:03:19.873] Timer tick, asking Buildbucket for the build status
[01:03:20.014] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:20.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:63:0) after 1m0s
[01:04:20.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:63:0)
[01:04:20.176] Timer tick, asking Buildbucket for the build status
[01:04:21.659] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:21.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:64:0) after 1m0s
[01:05:21.666] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:64:0)
[01:05:21.666] Timer tick, asking Buildbucket for the build status
[01:05:21.815] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:21.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:65:0) after 1m0s
[01:06:21.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:65:0)
[01:06:21.808] Timer tick, asking Buildbucket for the build status
[01:06:21.901] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:21.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:66:0) after 1m0s
[01:07:22.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:66:0)
[01:07:22.121] Timer tick, asking Buildbucket for the build status
[01:07:22.386] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:22.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:67:0) after 1m0s
[01:08:22.558] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:67:0)
[01:08:22.558] Timer tick, asking Buildbucket for the build status
[01:08:22.828] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:22.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:68:0) after 1m0s
[01:09:22.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:68:0)
[01:09:22.938] Timer tick, asking Buildbucket for the build status
[01:09:25.806] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:25.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:69:0) after 1m0s
[01:10:26.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:69:0)
[01:10:26.257] Timer tick, asking Buildbucket for the build status
[01:10:26.336] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:26.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:70:0) after 1m0s
[01:11:26.514] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:70:0)
[01:11:26.514] Timer tick, asking Buildbucket for the build status
[01:11:26.784] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:26.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:71:0) after 1m0s
[01:12:26.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:71:0)
[01:12:26.878] Timer tick, asking Buildbucket for the build status
[01:12:26.987] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:26.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:72:0) after 1m0s
[01:13:27.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:72:0)
[01:13:27.211] Timer tick, asking Buildbucket for the build status
[01:13:28.121] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:28.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:73:0) after 1m0s
[01:14:28.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:73:0)
[01:14:28.310] Timer tick, asking Buildbucket for the build status
[01:14:28.417] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:28.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:74:0) after 1m0s
[01:15:28.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:74:0)
[01:15:28.603] Timer tick, asking Buildbucket for the build status
[01:15:28.711] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:28.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:75:0) after 1m0s
[01:16:28.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:75:0)
[01:16:28.900] Timer tick, asking Buildbucket for the build status
[01:16:29.003] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:29.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:76:0) after 1m0s
[01:17:29.207] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:76:0)
[01:17:29.207] Timer tick, asking Buildbucket for the build status
[01:17:29.885] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:29.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:77:0) after 1m0s
[01:18:29.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:77:0)
[01:18:29.911] Timer tick, asking Buildbucket for the build status
[01:18:30.052] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:30.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:78:0) after 1m0s
[01:19:30.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:78:0)
[01:19:30.132] Timer tick, asking Buildbucket for the build status
[01:19:30.194] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:30.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:79:0) after 1m0s
[01:20:30.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:79:0)
[01:20:30.340] Timer tick, asking Buildbucket for the build status
[01:20:30.582] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:30.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:80:0) after 1m0s
[01:21:30.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:80:0)
[01:21:30.756] Timer tick, asking Buildbucket for the build status
[01:21:30.847] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:30.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:81:0) after 1m0s
[01:22:31.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:81:0)
[01:22:31.054] Timer tick, asking Buildbucket for the build status
[01:22:31.290] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:31.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:82:0) after 1m0s
[01:23:31.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:82:0)
[01:23:31.383] Timer tick, asking Buildbucket for the build status
[01:23:32.910] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:32.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:83:0) after 1m0s
[01:24:33.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:83:0)
[01:24:33.224] Timer tick, asking Buildbucket for the build status
[01:24:33.587] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:33.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:84:0) after 1m0s
[01:25:33.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:84:0)
[01:25:33.667] Timer tick, asking Buildbucket for the build status
[01:25:34.033] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:34.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:85:0) after 1m0s
[01:26:34.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:85:0)
[01:26:34.109] Timer tick, asking Buildbucket for the build status
[01:26:34.380] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:34.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:86:0) after 1m0s
[01:27:34.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:86:0)
[01:27:34.712] Timer tick, asking Buildbucket for the build status
[01:27:34.955] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:34.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:87:0) after 1m0s
[01:28:35.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:87:0)
[01:28:35.068] Timer tick, asking Buildbucket for the build status
[01:28:35.234] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:35.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:88:0) after 1m0s
[01:29:35.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:88:0)
[01:29:35.278] Timer tick, asking Buildbucket for the build status
[01:29:35.335] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:35.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:89:0) after 1m0s
[01:30:35.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:89:0)
[01:30:35.343] Timer tick, asking Buildbucket for the build status
[01:30:35.737] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:35.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:90:0) after 1m0s
[01:31:35.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:90:0)
[01:31:35.757] Timer tick, asking Buildbucket for the build status
[01:31:35.846] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:35.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:91:0) after 1m0s
[01:32:35.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:91:0)
[01:32:35.916] Timer tick, asking Buildbucket for the build status
[01:32:36.008] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:36.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:92:0) after 1m0s
[01:33:36.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:92:0)
[01:33:36.114] Timer tick, asking Buildbucket for the build status
[01:33:36.331] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:36.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:93:0) after 1m0s
[01:34:36.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:93:0)
[01:34:36.457] Timer tick, asking Buildbucket for the build status
[01:34:36.552] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:36.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:94:0) after 1m0s
[01:35:36.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:94:0)
[01:35:36.580] Timer tick, asking Buildbucket for the build status
[01:35:36.669] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:36.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:95:0) after 1m0s
[01:36:36.737] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:95:0)
[01:36:36.737] Timer tick, asking Buildbucket for the build status
[01:36:36.841] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:36.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:96:0) after 1m0s
[01:37:36.982] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:96:0)
[01:37:36.982] Timer tick, asking Buildbucket for the build status
[01:37:37.433] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:37.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:97:0) after 1m0s
[01:38:37.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:97:0)
[01:38:37.512] Timer tick, asking Buildbucket for the build status
[01:38:37.774] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:37.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:98:0) after 1m0s
[01:39:37.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:98:0)
[01:39:37.818] Timer tick, asking Buildbucket for the build status
[01:39:37.881] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:37.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:99:0) after 1m0s
[01:40:37.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:99:0)
[01:40:37.950] Timer tick, asking Buildbucket for the build status
[01:40:38.046] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:38.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:100:0) after 1m0s
[01:41:38.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:100:0)
[01:41:38.066] Timer tick, asking Buildbucket for the build status
[01:41:38.152] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:38.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:101:0) after 1m0s
[01:42:38.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:101:0)
[01:42:38.263] Timer tick, asking Buildbucket for the build status
[01:42:38.453] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:38.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:102:0) after 1m0s
[01:43:38.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:102:0)
[01:43:38.631] Timer tick, asking Buildbucket for the build status
[01:43:38.768] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:38.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:103:0) after 1m0s
[01:44:38.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:103:0)
[01:44:38.811] Timer tick, asking Buildbucket for the build status
[01:44:38.904] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:38.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:104:0) after 1m0s
[01:45:39.000] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:104:0)
[01:45:39.000] Timer tick, asking Buildbucket for the build status
[01:45:39.104] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:39.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:105:0) after 1m0s
[01:46:39.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:105:0)
[01:46:39.206] Timer tick, asking Buildbucket for the build status
[01:46:39.316] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:39.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:106:0) after 1m0s
[01:47:39.459] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:106:0)
[01:47:39.459] Timer tick, asking Buildbucket for the build status
[01:47:39.686] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:39.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:107:0) after 1m0s
[01:48:39.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:107:0)
[01:48:39.723] Timer tick, asking Buildbucket for the build status
[01:48:40.438] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:40.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:108:0) after 1m0s
[01:49:40.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:108:0)
[01:49:40.568] Timer tick, asking Buildbucket for the build status
[01:49:40.631] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:40.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:109:0) after 1m0s
[01:50:40.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:109:0)
[01:50:40.687] Timer tick, asking Buildbucket for the build status
[01:50:40.812] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:40.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:110:0) after 1m0s
[01:51:40.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:110:0)
[01:51:40.832] Timer tick, asking Buildbucket for the build status
[01:51:40.999] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:40.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:111:0) after 1m0s
[01:52:41.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:111:0)
[01:52:41.003] Timer tick, asking Buildbucket for the build status
[01:52:41.102] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:41.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:112:0) after 1m0s
[01:53:41.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:112:0)
[01:53:41.124] Timer tick, asking Buildbucket for the build status
[01:53:42.578] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:42.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:113:0) after 1m0s
[01:54:42.621] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:113:0)
[01:54:42.621] Timer tick, asking Buildbucket for the build status
[01:54:42.744] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:42.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:114:0) after 1m0s
[01:55:42.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:114:0)
[01:55:42.811] Timer tick, asking Buildbucket for the build status
[01:55:42.889] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:42.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:115:0) after 1m0s
[01:56:42.890] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:115:0)
[01:56:42.890] Timer tick, asking Buildbucket for the build status
[01:56:42.953] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:42.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:116:0) after 1m0s
[01:57:43.074] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:116:0)
[01:57:43.074] Timer tick, asking Buildbucket for the build status
[01:57:43.379] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:43.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:117:0) after 1m0s
[01:58:43.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:117:0)
[01:58:43.493] Timer tick, asking Buildbucket for the build status
[01:58:43.743] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:43.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:118:0) after 1m0s
[01:59:43.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:118:0)
[01:59:43.784] Timer tick, asking Buildbucket for the build status
[01:59:43.873] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:43.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:119:0) after 1m0s
[02:00:43.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:119:0)
[02:00:43.924] Timer tick, asking Buildbucket for the build status
[02:00:44.009] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:44.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:120:0) after 1m0s
[02:01:44.039] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:120:0)
[02:01:44.039] Timer tick, asking Buildbucket for the build status
[02:01:44.119] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:44.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:121:0) after 1m0s
[02:02:44.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:121:0)
[02:02:44.201] Timer tick, asking Buildbucket for the build status
[02:02:44.274] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:44.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:122:0) after 1m0s
[02:03:44.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:122:0)
[02:03:44.275] Timer tick, asking Buildbucket for the build status
[02:03:44.598] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:44.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:123:0) after 1m0s
[02:04:44.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:123:0)
[02:04:44.647] Timer tick, asking Buildbucket for the build status
[02:04:44.993] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:44.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:124:0) after 1m0s
[02:05:45.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:124:0)
[02:05:45.029] Timer tick, asking Buildbucket for the build status
[02:05:45.109] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:45.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:125:0) after 1m0s
[02:06:45.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:125:0)
[02:06:45.399] Timer tick, asking Buildbucket for the build status
[02:06:46.026] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:46.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:126:0) after 1m0s
[02:07:46.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:126:0)
[02:07:46.120] Timer tick, asking Buildbucket for the build status
[02:07:46.612] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:46.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:127:0) after 1m0s
[02:08:46.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:127:0)
[02:08:46.662] Timer tick, asking Buildbucket for the build status
[02:08:46.862] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:46.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:128:0) after 1m0s
[02:09:46.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:128:0)
[02:09:46.884] Timer tick, asking Buildbucket for the build status
[02:09:47.042] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:47.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:129:0) after 1m0s
[02:10:47.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:129:0)
[02:10:47.186] Timer tick, asking Buildbucket for the build status
[02:10:47.558] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:47.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:130:0) after 1m0s
[02:11:47.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:130:0)
[02:11:47.562] Timer tick, asking Buildbucket for the build status
[02:11:47.875] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:47.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:131:0) after 1m0s
[02:12:47.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:131:0)
[02:12:47.891] Timer tick, asking Buildbucket for the build status
[02:12:48.003] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:48.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:132:0) after 1m0s
[02:13:48.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:132:0)
[02:13:48.072] Timer tick, asking Buildbucket for the build status
[02:13:49.609] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:49.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:133:0) after 1m0s
[02:14:49.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:133:0)
[02:14:49.601] Timer tick, asking Buildbucket for the build status
[02:14:49.695] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:49.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:134:0) after 1m0s
[02:15:49.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:134:0)
[02:15:49.780] Timer tick, asking Buildbucket for the build status
[02:15:49.917] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:49.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:135:0) after 1m0s
[02:16:49.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:135:0)
[02:16:49.990] Timer tick, asking Buildbucket for the build status
[02:16:50.138] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:50.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:136:0) after 1m0s
[02:17:50.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:136:0)
[02:17:50.176] Timer tick, asking Buildbucket for the build status
[02:17:50.497] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:50.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:137:0) after 1m0s
[02:18:50.537] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:137:0)
[02:18:50.537] Timer tick, asking Buildbucket for the build status
[02:18:50.646] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:50.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:138:0) after 1m0s
[02:19:50.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:138:0)
[02:19:50.639] Timer tick, asking Buildbucket for the build status
[02:19:50.699] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:50.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:139:0) after 1m0s
[02:20:50.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:139:0)
[02:20:50.847] Timer tick, asking Buildbucket for the build status
[02:20:50.921] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:50.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:140:0) after 1m0s
[02:21:50.952] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:140:0)
[02:21:50.952] Timer tick, asking Buildbucket for the build status
[02:21:51.053] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:51.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:141:0) after 1m0s
[02:22:51.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:141:0)
[02:22:51.083] Timer tick, asking Buildbucket for the build status
[02:22:51.331] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:51.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:142:0) after 1m0s
[02:23:51.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:142:0)
[02:23:51.356] Timer tick, asking Buildbucket for the build status
[02:23:51.624] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:51.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:143:0) after 1m0s
[02:24:51.688] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:143:0)
[02:24:51.688] Timer tick, asking Buildbucket for the build status
[02:24:51.761] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:51.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:144:0) after 1m0s
[02:25:51.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:144:0)
[02:25:51.800] Timer tick, asking Buildbucket for the build status
[02:25:52.073] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:52.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:145:0) after 1m0s
[02:26:52.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:145:0)
[02:26:52.143] Timer tick, asking Buildbucket for the build status
[02:26:52.255] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:52.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:146:0) after 1m0s
[02:27:52.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:146:0)
[02:27:52.398] Timer tick, asking Buildbucket for the build status
[02:27:52.520] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:52.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:147:0) after 1m0s
[02:28:52.999] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:147:0)
[02:28:52.999] Timer tick, asking Buildbucket for the build status
[02:28:54.897] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:54.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:148:0) after 1m0s
[02:29:54.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:148:0)
[02:29:54.946] Timer tick, asking Buildbucket for the build status
[02:29:55.155] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:55.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:149:0) after 1m0s
[02:30:55.153] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:149:0)
[02:30:55.153] Timer tick, asking Buildbucket for the build status
[02:30:55.645] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:55.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:150:0) after 1m0s
[02:31:55.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:150:0)
[02:31:55.672] Timer tick, asking Buildbucket for the build status
[02:31:55.731] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:55.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:151:0) after 1m0s
[02:32:55.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:151:0)
[02:32:55.794] Timer tick, asking Buildbucket for the build status
[02:32:55.871] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:55.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:152:0) after 1m0s
[02:33:55.902] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:152:0)
[02:33:55.902] Timer tick, asking Buildbucket for the build status
[02:33:56.058] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:56.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:153:0) after 1m0s
[02:34:56.146] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:153:0)
[02:34:56.146] Timer tick, asking Buildbucket for the build status
[02:34:56.294] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:56.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:154:0) after 1m0s
[02:35:56.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:154:0)
[02:35:56.355] Timer tick, asking Buildbucket for the build status
[02:35:56.549] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:56.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:155:0) after 1m0s
[02:36:56.824] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:155:0)
[02:36:56.824] Timer tick, asking Buildbucket for the build status
[02:36:56.908] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:56.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:156:0) after 1m0s
[02:37:57.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:156:0)
[02:37:57.109] Timer tick, asking Buildbucket for the build status
[02:37:57.223] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:57.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:157:0) after 1m0s
[02:38:57.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:157:0)
[02:38:57.293] Timer tick, asking Buildbucket for the build status
[02:38:57.521] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:57.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:158:0) after 1m0s
[02:39:57.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:158:0)
[02:39:57.873] Timer tick, asking Buildbucket for the build status
[02:39:57.981] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:57.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:159:0) after 1m0s
[02:40:58.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:159:0)
[02:40:58.049] Timer tick, asking Buildbucket for the build status
[02:40:58.151] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:58.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:160:0) after 1m0s
[02:41:58.288] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:160:0)
[02:41:58.288] Timer tick, asking Buildbucket for the build status
[02:41:58.439] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:58.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:161:0) after 1m0s
[02:42:58.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:161:0)
[02:42:58.571] Timer tick, asking Buildbucket for the build status
[02:42:58.680] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:58.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:162:0) after 1m0s
[02:43:58.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:162:0)
[02:43:58.712] Timer tick, asking Buildbucket for the build status
[02:43:59.371] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:59.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:163:0) after 1m0s
[02:44:59.432] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:163:0)
[02:44:59.432] Timer tick, asking Buildbucket for the build status
[02:44:59.811] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:59.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:164:0) after 1m0s
[02:45:59.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:164:0)
[02:45:59.847] Timer tick, asking Buildbucket for the build status
[02:46:00.110] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:00.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:165:0) after 1m0s
[02:47:00.166] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:165:0)
[02:47:00.166] Timer tick, asking Buildbucket for the build status
[02:47:00.347] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:00.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:166:0) after 1m0s
[02:48:00.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:166:0)
[02:48:00.400] Timer tick, asking Buildbucket for the build status
[02:48:00.704] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:00.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:167:0) after 1m0s
[02:49:00.768] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:167:0)
[02:49:00.768] Timer tick, asking Buildbucket for the build status
[02:49:00.913] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:00.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:168:0) after 1m0s
[02:50:01.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:168:0)
[02:50:01.002] Timer tick, asking Buildbucket for the build status
[02:50:01.133] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:01.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:169:0) after 1m0s
[02:51:01.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:169:0)
[02:51:01.629] Timer tick, asking Buildbucket for the build status
[02:51:01.695] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:01.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:170:0) after 1m0s
[02:52:01.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:170:0)
[02:52:01.721] Timer tick, asking Buildbucket for the build status
[02:52:01.793] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:01.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:171:0) after 1m0s
[02:53:02.040] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:171:0)
[02:53:02.040] Timer tick, asking Buildbucket for the build status
[02:53:02.275] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:02.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:172:0) after 1m0s
[02:54:02.284] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:172:0)
[02:54:02.284] Timer tick, asking Buildbucket for the build status
[02:54:02.434] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:02.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:173:0) after 1m0s
[02:55:02.491] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:173:0)
[02:55:02.491] Timer tick, asking Buildbucket for the build status
[02:55:02.594] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:02.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:174:0) after 1m0s
[02:56:02.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:174:0)
[02:56:02.691] Timer tick, asking Buildbucket for the build status
[02:56:02.822] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:02.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:175:0) after 1m0s
[02:57:02.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:175:0)
[02:57:02.887] Timer tick, asking Buildbucket for the build status
[02:57:03.303] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:03.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:176:0) after 1m0s
[02:58:03.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:176:0)
[02:58:03.331] Timer tick, asking Buildbucket for the build status
[02:58:03.476] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:03.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:177:0) after 1m0s
[02:59:03.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:177:0)
[02:59:03.504] Timer tick, asking Buildbucket for the build status
[02:59:03.716] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:03.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:178:0) after 1m0s
[03:00:04.613] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:178:0)
[03:00:04.613] Timer tick, asking Buildbucket for the build status
[03:00:04.856] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:04.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:179:0) after 1m0s
[03:01:04.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:179:0)
[03:01:04.929] Timer tick, asking Buildbucket for the build status
[03:01:05.159] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:05.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:180:0) after 1m0s
[03:02:05.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:180:0)
[03:02:05.157] Timer tick, asking Buildbucket for the build status
[03:02:05.824] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:05.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:181:0) after 1m0s
[03:03:05.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:181:0)
[03:03:05.882] Timer tick, asking Buildbucket for the build status
[03:03:06.036] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:06.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:182:0) after 1m0s
[03:04:06.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:182:0)
[03:04:06.081] Timer tick, asking Buildbucket for the build status
[03:04:06.465] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:06.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:183:0) after 1m0s
[03:05:06.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:183:0)
[03:05:06.497] Timer tick, asking Buildbucket for the build status
[03:05:06.645] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:06.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:184:0) after 1m0s
[03:06:06.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:184:0)
[03:06:06.665] Timer tick, asking Buildbucket for the build status
[03:06:06.805] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:06.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:185:0) after 1m0s
[03:07:06.864] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:185:0)
[03:07:06.864] Timer tick, asking Buildbucket for the build status
[03:07:07.013] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:07.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:186:0) after 1m0s
[03:08:07.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:186:0)
[03:08:07.096] Timer tick, asking Buildbucket for the build status
[03:08:07.484] Build 8870406070718515024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:07.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9035836134459726416:187:0) after 1m0s
[03:08:33.504] Received PubSub notification, asking Buildbucket for the build status
[03:08:33.658] Build 8870406070718515024: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:08:33.658] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1598929712531784",
    "created_by": "project:chromium",
    "created_ts": "1598918576469923",
    "id": "8870406070718515024",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4e25208b29420190e4c9aec56835551615141d3\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-2-3k06\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 475, \"got_angle_revision\": \"e1e6f2940c25b3899a13f9f76815ddbb2d00e245\", \"got_dawn_revision\": \"0b89b27263b127a46371641b299fdf0f2cd7caff\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"e4e25208b29420190e4c9aec56835551615141d3\", \"got_revision_cp\": \"refs/heads/master@{#803317}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"a2e6c1a149f4ee03f46e11afbb72cfa10e5526e3\", \"got_v8_revision\": \"4b3de99d978c746f47a9da42eb275d4ea3300b5a\", \"got_v8_revision_cp\": \"refs/heads/8.7.37@{#1}\", \"got_webrtc_revision\": \"81de439281e9dd65f09a8e3138576008b0b8b17b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32018}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4e25208b29420190e4c9aec56835551615141d3\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"git\", \"goma_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-2-3k06\"], \"image\": [\"chrome-win10-1703-20081700-d9392568d25\"], \"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\": [\"5506-8edbdd2\"], \"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": "1598918853339587",
    "status": "COMPLETED",
    "status_changed_ts": "1598929713209482",
    "tags": [
      "build_address:luci.chromium.ci/win-official/475",
      "builder:win-official",
      "buildset:commit/git/e4e25208b29420190e4c9aec56835551615141d3",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4e25208b29420190e4c9aec56835551615141d3",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9035836134459726416",
      "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/8870406070718515024/+/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:4e5fcad6b195d310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1598929713292271",
    "url": "https://ci.chromium.org/b/8870406070718515024",
    "utcnow_ts": "1598929713650358"
  }
}
[03:08:33.658] Invocation finished in 3h5m40.139788561s with status SUCCEEDED