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

• 431a245c23d26370df1cfe0aa06d881b7720d09c (5 years ago)
• f433462ab433af0fd0c222b810a6c5dc61a1275b (5 years ago)
• 0365ff9f51a6efbbf030b881f8a4ab2e933c8b3c (5 years ago)
• 1d85473993173a4812e50e7d71d796362d009005 (5 years ago)
• f0a217a20732752aa093f1859a8a59f01121620f (5 years ago)
• 565acfb0aab90186581971744c8651764ff5d4fb (5 years ago)
• 4a4d03fecc15d7e860331de5708481506a8b3cb4 (5 years ago)
• e9fe59463e3d72c72f22306738c412a175164826 (5 years ago)

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

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

[22:18:02.158] New invocation is queued and will start shortly
[22:18:03.505] Starting the invocation (attempt 1)
[22:18:03.538] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:18:03.538] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:18:03.538] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9023883931884331872",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e9fe59463e3d72c72f22306738c412a175164826\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9023883931884331872",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/e9fe59463e3d72c72f22306738c412a175164826",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9fe59463e3d72c72f22306738c412a175164826",
    "gitiles_ref:refs/heads/master"
  ]
}
[22:18:04.248] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1610317083623339",
    "id": "8858453869681384656",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e9fe59463e3d72c72f22306738c412a175164826\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1610317084071766",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1355",
      "builder:win-official",
      "buildset:commit/git/e9fe59463e3d72c72f22306738c412a175164826",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9fe59463e3d72c72f22306738c412a175164826",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9023883931884331872",
      "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/8858453869681384656/+/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": "1610317084071877",
    "url": "https://ci.chromium.org/b/8858453869681384656",
    "utcnow_ts": "1610317084234841"
  }
}
[22:18:04.248] Task URL: https://ci.chromium.org/b/8858453869681384656
[22:18:04.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:2:0) after 1m0s
[22:18:35.171] Received PubSub notification, asking Buildbucket for the build status
[22:18:35.406] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:04.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:2:0)
[22:19:04.304] Timer tick, asking Buildbucket for the build status
[22:19:04.398] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:04.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:4:0) after 1m0s
[22:20:04.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:4:0)
[22:20:04.373] Timer tick, asking Buildbucket for the build status
[22:20:04.462] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:04.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:5:0) after 1m0s
[22:21:04.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:5:0)
[22:21:04.503] Timer tick, asking Buildbucket for the build status
[22:21:04.565] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:04.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:6:0) after 1m0s
[22:22:04.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:6:0)
[22:22:04.697] Timer tick, asking Buildbucket for the build status
[22:22:04.785] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:04.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:7:0) after 1m0s
[22:23:04.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:7:0)
[22:23:04.803] Timer tick, asking Buildbucket for the build status
[22:23:05.260] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:05.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:8:0) after 1m0s
[22:24:05.489] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:8:0)
[22:24:05.489] Timer tick, asking Buildbucket for the build status
[22:24:05.789] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:05.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:9:0) after 1m0s
[22:25:05.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:9:0)
[22:25:05.821] Timer tick, asking Buildbucket for the build status
[22:25:05.898] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:05.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:10:0) after 1m0s
[22:26:05.969] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:10:0)
[22:26:05.969] Timer tick, asking Buildbucket for the build status
[22:26:06.057] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:06.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:11:0) after 1m0s
[22:27:06.119] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:11:0)
[22:27:06.119] Timer tick, asking Buildbucket for the build status
[22:27:06.260] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:06.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:12:0) after 1m0s
[22:28:06.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:12:0)
[22:28:06.282] Timer tick, asking Buildbucket for the build status
[22:28:06.399] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:06.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:13:0) after 1m0s
[22:29:06.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:13:0)
[22:29:06.504] Timer tick, asking Buildbucket for the build status
[22:29:06.611] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:06.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:14:0) after 1m0s
[22:30:06.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:14:0)
[22:30:06.641] Timer tick, asking Buildbucket for the build status
[22:30:06.815] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:06.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:15:0) after 1m0s
[22:31:06.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:15:0)
[22:31:06.851] Timer tick, asking Buildbucket for the build status
[22:31:06.950] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:06.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:16:0) after 1m0s
[22:32:06.977] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:16:0)
[22:32:06.977] Timer tick, asking Buildbucket for the build status
[22:32:07.092] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:07.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:17:0) after 1m0s
[22:33:07.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:17:0)
[22:33:07.114] Timer tick, asking Buildbucket for the build status
[22:33:07.249] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:07.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:18:0) after 1m0s
[22:34:07.302] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:18:0)
[22:34:07.302] Timer tick, asking Buildbucket for the build status
[22:34:07.829] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:07.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:19:0) after 1m0s
[22:35:07.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:19:0)
[22:35:07.851] Timer tick, asking Buildbucket for the build status
[22:35:07.913] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:07.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:20:0) after 1m0s
[22:36:07.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:20:0)
[22:36:07.934] Timer tick, asking Buildbucket for the build status
[22:36:08.007] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:08.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:21:0) after 1m0s
[22:37:08.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:21:0)
[22:37:08.011] Timer tick, asking Buildbucket for the build status
[22:37:08.208] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:08.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:22:0) after 1m0s
[22:38:08.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:22:0)
[22:38:08.360] Timer tick, asking Buildbucket for the build status
[22:38:08.613] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:08.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:23:0) after 1m0s
[22:39:08.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:23:0)
[22:39:08.633] Timer tick, asking Buildbucket for the build status
[22:39:08.804] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:08.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:24:0) after 1m0s
[22:40:08.875] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:24:0)
[22:40:08.875] Timer tick, asking Buildbucket for the build status
[22:40:09.084] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:09.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:25:0) after 1m0s
[22:41:09.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:25:0)
[22:41:09.148] Timer tick, asking Buildbucket for the build status
[22:41:09.203] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:09.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:26:0) after 1m0s
[22:42:09.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:26:0)
[22:42:09.198] Timer tick, asking Buildbucket for the build status
[22:42:09.302] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:09.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:27:0) after 1m0s
[22:43:09.399] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:27:0)
[22:43:09.399] Timer tick, asking Buildbucket for the build status
[22:43:09.915] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:09.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:28:0) after 1m0s
[22:44:09.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:28:0)
[22:44:09.939] Timer tick, asking Buildbucket for the build status
[22:44:10.182] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:10.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:29:0) after 1m0s
[22:45:10.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:29:0)
[22:45:10.301] Timer tick, asking Buildbucket for the build status
[22:45:10.381] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:10.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:30:0) after 1m0s
[22:46:11.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:30:0)
[22:46:11.734] Timer tick, asking Buildbucket for the build status
[22:46:11.930] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:11.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:31:0) after 1m0s
[22:47:12.214] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:31:0)
[22:47:12.214] Timer tick, asking Buildbucket for the build status
[22:47:12.268] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:12.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:32:0) after 1m0s
[22:48:12.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:32:0)
[22:48:12.392] Timer tick, asking Buildbucket for the build status
[22:48:12.556] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:12.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:33:0) after 1m0s
[22:49:12.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:33:0)
[22:49:12.681] Timer tick, asking Buildbucket for the build status
[22:49:12.791] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:12.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:34:0) after 1m0s
[22:50:12.918] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:34:0)
[22:50:12.918] Timer tick, asking Buildbucket for the build status
[22:50:13.157] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:13.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:35:0) after 1m0s
[22:51:13.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:35:0)
[22:51:13.180] Timer tick, asking Buildbucket for the build status
[22:51:13.266] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:13.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:36:0) after 1m0s
[22:52:13.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:36:0)
[22:52:13.322] Timer tick, asking Buildbucket for the build status
[22:52:13.514] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:13.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:37:0) after 1m0s
[22:53:13.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:37:0)
[22:53:13.511] Timer tick, asking Buildbucket for the build status
[22:53:13.610] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:13.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:38:0) after 1m0s
[22:54:13.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:38:0)
[22:54:13.645] Timer tick, asking Buildbucket for the build status
[22:54:13.703] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:13.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:39:0) after 1m0s
[22:55:13.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:39:0)
[22:55:13.788] Timer tick, asking Buildbucket for the build status
[22:55:13.862] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:13.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:40:0) after 1m0s
[22:56:13.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:40:0)
[22:56:13.912] Timer tick, asking Buildbucket for the build status
[22:56:13.969] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:13.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:41:0) after 1m0s
[22:57:13.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:41:0)
[22:57:13.985] Timer tick, asking Buildbucket for the build status
[22:57:14.057] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:14.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:42:0) after 1m0s
[22:58:14.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:42:0)
[22:58:14.076] Timer tick, asking Buildbucket for the build status
[22:58:14.619] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:14.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:43:0) after 1m0s
[22:59:14.644] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:43:0)
[22:59:14.644] Timer tick, asking Buildbucket for the build status
[22:59:14.835] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:14.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:44:0) after 1m0s
[23:00:14.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:44:0)
[23:00:14.879] Timer tick, asking Buildbucket for the build status
[23:00:15.157] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:15.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:45:0) after 1m0s
[23:01:15.214] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:45:0)
[23:01:15.214] Timer tick, asking Buildbucket for the build status
[23:01:15.692] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:15.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:46:0) after 1m0s
[23:02:16.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:46:0)
[23:02:16.063] Timer tick, asking Buildbucket for the build status
[23:02:16.141] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:16.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:47:0) after 1m0s
[23:03:16.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:47:0)
[23:03:16.183] Timer tick, asking Buildbucket for the build status
[23:03:16.269] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:16.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:48:0) after 1m0s
[23:04:16.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:48:0)
[23:04:16.377] Timer tick, asking Buildbucket for the build status
[23:04:16.430] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:16.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:49:0) after 1m0s
[23:05:16.451] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:49:0)
[23:05:16.451] Timer tick, asking Buildbucket for the build status
[23:05:16.545] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:16.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:50:0) after 1m0s
[23:06:16.566] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:50:0)
[23:06:16.566] Timer tick, asking Buildbucket for the build status
[23:06:16.631] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:16.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:51:0) after 1m0s
[23:07:16.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:51:0)
[23:07:16.620] Timer tick, asking Buildbucket for the build status
[23:07:16.675] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:16.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:52:0) after 1m0s
[23:08:16.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:52:0)
[23:08:16.695] Timer tick, asking Buildbucket for the build status
[23:08:16.815] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:16.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:53:0) after 1m0s
[23:09:16.833] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:53:0)
[23:09:16.833] Timer tick, asking Buildbucket for the build status
[23:09:16.896] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:16.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:54:0) after 1m0s
[23:10:16.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:54:0)
[23:10:16.917] Timer tick, asking Buildbucket for the build status
[23:10:16.981] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:16.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:55:0) after 1m0s
[23:11:17.016] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:55:0)
[23:11:17.016] Timer tick, asking Buildbucket for the build status
[23:11:17.170] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:17.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:56:0) after 1m0s
[23:12:17.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:56:0)
[23:12:17.187] Timer tick, asking Buildbucket for the build status
[23:12:17.269] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:17.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:57:0) after 1m0s
[23:13:17.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:57:0)
[23:13:17.319] Timer tick, asking Buildbucket for the build status
[23:13:17.435] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:17.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:58:0) after 1m0s
[23:14:17.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:58:0)
[23:14:17.474] Timer tick, asking Buildbucket for the build status
[23:14:17.539] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:17.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:59:0) after 1m0s
[23:15:17.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:59:0)
[23:15:17.541] Timer tick, asking Buildbucket for the build status
[23:15:17.698] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:17.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:60:0) after 1m0s
[23:16:17.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:60:0)
[23:16:17.675] Timer tick, asking Buildbucket for the build status
[23:16:17.741] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:17.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:61:0) after 1m0s
[23:17:17.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:61:0)
[23:17:17.760] Timer tick, asking Buildbucket for the build status
[23:17:17.828] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:17.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:62:0) after 1m0s
[23:18:17.846] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:62:0)
[23:18:17.846] Timer tick, asking Buildbucket for the build status
[23:18:18.029] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:18.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:63:0) after 1m0s
[23:19:18.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:63:0)
[23:19:18.084] Timer tick, asking Buildbucket for the build status
[23:19:18.154] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:18.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:64:0) after 1m0s
[23:20:18.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:64:0)
[23:20:18.208] Timer tick, asking Buildbucket for the build status
[23:20:18.340] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:18.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:65:0) after 1m0s
[23:21:18.358] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:65:0)
[23:21:18.358] Timer tick, asking Buildbucket for the build status
[23:21:18.415] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:18.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:66:0) after 1m0s
[23:22:18.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:66:0)
[23:22:18.439] Timer tick, asking Buildbucket for the build status
[23:22:18.528] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:18.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:67:0) after 1m0s
[23:23:18.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:67:0)
[23:23:18.554] Timer tick, asking Buildbucket for the build status
[23:23:18.641] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:18.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:68:0) after 1m0s
[23:24:18.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:68:0)
[23:24:18.739] Timer tick, asking Buildbucket for the build status
[23:24:18.800] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:18.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:69:0) after 1m0s
[23:25:18.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:69:0)
[23:25:18.901] Timer tick, asking Buildbucket for the build status
[23:25:19.261] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:19.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:70:0) after 1m0s
[23:26:19.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:70:0)
[23:26:19.233] Timer tick, asking Buildbucket for the build status
[23:26:19.396] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:19.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:71:0) after 1m0s
[23:27:19.449] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:71:0)
[23:27:19.449] Timer tick, asking Buildbucket for the build status
[23:27:19.502] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:19.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:72:0) after 1m0s
[23:28:19.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:72:0)
[23:28:19.492] Timer tick, asking Buildbucket for the build status
[23:28:19.638] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:19.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:73:0) after 1m0s
[23:29:19.659] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:73:0)
[23:29:19.659] Timer tick, asking Buildbucket for the build status
[23:29:19.768] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:19.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:74:0) after 1m0s
[23:30:19.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:74:0)
[23:30:19.828] Timer tick, asking Buildbucket for the build status
[23:30:19.905] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:19.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:75:0) after 1m0s
[23:31:19.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:75:0)
[23:31:19.899] Timer tick, asking Buildbucket for the build status
[23:31:19.956] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:19.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:76:0) after 1m0s
[23:32:19.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:76:0)
[23:32:19.939] Timer tick, asking Buildbucket for the build status
[23:32:20.188] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:20.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:77:0) after 1m0s
[23:33:20.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:77:0)
[23:33:20.255] Timer tick, asking Buildbucket for the build status
[23:33:20.383] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:20.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:78:0) after 1m0s
[23:34:20.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:78:0)
[23:34:20.430] Timer tick, asking Buildbucket for the build status
[23:34:20.499] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:20.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:79:0) after 1m0s
[23:35:20.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:79:0)
[23:35:20.571] Timer tick, asking Buildbucket for the build status
[23:35:20.813] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:20.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:80:0) after 1m0s
[23:36:20.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:80:0)
[23:36:20.866] Timer tick, asking Buildbucket for the build status
[23:36:20.928] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:20.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:81:0) after 1m0s
[23:37:20.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:81:0)
[23:37:20.949] Timer tick, asking Buildbucket for the build status
[23:37:21.008] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:21.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:82:0) after 1m0s
[23:38:21.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:82:0)
[23:38:21.029] Timer tick, asking Buildbucket for the build status
[23:38:21.163] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:21.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:83:0) after 1m0s
[23:39:21.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:83:0)
[23:39:21.185] Timer tick, asking Buildbucket for the build status
[23:39:21.279] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:21.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:84:0) after 1m0s
[23:40:21.303] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:84:0)
[23:40:21.303] Timer tick, asking Buildbucket for the build status
[23:40:21.588] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:21.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:85:0) after 1m0s
[23:41:21.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:85:0)
[23:41:21.608] Timer tick, asking Buildbucket for the build status
[23:41:22.130] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:22.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:86:0) after 1m0s
[23:42:22.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:86:0)
[23:42:22.150] Timer tick, asking Buildbucket for the build status
[23:42:22.481] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:22.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:87:0) after 1m0s
[23:43:22.555] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:87:0)
[23:43:22.555] Timer tick, asking Buildbucket for the build status
[23:43:22.714] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:22.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:88:0) after 1m0s
[23:44:22.755] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:88:0)
[23:44:22.755] Timer tick, asking Buildbucket for the build status
[23:44:23.102] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:23.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:89:0) after 1m0s
[23:45:23.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:89:0)
[23:45:23.109] Timer tick, asking Buildbucket for the build status
[23:45:23.176] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:23.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:90:0) after 1m0s
[23:46:23.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:90:0)
[23:46:23.202] Timer tick, asking Buildbucket for the build status
[23:46:23.348] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:23.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:91:0) after 1m0s
[23:47:23.448] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:91:0)
[23:47:23.448] Timer tick, asking Buildbucket for the build status
[23:47:23.789] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:23.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:92:0) after 1m0s
[23:48:23.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:92:0)
[23:48:23.919] Timer tick, asking Buildbucket for the build status
[23:48:24.007] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:24.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:93:0) after 1m0s
[23:49:24.030] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:93:0)
[23:49:24.030] Timer tick, asking Buildbucket for the build status
[23:49:24.194] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:24.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:94:0) after 1m0s
[23:50:24.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:94:0)
[23:50:24.256] Timer tick, asking Buildbucket for the build status
[23:50:24.306] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:24.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:95:0) after 1m0s
[23:51:24.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:95:0)
[23:51:24.313] Timer tick, asking Buildbucket for the build status
[23:51:24.373] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:24.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:96:0) after 1m0s
[23:52:24.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:96:0)
[23:52:24.393] Timer tick, asking Buildbucket for the build status
[23:52:24.509] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:24.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:97:0) after 1m0s
[23:53:24.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:97:0)
[23:53:24.531] Timer tick, asking Buildbucket for the build status
[23:53:24.653] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:24.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:98:0) after 1m0s
[23:54:24.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:98:0)
[23:54:24.699] Timer tick, asking Buildbucket for the build status
[23:54:24.800] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:24.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:99:0) after 1m0s
[23:55:24.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:99:0)
[23:55:24.855] Timer tick, asking Buildbucket for the build status
[23:55:25.000] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:25.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:100:0) after 1m0s
[23:56:25.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:100:0)
[23:56:25.021] Timer tick, asking Buildbucket for the build status
[23:56:25.200] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:25.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:101:0) after 1m0s
[23:57:25.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:101:0)
[23:57:25.225] Timer tick, asking Buildbucket for the build status
[23:57:25.487] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:25.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:102:0) after 1m0s
[23:58:25.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:102:0)
[23:58:25.596] Timer tick, asking Buildbucket for the build status
[23:58:25.712] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:25.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:103:0) after 1m0s
[23:59:25.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:103:0)
[23:59:25.734] Timer tick, asking Buildbucket for the build status
[23:59:25.794] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:25.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:104:0) after 1m0s
[00:00:25.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:104:0)
[00:00:25.821] Timer tick, asking Buildbucket for the build status
[00:00:26.092] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:26.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:105:0) after 1m0s
[00:01:26.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:105:0)
[00:01:26.125] Timer tick, asking Buildbucket for the build status
[00:01:26.192] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:26.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:106:0) after 1m0s
[00:02:26.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:106:0)
[00:02:26.274] Timer tick, asking Buildbucket for the build status
[00:02:26.335] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:26.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:107:0) after 1m0s
[00:03:26.399] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:107:0)
[00:03:26.399] Timer tick, asking Buildbucket for the build status
[00:03:26.530] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:26.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:108:0) after 1m0s
[00:04:26.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:108:0)
[00:04:26.579] Timer tick, asking Buildbucket for the build status
[00:04:26.649] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:26.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:109:0) after 1m0s
[00:05:26.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:109:0)
[00:05:26.679] Timer tick, asking Buildbucket for the build status
[00:05:26.746] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:26.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:110:0) after 1m0s
[00:06:26.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:110:0)
[00:06:26.771] Timer tick, asking Buildbucket for the build status
[00:06:26.855] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:26.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:111:0) after 1m0s
[00:07:26.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:111:0)
[00:07:26.899] Timer tick, asking Buildbucket for the build status
[00:07:26.954] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:26.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:112:0) after 1m0s
[00:08:27.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:112:0)
[00:08:27.064] Timer tick, asking Buildbucket for the build status
[00:08:27.388] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:27.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:113:0) after 1m0s
[00:09:27.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:113:0)
[00:09:27.416] Timer tick, asking Buildbucket for the build status
[00:09:27.539] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:27.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:114:0) after 1m0s
[00:10:27.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:114:0)
[00:10:27.569] Timer tick, asking Buildbucket for the build status
[00:10:27.645] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:27.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:115:0) after 1m0s
[00:11:27.727] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:115:0)
[00:11:27.727] Timer tick, asking Buildbucket for the build status
[00:11:27.881] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:27.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:116:0) after 1m0s
[00:12:27.923] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:116:0)
[00:12:27.923] Timer tick, asking Buildbucket for the build status
[00:12:27.977] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:27.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:117:0) after 1m0s
[00:13:28.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:117:0)
[00:13:28.017] Timer tick, asking Buildbucket for the build status
[00:13:28.118] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:28.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:118:0) after 1m0s
[00:14:28.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:118:0)
[00:14:28.137] Timer tick, asking Buildbucket for the build status
[00:14:28.189] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:28.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:119:0) after 1m0s
[00:15:28.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:119:0)
[00:15:28.230] Timer tick, asking Buildbucket for the build status
[00:15:28.306] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:28.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:120:0) after 1m0s
[00:16:28.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:120:0)
[00:16:28.361] Timer tick, asking Buildbucket for the build status
[00:16:28.426] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:28.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:121:0) after 1m0s
[00:17:28.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:121:0)
[00:17:28.466] Timer tick, asking Buildbucket for the build status
[00:17:28.555] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:28.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:122:0) after 1m0s
[00:18:28.625] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:122:0)
[00:18:28.625] Timer tick, asking Buildbucket for the build status
[00:18:29.471] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:29.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:123:0) after 1m0s
[00:19:29.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:123:0)
[00:19:29.513] Timer tick, asking Buildbucket for the build status
[00:19:29.575] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:29.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:124:0) after 1m0s
[00:20:29.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:124:0)
[00:20:29.609] Timer tick, asking Buildbucket for the build status
[00:20:29.947] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:29.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:125:0) after 1m0s
[00:21:30.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:125:0)
[00:21:30.072] Timer tick, asking Buildbucket for the build status
[00:21:30.152] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:30.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:126:0) after 1m0s
[00:22:30.199] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:126:0)
[00:22:30.199] Timer tick, asking Buildbucket for the build status
[00:22:30.287] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:30.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:127:0) after 1m0s
[00:23:30.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:127:0)
[00:23:30.410] Timer tick, asking Buildbucket for the build status
[00:23:30.595] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:30.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:128:0) after 1m0s
[00:24:30.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:128:0)
[00:24:30.619] Timer tick, asking Buildbucket for the build status
[00:24:30.691] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:30.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:129:0) after 1m0s
[00:25:30.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:129:0)
[00:25:30.667] Timer tick, asking Buildbucket for the build status
[00:25:30.817] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:30.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:130:0) after 1m0s
[00:26:30.841] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:130:0)
[00:26:30.841] Timer tick, asking Buildbucket for the build status
[00:26:30.910] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:30.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:131:0) after 1m0s
[00:27:30.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:131:0)
[00:27:30.935] Timer tick, asking Buildbucket for the build status
[00:27:31.002] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:31.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:132:0) after 1m0s
[00:28:31.026] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:132:0)
[00:28:31.026] Timer tick, asking Buildbucket for the build status
[00:28:31.189] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:31.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:133:0) after 1m0s
[00:29:31.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:133:0)
[00:29:31.233] Timer tick, asking Buildbucket for the build status
[00:29:31.422] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:31.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:134:0) after 1m0s
[00:30:31.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:134:0)
[00:30:31.483] Timer tick, asking Buildbucket for the build status
[00:30:31.693] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:31.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:135:0) after 1m0s
[00:31:31.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:135:0)
[00:31:31.719] Timer tick, asking Buildbucket for the build status
[00:31:31.935] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:31.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:136:0) after 1m0s
[00:32:31.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:136:0)
[00:32:31.960] Timer tick, asking Buildbucket for the build status
[00:32:32.017] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:32.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:137:0) after 1m0s
[00:33:32.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:137:0)
[00:33:32.042] Timer tick, asking Buildbucket for the build status
[00:33:32.159] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:32.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:138:0) after 1m0s
[00:34:32.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:138:0)
[00:34:32.190] Timer tick, asking Buildbucket for the build status
[00:34:32.497] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:32.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:139:0) after 1m0s
[00:35:32.521] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:139:0)
[00:35:32.521] Timer tick, asking Buildbucket for the build status
[00:35:32.725] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:32.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:140:0) after 1m0s
[00:36:32.713] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:140:0)
[00:36:32.713] Timer tick, asking Buildbucket for the build status
[00:36:32.773] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:32.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:141:0) after 1m0s
[00:37:32.796] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:141:0)
[00:37:32.796] Timer tick, asking Buildbucket for the build status
[00:37:32.876] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:32.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:142:0) after 1m0s
[00:38:32.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:142:0)
[00:38:32.899] Timer tick, asking Buildbucket for the build status
[00:38:33.014] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:33.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:143:0) after 1m0s
[00:39:33.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:143:0)
[00:39:33.038] Timer tick, asking Buildbucket for the build status
[00:39:33.302] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:33.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:144:0) after 1m0s
[00:40:33.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:144:0)
[00:40:33.328] Timer tick, asking Buildbucket for the build status
[00:40:33.404] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:33.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:145:0) after 1m0s
[00:41:33.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:145:0)
[00:41:33.431] Timer tick, asking Buildbucket for the build status
[00:41:33.489] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:33.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:146:0) after 1m0s
[00:42:33.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:146:0)
[00:42:33.510] Timer tick, asking Buildbucket for the build status
[00:42:33.586] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:33.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:147:0) after 1m0s
[00:43:33.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:147:0)
[00:43:33.662] Timer tick, asking Buildbucket for the build status
[00:43:33.807] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:33.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:148:0) after 1m0s
[00:44:33.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:148:0)
[00:44:33.831] Timer tick, asking Buildbucket for the build status
[00:44:33.920] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:33.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:149:0) after 1m0s
[00:45:33.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:149:0)
[00:45:33.947] Timer tick, asking Buildbucket for the build status
[00:45:34.031] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:34.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:150:0) after 1m0s
[00:46:34.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:150:0)
[00:46:34.079] Timer tick, asking Buildbucket for the build status
[00:46:34.162] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:34.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:151:0) after 1m0s
[00:47:34.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:151:0)
[00:47:34.212] Timer tick, asking Buildbucket for the build status
[00:47:34.284] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:34.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:152:0) after 1m0s
[00:48:34.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:152:0)
[00:48:34.388] Timer tick, asking Buildbucket for the build status
[00:48:34.534] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:34.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:153:0) after 1m0s
[00:49:34.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:153:0)
[00:49:34.603] Timer tick, asking Buildbucket for the build status
[00:49:34.670] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:34.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:154:0) after 1m0s
[00:50:34.751] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:154:0)
[00:50:34.751] Timer tick, asking Buildbucket for the build status
[00:50:34.815] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:34.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:155:0) after 1m0s
[00:51:34.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:155:0)
[00:51:34.921] Timer tick, asking Buildbucket for the build status
[00:51:35.146] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:35.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:156:0) after 1m0s
[00:52:35.228] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:156:0)
[00:52:35.228] Timer tick, asking Buildbucket for the build status
[00:52:35.642] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:35.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:157:0) after 1m0s
[00:53:35.754] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:157:0)
[00:53:35.754] Timer tick, asking Buildbucket for the build status
[00:53:36.038] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:36.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:158:0) after 1m0s
[00:54:36.067] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:158:0)
[00:54:36.067] Timer tick, asking Buildbucket for the build status
[00:54:36.127] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:36.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:159:0) after 1m0s
[00:55:39.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:159:0)
[00:55:39.822] Timer tick, asking Buildbucket for the build status
[00:55:39.877] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:39.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:160:0) after 1m0s
[00:56:39.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:160:0)
[00:56:39.936] Timer tick, asking Buildbucket for the build status
[00:56:40.003] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:40.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:161:0) after 1m0s
[00:57:40.087] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:161:0)
[00:57:40.087] Timer tick, asking Buildbucket for the build status
[00:57:40.146] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:40.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:162:0) after 1m0s
[00:58:40.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:162:0)
[00:58:40.188] Timer tick, asking Buildbucket for the build status
[00:58:40.613] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:40.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:163:0) after 1m0s
[00:59:40.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:163:0)
[00:59:40.654] Timer tick, asking Buildbucket for the build status
[00:59:40.820] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:40.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:164:0) after 1m0s
[01:00:40.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:164:0)
[01:00:40.885] Timer tick, asking Buildbucket for the build status
[01:00:40.948] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:40.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:165:0) after 1m0s
[01:01:40.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:165:0)
[01:01:40.995] Timer tick, asking Buildbucket for the build status
[01:01:41.242] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:41.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:166:0) after 1m0s
[01:02:41.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:166:0)
[01:02:41.392] Timer tick, asking Buildbucket for the build status
[01:02:41.466] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:41.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:167:0) after 1m0s
[01:03:41.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:167:0)
[01:03:41.511] Timer tick, asking Buildbucket for the build status
[01:03:41.651] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:41.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:168:0) after 1m0s
[01:04:41.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:168:0)
[01:04:41.674] Timer tick, asking Buildbucket for the build status
[01:04:41.985] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:41.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:169:0) after 1m0s
[01:05:42.014] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:169:0)
[01:05:42.014] Timer tick, asking Buildbucket for the build status
[01:05:42.523] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:42.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:170:0) after 1m0s
[01:06:42.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:170:0)
[01:06:42.567] Timer tick, asking Buildbucket for the build status
[01:06:42.623] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:42.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:171:0) after 1m0s
[01:07:42.688] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:171:0)
[01:07:42.688] Timer tick, asking Buildbucket for the build status
[01:07:42.768] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:42.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:172:0) after 1m0s
[01:08:42.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:172:0)
[01:08:42.856] Timer tick, asking Buildbucket for the build status
[01:08:42.977] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:42.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:173:0) after 1m0s
[01:09:43.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:173:0)
[01:09:43.032] Timer tick, asking Buildbucket for the build status
[01:09:43.312] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:43.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:174:0) after 1m0s
[01:10:43.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:174:0)
[01:10:43.345] Timer tick, asking Buildbucket for the build status
[01:10:43.594] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:43.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:175:0) after 1m0s
[01:11:43.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:175:0)
[01:11:43.739] Timer tick, asking Buildbucket for the build status
[01:11:43.804] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:43.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:176:0) after 1m0s
[01:12:43.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:176:0)
[01:12:43.799] Timer tick, asking Buildbucket for the build status
[01:12:43.866] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:43.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:177:0) after 1m0s
[01:13:43.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:177:0)
[01:13:43.933] Timer tick, asking Buildbucket for the build status
[01:13:44.102] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:44.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:178:0) after 1m0s
[01:14:44.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:178:0)
[01:14:44.173] Timer tick, asking Buildbucket for the build status
[01:14:44.247] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:44.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:179:0) after 1m0s
[01:15:44.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:179:0)
[01:15:44.279] Timer tick, asking Buildbucket for the build status
[01:15:44.386] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:44.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:180:0) after 1m0s
[01:16:44.421] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:180:0)
[01:16:44.421] Timer tick, asking Buildbucket for the build status
[01:16:44.556] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:44.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:181:0) after 1m0s
[01:17:44.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:181:0)
[01:17:44.602] Timer tick, asking Buildbucket for the build status
[01:17:44.684] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:44.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:182:0) after 1m0s
[01:18:44.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:182:0)
[01:18:44.686] Timer tick, asking Buildbucket for the build status
[01:18:44.863] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:44.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:183:0) after 1m0s
[01:19:44.937] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:183:0)
[01:19:44.937] Timer tick, asking Buildbucket for the build status
[01:19:45.022] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:45.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:184:0) after 1m0s
[01:20:45.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:184:0)
[01:20:45.082] Timer tick, asking Buildbucket for the build status
[01:20:45.229] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:45.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:185:0) after 1m0s
[01:21:45.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:185:0)
[01:21:45.237] Timer tick, asking Buildbucket for the build status
[01:21:45.347] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:45.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:186:0) after 1m0s
[01:22:45.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:186:0)
[01:22:45.391] Timer tick, asking Buildbucket for the build status
[01:22:45.449] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:45.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:187:0) after 1m0s
[01:23:45.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:187:0)
[01:23:45.517] Timer tick, asking Buildbucket for the build status
[01:23:46.145] Build 8858453869681384656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:46.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023883931884331872:188:0) after 1m0s
[01:24:15.374] Received PubSub notification, asking Buildbucket for the build status
[01:24:15.596] Build 8858453869681384656: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:24:15.596] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1610328254538724",
    "created_by": "project:chromium",
    "created_ts": "1610317083623339",
    "id": "8858453869681384656",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e9fe59463e3d72c72f22306738c412a175164826\"}}",
    "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\": \"e9fe59463e3d72c72f22306738c412a175164826\", \"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-4-yywi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1355, \"got_angle_revision\": \"0b90eef09f607336330f318bc8e65fa981634160\", \"got_dawn_revision\": \"3a0405597374c9ae12fb93e33aac35826455a958\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"e9fe59463e3d72c72f22306738c412a175164826\", \"got_revision_cp\": \"refs/heads/master@{#841903}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"348ba200aa29d5b3a36d696d48d8f619e055219f\", \"got_v8_revision\": \"5d60a181de0863d8d00ae42ec0ee3521f51b501a\", \"got_v8_revision_cp\": \"refs/heads/8.9.229@{#1}\", \"got_webrtc_revision\": \"42082f9045e74e65b9e3a66b51093e0dc2f9375a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32929}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e9fe59463e3d72c72f22306738c412a175164826\"}, \"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-4-yywi\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5657-0417a3f\"], \"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": "1610317114601453",
    "status": "COMPLETED",
    "status_changed_ts": "1610328255050456",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1355",
      "builder:win-official",
      "buildset:commit/git/e9fe59463e3d72c72f22306738c412a175164826",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e9fe59463e3d72c72f22306738c412a175164826",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9023883931884331872",
      "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/8858453869681384656/+/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:5107323f79b2fb10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1610328255058377",
    "url": "https://ci.chromium.org/b/8858453869681384656",
    "utcnow_ts": "1610328255587919"
  }
}
[01:24:15.596] Invocation finished in 3h6m13.458840486s with status SUCCEEDED