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

Definition (rev 835dd06986af6863f902c628becb4df908d0fc20)

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

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[20:40:24.810] New invocation is queued and will start shortly
[20:40:25.954] Starting the invocation (attempt 1)
[20:40:26.045] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:40:26.045] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:40:26.047] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9018997837569781920",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"54eebbdc802d943b3ad9bfe73ab364ceb5b6d203\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9018997837569781920",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/54eebbdc802d943b3ad9bfe73ab364ceb5b6d203",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/54eebbdc802d943b3ad9bfe73ab364ceb5b6d203",
    "gitiles_ref:refs/heads/master"
  ]
}
[20:40:26.853] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1614976826301109",
    "id": "8853567775342564512",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"54eebbdc802d943b3ad9bfe73ab364ceb5b6d203\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1614976826723071",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1696",
      "builder:win-official",
      "buildset:commit/git/54eebbdc802d943b3ad9bfe73ab364ceb5b6d203",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/54eebbdc802d943b3ad9bfe73ab364ceb5b6d203",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9018997837569781920",
      "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/8853567775342564512/+/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": "1614976826723172",
    "url": "https://ci.chromium.org/b/8853567775342564512",
    "utcnow_ts": "1614976826841359"
  }
}
[20:40:26.853] Task URL: https://ci.chromium.org/b/8853567775342564512
[20:40:26.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:2:0) after 1m0s
[20:41:26.858] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:2:0)
[20:41:26.858] Timer tick, asking Buildbucket for the build status
[20:41:26.979] Build 8853567775342564512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:26.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:3:0) after 1m0s
[20:42:27.041] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:3:0)
[20:42:27.041] Timer tick, asking Buildbucket for the build status
[20:42:27.134] Build 8853567775342564512: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:27.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:4:0) after 1m0s
[20:42:39.461] Received PubSub notification, asking Buildbucket for the build status
[20:42:39.763] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:27.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:4:0)
[20:43:27.194] Timer tick, asking Buildbucket for the build status
[20:43:27.324] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:27.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:6:0) after 1m0s
[20:44:28.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:6:0)
[20:44:28.281] Timer tick, asking Buildbucket for the build status
[20:44:28.450] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:28.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:7:0) after 1m0s
[20:45:28.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:7:0)
[20:45:28.752] Timer tick, asking Buildbucket for the build status
[20:45:28.848] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:28.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:8:0) after 1m0s
[20:46:29.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:8:0)
[20:46:29.202] Timer tick, asking Buildbucket for the build status
[20:46:29.355] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:29.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:9:0) after 1m0s
[20:47:29.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:9:0)
[20:47:29.780] Timer tick, asking Buildbucket for the build status
[20:47:29.968] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:29.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:10:0) after 1m0s
[20:48:30.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:10:0)
[20:48:30.114] Timer tick, asking Buildbucket for the build status
[20:48:30.189] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:30.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:11:0) after 1m0s
[20:49:30.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:11:0)
[20:49:30.598] Timer tick, asking Buildbucket for the build status
[20:49:32.189] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:32.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:12:0) after 1m0s
[20:50:32.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:12:0)
[20:50:32.246] Timer tick, asking Buildbucket for the build status
[20:50:32.313] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:32.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:13:0) after 1m0s
[20:51:32.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:13:0)
[20:51:32.410] Timer tick, asking Buildbucket for the build status
[20:51:32.494] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:32.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:14:0) after 1m0s
[20:52:32.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:14:0)
[20:52:32.499] Timer tick, asking Buildbucket for the build status
[20:52:32.602] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:32.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:15:0) after 1m0s
[20:53:32.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:15:0)
[20:53:32.947] Timer tick, asking Buildbucket for the build status
[20:53:33.047] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:33.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:16:0) after 1m0s
[20:54:33.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:16:0)
[20:54:33.587] Timer tick, asking Buildbucket for the build status
[20:54:33.927] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:33.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:17:0) after 1m0s
[20:55:33.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:17:0)
[20:55:33.957] Timer tick, asking Buildbucket for the build status
[20:55:34.063] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:34.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:18:0) after 1m0s
[20:56:34.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:18:0)
[20:56:34.107] Timer tick, asking Buildbucket for the build status
[20:56:34.193] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:34.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:19:0) after 1m0s
[20:57:34.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:19:0)
[20:57:34.350] Timer tick, asking Buildbucket for the build status
[20:57:34.412] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:34.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:20:0) after 1m0s
[20:58:34.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:20:0)
[20:58:34.619] Timer tick, asking Buildbucket for the build status
[20:58:34.695] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:34.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:21:0) after 1m0s
[20:59:34.845] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:21:0)
[20:59:34.845] Timer tick, asking Buildbucket for the build status
[20:59:34.927] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:34.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:22:0) after 1m0s
[21:00:34.975] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:22:0)
[21:00:34.975] Timer tick, asking Buildbucket for the build status
[21:00:35.364] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:35.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:23:0) after 1m0s
[21:01:35.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:23:0)
[21:01:35.414] Timer tick, asking Buildbucket for the build status
[21:01:35.518] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:35.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:24:0) after 1m0s
[21:02:35.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:24:0)
[21:02:35.542] Timer tick, asking Buildbucket for the build status
[21:02:35.826] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:35.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:25:0) after 1m0s
[21:03:35.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:25:0)
[21:03:35.873] Timer tick, asking Buildbucket for the build status
[21:03:35.954] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:35.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:26:0) after 1m0s
[21:04:36.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:26:0)
[21:04:36.518] Timer tick, asking Buildbucket for the build status
[21:04:36.592] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:36.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:27:0) after 1m0s
[21:05:36.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:27:0)
[21:05:36.802] Timer tick, asking Buildbucket for the build status
[21:05:37.000] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:37.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:28:0) after 1m0s
[21:06:37.103] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:28:0)
[21:06:37.103] Timer tick, asking Buildbucket for the build status
[21:06:37.222] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:37.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:29:0) after 1m0s
[21:07:37.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:29:0)
[21:07:37.373] Timer tick, asking Buildbucket for the build status
[21:07:37.453] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:37.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:30:0) after 1m0s
[21:08:37.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:30:0)
[21:08:37.584] Timer tick, asking Buildbucket for the build status
[21:08:37.699] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:37.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:31:0) after 1m0s
[21:09:37.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:31:0)
[21:09:37.815] Timer tick, asking Buildbucket for the build status
[21:09:37.928] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:37.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:32:0) after 1m0s
[21:10:38.015] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:32:0)
[21:10:38.015] Timer tick, asking Buildbucket for the build status
[21:10:38.199] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:38.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:33:0) after 1m0s
[21:11:38.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:33:0)
[21:11:38.301] Timer tick, asking Buildbucket for the build status
[21:11:38.380] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:38.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:34:0) after 1m0s
[21:12:38.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:34:0)
[21:12:38.481] Timer tick, asking Buildbucket for the build status
[21:12:38.654] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:38.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:35:0) after 1m0s
[21:13:38.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:35:0)
[21:13:38.855] Timer tick, asking Buildbucket for the build status
[21:13:38.950] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:38.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:36:0) after 1m0s
[21:14:39.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:36:0)
[21:14:39.109] Timer tick, asking Buildbucket for the build status
[21:14:39.205] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:39.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:37:0) after 1m0s
[21:15:40.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:37:0)
[21:15:40.098] Timer tick, asking Buildbucket for the build status
[21:15:40.179] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:40.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:38:0) after 1m0s
[21:16:40.368] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:38:0)
[21:16:40.368] Timer tick, asking Buildbucket for the build status
[21:16:40.442] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:40.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:39:0) after 1m0s
[21:17:40.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:39:0)
[21:17:40.571] Timer tick, asking Buildbucket for the build status
[21:17:40.835] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:40.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:40:0) after 1m0s
[21:18:40.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:40:0)
[21:18:40.924] Timer tick, asking Buildbucket for the build status
[21:18:41.038] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:41.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:41:0) after 1m0s
[21:19:41.031] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:41:0)
[21:19:41.031] Timer tick, asking Buildbucket for the build status
[21:19:41.136] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:41.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:42:0) after 1m0s
[21:20:41.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:42:0)
[21:20:41.151] Timer tick, asking Buildbucket for the build status
[21:20:41.276] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:41.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:43:0) after 1m0s
[21:21:41.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:43:0)
[21:21:41.304] Timer tick, asking Buildbucket for the build status
[21:21:41.395] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:41.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:44:0) after 1m0s
[21:22:41.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:44:0)
[21:22:41.466] Timer tick, asking Buildbucket for the build status
[21:22:41.569] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:41.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:45:0) after 1m0s
[21:23:41.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:45:0)
[21:23:41.721] Timer tick, asking Buildbucket for the build status
[21:23:42.056] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:42.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:46:0) after 1m0s
[21:24:42.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:46:0)
[21:24:42.188] Timer tick, asking Buildbucket for the build status
[21:24:42.279] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:42.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:47:0) after 1m0s
[21:25:42.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:47:0)
[21:25:42.633] Timer tick, asking Buildbucket for the build status
[21:25:43.971] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:43.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:48:0) after 1m0s
[21:26:44.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:48:0)
[21:26:44.071] Timer tick, asking Buildbucket for the build status
[21:26:45.701] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:45.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:49:0) after 1m0s
[21:27:45.770] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:49:0)
[21:27:45.770] Timer tick, asking Buildbucket for the build status
[21:27:45.826] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:45.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:50:0) after 1m0s
[21:28:45.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:50:0)
[21:28:45.867] Timer tick, asking Buildbucket for the build status
[21:28:45.927] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:45.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:51:0) after 1m0s
[21:29:45.930] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:51:0)
[21:29:45.930] Timer tick, asking Buildbucket for the build status
[21:29:46.014] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:46.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:52:0) after 1m0s
[21:30:46.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:52:0)
[21:30:46.063] Timer tick, asking Buildbucket for the build status
[21:30:46.173] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:46.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:53:0) after 1m0s
[21:31:46.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:53:0)
[21:31:46.252] Timer tick, asking Buildbucket for the build status
[21:31:46.353] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:46.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:54:0) after 1m0s
[21:32:46.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:54:0)
[21:32:46.765] Timer tick, asking Buildbucket for the build status
[21:32:46.873] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:46.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:55:0) after 1m0s
[21:33:47.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:55:0)
[21:33:47.121] Timer tick, asking Buildbucket for the build status
[21:33:50.185] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:50.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:56:0) after 1m0s
[21:34:50.213] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:56:0)
[21:34:50.213] Timer tick, asking Buildbucket for the build status
[21:34:51.077] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:51.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:57:0) after 1m0s
[21:35:51.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:57:0)
[21:35:51.350] Timer tick, asking Buildbucket for the build status
[21:35:51.454] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:51.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:58:0) after 1m0s
[21:36:51.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:58:0)
[21:36:51.587] Timer tick, asking Buildbucket for the build status
[21:36:51.657] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:51.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:59:0) after 1m0s
[21:37:51.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:59:0)
[21:37:51.722] Timer tick, asking Buildbucket for the build status
[21:37:51.795] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:51.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:60:0) after 1m0s
[21:38:51.854] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:60:0)
[21:38:51.854] Timer tick, asking Buildbucket for the build status
[21:38:51.927] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:51.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:61:0) after 1m0s
[21:39:52.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:61:0)
[21:39:52.412] Timer tick, asking Buildbucket for the build status
[21:39:52.493] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:52.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:62:0) after 1m0s
[21:40:52.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:62:0)
[21:40:52.704] Timer tick, asking Buildbucket for the build status
[21:40:52.833] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:52.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:63:0) after 1m0s
[21:41:52.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:63:0)
[21:41:52.876] Timer tick, asking Buildbucket for the build status
[21:41:52.963] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:52.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:64:0) after 1m0s
[21:42:53.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:64:0)
[21:42:53.032] Timer tick, asking Buildbucket for the build status
[21:42:53.110] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:53.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:65:0) after 1m0s
[21:43:53.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:65:0)
[21:43:53.161] Timer tick, asking Buildbucket for the build status
[21:43:53.255] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:53.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:66:0) after 1m0s
[21:44:54.000] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:66:0)
[21:44:54.000] Timer tick, asking Buildbucket for the build status
[21:44:54.078] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:54.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:67:0) after 1m0s
[21:45:54.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:67:0)
[21:45:54.716] Timer tick, asking Buildbucket for the build status
[21:45:55.134] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:55.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:68:0) after 1m0s
[21:46:55.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:68:0)
[21:46:55.261] Timer tick, asking Buildbucket for the build status
[21:46:55.346] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:55.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:69:0) after 1m0s
[21:47:55.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:69:0)
[21:47:55.633] Timer tick, asking Buildbucket for the build status
[21:47:55.924] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:55.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:70:0) after 1m0s
[21:48:56.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:70:0)
[21:48:56.121] Timer tick, asking Buildbucket for the build status
[21:48:56.211] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:56.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:71:0) after 1m0s
[21:49:57.222] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:71:0)
[21:49:57.222] Timer tick, asking Buildbucket for the build status
[21:49:57.281] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:57.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:72:0) after 1m0s
[21:50:57.872] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:72:0)
[21:50:57.872] Timer tick, asking Buildbucket for the build status
[21:50:57.977] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:57.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:73:0) after 1m0s
[21:51:58.060] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:73:0)
[21:51:58.060] Timer tick, asking Buildbucket for the build status
[21:51:58.313] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:58.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:74:0) after 1m0s
[21:52:58.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:74:0)
[21:52:58.443] Timer tick, asking Buildbucket for the build status
[21:52:58.517] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:58.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:75:0) after 1m0s
[21:53:58.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:75:0)
[21:53:58.571] Timer tick, asking Buildbucket for the build status
[21:53:58.936] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:58.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:76:0) after 1m0s
[21:54:59.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:76:0)
[21:54:59.055] Timer tick, asking Buildbucket for the build status
[21:54:59.179] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:59.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:77:0) after 1m0s
[21:55:59.249] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:77:0)
[21:55:59.249] Timer tick, asking Buildbucket for the build status
[21:55:59.355] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:59.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:78:0) after 1m0s
[21:56:59.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:78:0)
[21:56:59.419] Timer tick, asking Buildbucket for the build status
[21:56:59.483] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:59.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:79:0) after 1m0s
[21:57:59.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:79:0)
[21:57:59.515] Timer tick, asking Buildbucket for the build status
[21:57:59.598] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:59.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:80:0) after 1m0s
[21:58:59.727] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:80:0)
[21:58:59.727] Timer tick, asking Buildbucket for the build status
[21:59:00.483] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:00.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:81:0) after 1m0s
[22:00:01.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:81:0)
[22:00:01.017] Timer tick, asking Buildbucket for the build status
[22:00:01.144] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:01.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:82:0) after 1m0s
[22:01:01.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:82:0)
[22:01:01.320] Timer tick, asking Buildbucket for the build status
[22:01:01.444] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:01.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:83:0) after 1m0s
[22:02:01.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:83:0)
[22:02:01.524] Timer tick, asking Buildbucket for the build status
[22:02:01.605] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:01.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:84:0) after 1m0s
[22:03:01.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:84:0)
[22:03:01.946] Timer tick, asking Buildbucket for the build status
[22:03:02.975] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:02.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:85:0) after 1m0s
[22:04:03.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:85:0)
[22:04:03.024] Timer tick, asking Buildbucket for the build status
[22:04:03.118] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:03.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:86:0) after 1m0s
[22:05:03.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:86:0)
[22:05:03.234] Timer tick, asking Buildbucket for the build status
[22:05:03.338] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:03.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:87:0) after 1m0s
[22:06:03.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:87:0)
[22:06:03.334] Timer tick, asking Buildbucket for the build status
[22:06:03.439] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:03.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:88:0) after 1m0s
[22:07:03.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:88:0)
[22:07:03.517] Timer tick, asking Buildbucket for the build status
[22:07:03.921] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:03.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:89:0) after 1m0s
[22:08:04.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:89:0)
[22:08:04.068] Timer tick, asking Buildbucket for the build status
[22:08:04.172] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:04.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:90:0) after 1m0s
[22:09:04.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:90:0)
[22:09:04.251] Timer tick, asking Buildbucket for the build status
[22:09:04.461] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:04.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:91:0) after 1m0s
[22:10:04.460] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:91:0)
[22:10:04.460] Timer tick, asking Buildbucket for the build status
[22:10:07.944] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:07.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:92:0) after 1m0s
[22:11:08.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:92:0)
[22:11:08.042] Timer tick, asking Buildbucket for the build status
[22:11:08.146] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:08.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:93:0) after 1m0s
[22:12:08.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:93:0)
[22:12:08.209] Timer tick, asking Buildbucket for the build status
[22:12:08.348] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:08.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:94:0) after 1m0s
[22:13:08.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:94:0)
[22:13:08.486] Timer tick, asking Buildbucket for the build status
[22:13:08.597] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:08.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:95:0) after 1m0s
[22:14:08.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:95:0)
[22:14:08.942] Timer tick, asking Buildbucket for the build status
[22:14:09.016] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:09.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:96:0) after 1m0s
[22:15:09.166] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:96:0)
[22:15:09.166] Timer tick, asking Buildbucket for the build status
[22:15:09.591] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:09.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:97:0) after 1m0s
[22:16:09.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:97:0)
[22:16:09.782] Timer tick, asking Buildbucket for the build status
[22:16:10.041] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:10.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:98:0) after 1m0s
[22:17:10.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:98:0)
[22:17:10.062] Timer tick, asking Buildbucket for the build status
[22:17:10.142] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:10.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:99:0) after 1m0s
[22:18:10.179] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:99:0)
[22:18:10.179] Timer tick, asking Buildbucket for the build status
[22:18:10.264] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:10.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:100:0) after 1m0s
[22:19:10.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:100:0)
[22:19:10.307] Timer tick, asking Buildbucket for the build status
[22:19:10.391] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:10.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:101:0) after 1m0s
[22:20:10.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:101:0)
[22:20:10.388] Timer tick, asking Buildbucket for the build status
[22:20:10.546] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:10.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:102:0) after 1m0s
[22:21:10.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:102:0)
[22:21:10.586] Timer tick, asking Buildbucket for the build status
[22:21:10.810] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:10.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:103:0) after 1m0s
[22:22:10.830] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:103:0)
[22:22:10.830] Timer tick, asking Buildbucket for the build status
[22:22:10.994] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:10.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:104:0) after 1m0s
[22:23:11.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:104:0)
[22:23:11.257] Timer tick, asking Buildbucket for the build status
[22:23:11.438] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:11.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:105:0) after 1m0s
[22:24:11.438] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:105:0)
[22:24:11.438] Timer tick, asking Buildbucket for the build status
[22:24:11.529] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:11.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:106:0) after 1m0s
[22:25:11.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:106:0)
[22:25:11.592] Timer tick, asking Buildbucket for the build status
[22:25:11.803] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:11.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:107:0) after 1m0s
[22:26:11.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:107:0)
[22:26:11.888] Timer tick, asking Buildbucket for the build status
[22:26:12.003] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:12.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:108:0) after 1m0s
[22:27:12.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:108:0)
[22:27:12.028] Timer tick, asking Buildbucket for the build status
[22:27:12.092] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:12.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:109:0) after 1m0s
[22:28:12.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:109:0)
[22:28:12.194] Timer tick, asking Buildbucket for the build status
[22:28:12.256] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:12.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:110:0) after 1m0s
[22:29:12.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:110:0)
[22:29:12.334] Timer tick, asking Buildbucket for the build status
[22:29:12.448] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:12.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:111:0) after 1m0s
[22:30:12.605] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:111:0)
[22:30:12.605] Timer tick, asking Buildbucket for the build status
[22:30:12.880] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:12.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:112:0) after 1m0s
[22:31:12.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:112:0)
[22:31:12.947] Timer tick, asking Buildbucket for the build status
[22:31:13.973] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:13.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:113:0) after 1m0s
[22:32:14.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:113:0)
[22:32:14.301] Timer tick, asking Buildbucket for the build status
[22:32:14.385] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:14.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:114:0) after 1m0s
[22:33:14.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:114:0)
[22:33:14.609] Timer tick, asking Buildbucket for the build status
[22:33:14.686] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:14.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:115:0) after 1m0s
[22:34:14.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:115:0)
[22:34:14.788] Timer tick, asking Buildbucket for the build status
[22:34:14.859] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:14.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:116:0) after 1m0s
[22:35:14.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:116:0)
[22:35:14.901] Timer tick, asking Buildbucket for the build status
[22:35:15.006] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:15.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:117:0) after 1m0s
[22:36:15.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:117:0)
[22:36:15.122] Timer tick, asking Buildbucket for the build status
[22:36:15.217] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:15.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:118:0) after 1m0s
[22:37:15.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:118:0)
[22:37:15.265] Timer tick, asking Buildbucket for the build status
[22:37:15.353] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:15.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:119:0) after 1m0s
[22:38:15.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:119:0)
[22:38:15.771] Timer tick, asking Buildbucket for the build status
[22:38:15.837] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:15.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:120:0) after 1m0s
[22:39:15.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:120:0)
[22:39:15.891] Timer tick, asking Buildbucket for the build status
[22:39:15.975] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:15.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:121:0) after 1m0s
[22:40:16.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:121:0)
[22:40:16.048] Timer tick, asking Buildbucket for the build status
[22:40:16.245] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:16.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:122:0) after 1m0s
[22:41:16.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:122:0)
[22:41:16.498] Timer tick, asking Buildbucket for the build status
[22:41:16.659] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:16.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:123:0) after 1m0s
[22:42:16.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:123:0)
[22:42:16.810] Timer tick, asking Buildbucket for the build status
[22:42:16.905] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:16.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:124:0) after 1m0s
[22:43:16.922] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:124:0)
[22:43:16.922] Timer tick, asking Buildbucket for the build status
[22:43:17.044] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:17.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:125:0) after 1m0s
[22:44:17.147] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:125:0)
[22:44:17.147] Timer tick, asking Buildbucket for the build status
[22:44:17.219] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:17.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:126:0) after 1m0s
[22:45:17.514] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:126:0)
[22:45:17.514] Timer tick, asking Buildbucket for the build status
[22:45:17.650] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:17.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:127:0) after 1m0s
[22:46:17.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:127:0)
[22:46:17.834] Timer tick, asking Buildbucket for the build status
[22:46:17.918] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:17.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:128:0) after 1m0s
[22:47:18.006] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:128:0)
[22:47:18.006] Timer tick, asking Buildbucket for the build status
[22:47:18.078] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:18.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:129:0) after 1m0s
[22:48:18.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:129:0)
[22:48:18.137] Timer tick, asking Buildbucket for the build status
[22:48:18.212] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:18.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:130:0) after 1m0s
[22:49:18.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:130:0)
[22:49:18.239] Timer tick, asking Buildbucket for the build status
[22:49:18.879] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:18.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:131:0) after 1m0s
[22:50:18.992] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:131:0)
[22:50:18.992] Timer tick, asking Buildbucket for the build status
[22:50:19.074] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:19.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:132:0) after 1m0s
[22:51:19.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:132:0)
[22:51:19.264] Timer tick, asking Buildbucket for the build status
[22:51:19.353] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:19.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:133:0) after 1m0s
[22:52:19.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:133:0)
[22:52:19.425] Timer tick, asking Buildbucket for the build status
[22:52:19.863] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:19.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:134:0) after 1m0s
[22:53:20.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:134:0)
[22:53:20.679] Timer tick, asking Buildbucket for the build status
[22:53:20.788] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:20.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:135:0) after 1m0s
[22:54:21.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:135:0)
[22:54:21.573] Timer tick, asking Buildbucket for the build status
[22:54:21.665] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:21.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:136:0) after 1m0s
[22:55:21.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:136:0)
[22:55:21.936] Timer tick, asking Buildbucket for the build status
[22:55:22.025] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:22.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:137:0) after 1m0s
[22:56:22.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:137:0)
[22:56:22.132] Timer tick, asking Buildbucket for the build status
[22:56:22.212] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:22.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:138:0) after 1m0s
[22:57:22.359] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:138:0)
[22:57:22.359] Timer tick, asking Buildbucket for the build status
[22:57:22.425] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:22.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:139:0) after 1m0s
[22:58:22.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:139:0)
[22:58:22.493] Timer tick, asking Buildbucket for the build status
[22:58:22.599] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:22.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:140:0) after 1m0s
[22:59:22.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:140:0)
[22:59:22.622] Timer tick, asking Buildbucket for the build status
[22:59:22.750] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:22.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:141:0) after 1m0s
[23:00:22.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:141:0)
[23:00:22.756] Timer tick, asking Buildbucket for the build status
[23:00:22.816] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:22.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:142:0) after 1m0s
[23:01:23.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:142:0)
[23:01:23.083] Timer tick, asking Buildbucket for the build status
[23:01:23.196] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:23.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:143:0) after 1m0s
[23:02:23.358] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:143:0)
[23:02:23.358] Timer tick, asking Buildbucket for the build status
[23:02:23.630] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:23.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:144:0) after 1m0s
[23:03:24.113] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:144:0)
[23:03:24.113] Timer tick, asking Buildbucket for the build status
[23:03:24.176] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:24.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:145:0) after 1m0s
[23:04:24.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:145:0)
[23:04:24.287] Timer tick, asking Buildbucket for the build status
[23:04:26.219] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:26.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:146:0) after 1m0s
[23:05:26.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:146:0)
[23:05:26.333] Timer tick, asking Buildbucket for the build status
[23:05:26.403] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:26.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:147:0) after 1m0s
[23:06:26.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:147:0)
[23:06:26.497] Timer tick, asking Buildbucket for the build status
[23:06:26.624] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:26.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:148:0) after 1m0s
[23:07:26.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:148:0)
[23:07:26.661] Timer tick, asking Buildbucket for the build status
[23:07:26.981] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:26.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:149:0) after 1m0s
[23:08:27.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:149:0)
[23:08:27.056] Timer tick, asking Buildbucket for the build status
[23:08:27.265] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:27.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:150:0) after 1m0s
[23:09:27.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:150:0)
[23:09:27.277] Timer tick, asking Buildbucket for the build status
[23:09:27.374] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:27.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:151:0) after 1m0s
[23:10:27.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:151:0)
[23:10:27.458] Timer tick, asking Buildbucket for the build status
[23:10:27.530] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:27.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:152:0) after 1m0s
[23:11:27.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:152:0)
[23:11:27.574] Timer tick, asking Buildbucket for the build status
[23:11:27.672] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:27.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:153:0) after 1m0s
[23:12:27.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:153:0)
[23:12:27.696] Timer tick, asking Buildbucket for the build status
[23:12:27.948] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:27.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:154:0) after 1m0s
[23:13:27.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:154:0)
[23:13:27.976] Timer tick, asking Buildbucket for the build status
[23:13:28.051] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:28.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:155:0) after 1m0s
[23:14:28.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:155:0)
[23:14:28.055] Timer tick, asking Buildbucket for the build status
[23:14:28.864] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:28.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:156:0) after 1m0s
[23:15:28.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:156:0)
[23:15:28.942] Timer tick, asking Buildbucket for the build status
[23:15:29.021] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:29.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:157:0) after 1m0s
[23:16:29.049] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:157:0)
[23:16:29.049] Timer tick, asking Buildbucket for the build status
[23:16:29.409] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:29.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:158:0) after 1m0s
[23:17:29.522] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:158:0)
[23:17:29.522] Timer tick, asking Buildbucket for the build status
[23:17:29.586] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:29.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:159:0) after 1m0s
[23:18:29.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:159:0)
[23:18:29.598] Timer tick, asking Buildbucket for the build status
[23:18:29.754] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:29.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:160:0) after 1m0s
[23:19:29.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:160:0)
[23:19:29.823] Timer tick, asking Buildbucket for the build status
[23:19:30.058] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:30.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:161:0) after 1m0s
[23:20:30.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:161:0)
[23:20:30.102] Timer tick, asking Buildbucket for the build status
[23:20:30.250] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:30.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:162:0) after 1m0s
[23:21:30.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:162:0)
[23:21:30.275] Timer tick, asking Buildbucket for the build status
[23:21:30.355] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:30.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:163:0) after 1m0s
[23:22:30.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:163:0)
[23:22:30.411] Timer tick, asking Buildbucket for the build status
[23:22:30.491] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:30.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:164:0) after 1m0s
[23:23:30.545] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:164:0)
[23:23:30.545] Timer tick, asking Buildbucket for the build status
[23:23:30.675] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:30.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:165:0) after 1m0s
[23:24:30.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:165:0)
[23:24:30.746] Timer tick, asking Buildbucket for the build status
[23:24:30.831] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:30.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:166:0) after 1m0s
[23:25:30.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:166:0)
[23:25:30.925] Timer tick, asking Buildbucket for the build status
[23:25:31.028] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:31.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:167:0) after 1m0s
[23:26:31.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:167:0)
[23:26:31.063] Timer tick, asking Buildbucket for the build status
[23:26:31.225] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:31.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:168:0) after 1m0s
[23:27:31.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:168:0)
[23:27:31.278] Timer tick, asking Buildbucket for the build status
[23:27:31.343] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:31.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:169:0) after 1m0s
[23:28:31.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:169:0)
[23:28:31.377] Timer tick, asking Buildbucket for the build status
[23:28:31.663] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:31.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:170:0) after 1m0s
[23:29:31.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:170:0)
[23:29:31.715] Timer tick, asking Buildbucket for the build status
[23:29:32.011] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:32.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:171:0) after 1m0s
[23:30:32.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:171:0)
[23:30:32.099] Timer tick, asking Buildbucket for the build status
[23:30:32.162] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:32.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:172:0) after 1m0s
[23:31:32.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:172:0)
[23:31:32.177] Timer tick, asking Buildbucket for the build status
[23:31:32.276] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:32.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:173:0) after 1m0s
[23:32:32.346] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:173:0)
[23:32:32.346] Timer tick, asking Buildbucket for the build status
[23:32:32.419] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:32.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:174:0) after 1m0s
[23:33:32.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:174:0)
[23:33:32.481] Timer tick, asking Buildbucket for the build status
[23:33:32.567] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:32.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:175:0) after 1m0s
[23:34:32.606] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:175:0)
[23:34:32.606] Timer tick, asking Buildbucket for the build status
[23:34:32.678] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:32.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:176:0) after 1m0s
[23:35:32.977] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:176:0)
[23:35:32.977] Timer tick, asking Buildbucket for the build status
[23:35:33.273] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:33.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:177:0) after 1m0s
[23:36:33.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:177:0)
[23:36:33.328] Timer tick, asking Buildbucket for the build status
[23:36:33.406] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:33.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:178:0) after 1m0s
[23:37:35.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:178:0)
[23:37:35.308] Timer tick, asking Buildbucket for the build status
[23:37:35.560] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:35.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:179:0) after 1m0s
[23:38:35.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:179:0)
[23:38:35.934] Timer tick, asking Buildbucket for the build status
[23:38:36.140] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:36.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:180:0) after 1m0s
[23:39:36.314] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:180:0)
[23:39:36.314] Timer tick, asking Buildbucket for the build status
[23:39:36.581] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:36.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:181:0) after 1m0s
[23:40:36.610] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:181:0)
[23:40:36.610] Timer tick, asking Buildbucket for the build status
[23:40:36.675] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:36.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:182:0) after 1m0s
[23:41:36.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:182:0)
[23:41:36.697] Timer tick, asking Buildbucket for the build status
[23:41:36.785] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:36.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:183:0) after 1m0s
[23:42:36.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:183:0)
[23:42:36.792] Timer tick, asking Buildbucket for the build status
[23:42:36.866] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:36.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:184:0) after 1m0s
[23:43:36.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:184:0)
[23:43:36.889] Timer tick, asking Buildbucket for the build status
[23:43:36.967] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:36.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:185:0) after 1m0s
[23:44:36.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:185:0)
[23:44:36.990] Timer tick, asking Buildbucket for the build status
[23:44:37.069] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:37.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:186:0) after 1m0s
[23:45:37.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:186:0)
[23:45:37.102] Timer tick, asking Buildbucket for the build status
[23:45:37.185] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:37.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:187:0) after 1m0s
[23:46:37.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:187:0)
[23:46:37.248] Timer tick, asking Buildbucket for the build status
[23:46:37.327] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:37.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:188:0) after 1m0s
[23:47:37.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:188:0)
[23:47:37.336] Timer tick, asking Buildbucket for the build status
[23:47:37.798] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:37.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:189:0) after 1m0s
[23:48:37.830] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:189:0)
[23:48:37.830] Timer tick, asking Buildbucket for the build status
[23:48:37.896] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:37.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:190:0) after 1m0s
[23:49:37.928] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:190:0)
[23:49:37.929] Timer tick, asking Buildbucket for the build status
[23:49:39.356] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:39.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:191:0) after 1m0s
[23:50:39.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:191:0)
[23:50:39.397] Timer tick, asking Buildbucket for the build status
[23:50:39.540] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:39.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:192:0) after 1m0s
[23:51:39.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:192:0)
[23:51:39.586] Timer tick, asking Buildbucket for the build status
[23:51:39.669] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:39.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:193:0) after 1m0s
[23:52:39.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:193:0)
[23:52:39.714] Timer tick, asking Buildbucket for the build status
[23:52:39.786] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:39.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:194:0) after 1m0s
[23:53:39.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:194:0)
[23:53:39.822] Timer tick, asking Buildbucket for the build status
[23:53:40.166] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:40.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:195:0) after 1m0s
[23:54:40.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:195:0)
[23:54:40.268] Timer tick, asking Buildbucket for the build status
[23:54:40.335] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:40.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:196:0) after 1m0s
[23:55:40.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:196:0)
[23:55:40.426] Timer tick, asking Buildbucket for the build status
[23:55:40.567] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:40.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:197:0) after 1m0s
[23:56:40.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:197:0)
[23:56:40.655] Timer tick, asking Buildbucket for the build status
[23:56:40.735] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:40.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:198:0) after 1m0s
[23:57:40.842] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:198:0)
[23:57:40.842] Timer tick, asking Buildbucket for the build status
[23:57:41.700] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:41.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:199:0) after 1m0s
[23:58:41.886] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:199:0)
[23:58:41.887] Timer tick, asking Buildbucket for the build status
[23:58:41.975] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:41.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:200:0) after 1m0s
[23:59:42.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:200:0)
[23:59:42.308] Timer tick, asking Buildbucket for the build status
[23:59:42.550] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:42.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:201:0) after 1m0s
[00:00:42.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:201:0)
[00:00:42.608] Timer tick, asking Buildbucket for the build status
[00:00:42.682] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:42.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:202:0) after 1m0s
[00:01:42.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:202:0)
[00:01:42.763] Timer tick, asking Buildbucket for the build status
[00:01:42.822] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:42.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:203:0) after 1m0s
[00:02:42.902] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:203:0)
[00:02:42.902] Timer tick, asking Buildbucket for the build status
[00:02:42.979] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:42.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:204:0) after 1m0s
[00:03:43.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:204:0)
[00:03:43.812] Timer tick, asking Buildbucket for the build status
[00:03:43.885] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:43.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:205:0) after 1m0s
[00:04:44.429] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:205:0)
[00:04:44.429] Timer tick, asking Buildbucket for the build status
[00:04:44.624] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:44.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:206:0) after 1m0s
[00:05:45.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:206:0)
[00:05:45.260] Timer tick, asking Buildbucket for the build status
[00:05:45.355] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:45.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:207:0) after 1m0s
[00:06:45.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:207:0)
[00:06:45.472] Timer tick, asking Buildbucket for the build status
[00:06:45.730] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:45.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:208:0) after 1m0s
[00:07:45.896] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:208:0)
[00:07:45.896] Timer tick, asking Buildbucket for the build status
[00:07:45.954] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:45.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:209:0) after 1m0s
[00:08:46.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:209:0)
[00:08:46.064] Timer tick, asking Buildbucket for the build status
[00:08:46.302] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:46.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:210:0) after 1m0s
[00:09:46.399] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:210:0)
[00:09:46.399] Timer tick, asking Buildbucket for the build status
[00:09:46.550] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:46.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:211:0) after 1m0s
[00:10:46.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:211:0)
[00:10:46.675] Timer tick, asking Buildbucket for the build status
[00:10:46.780] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:46.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:212:0) after 1m0s
[00:11:46.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:212:0)
[00:11:46.804] Timer tick, asking Buildbucket for the build status
[00:11:47.532] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:47.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:213:0) after 1m0s
[00:12:47.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:213:0)
[00:12:47.724] Timer tick, asking Buildbucket for the build status
[00:12:47.802] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:47.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:214:0) after 1m0s
[00:13:47.885] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:214:0)
[00:13:47.885] Timer tick, asking Buildbucket for the build status
[00:13:48.034] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:48.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:215:0) after 1m0s
[00:14:48.130] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:215:0)
[00:14:48.130] Timer tick, asking Buildbucket for the build status
[00:14:48.562] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:48.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:216:0) after 1m0s
[00:15:48.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:216:0)
[00:15:48.739] Timer tick, asking Buildbucket for the build status
[00:15:48.850] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:48.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:217:0) after 1m0s
[00:16:49.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:217:0)
[00:16:49.388] Timer tick, asking Buildbucket for the build status
[00:16:49.461] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:49.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:218:0) after 1m0s
[00:17:49.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:218:0)
[00:17:49.704] Timer tick, asking Buildbucket for the build status
[00:17:49.782] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:49.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:219:0) after 1m0s
[00:18:50.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:219:0)
[00:18:50.336] Timer tick, asking Buildbucket for the build status
[00:18:50.591] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:50.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:220:0) after 1m0s
[00:19:50.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:220:0)
[00:19:50.677] Timer tick, asking Buildbucket for the build status
[00:19:50.753] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:50.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:221:0) after 1m0s
[00:20:50.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:221:0)
[00:20:50.811] Timer tick, asking Buildbucket for the build status
[00:20:50.906] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:50.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:222:0) after 1m0s
[00:21:51.039] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:222:0)
[00:21:51.039] Timer tick, asking Buildbucket for the build status
[00:21:51.105] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:51.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:223:0) after 1m0s
[00:22:51.133] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:223:0)
[00:22:51.133] Timer tick, asking Buildbucket for the build status
[00:22:51.199] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:51.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:224:0) after 1m0s
[00:23:51.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:224:0)
[00:23:51.321] Timer tick, asking Buildbucket for the build status
[00:23:51.409] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:51.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:225:0) after 1m0s
[00:24:51.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:225:0)
[00:24:51.899] Timer tick, asking Buildbucket for the build status
[00:24:51.971] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:51.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:226:0) after 1m0s
[00:25:52.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:226:0)
[00:25:52.357] Timer tick, asking Buildbucket for the build status
[00:25:52.451] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:52.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:227:0) after 1m0s
[00:26:52.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:227:0)
[00:26:52.836] Timer tick, asking Buildbucket for the build status
[00:26:52.944] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:52.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:228:0) after 1m0s
[00:27:53.016] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:228:0)
[00:27:53.016] Timer tick, asking Buildbucket for the build status
[00:27:53.110] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:53.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:229:0) after 1m0s
[00:28:53.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:229:0)
[00:28:53.648] Timer tick, asking Buildbucket for the build status
[00:28:53.738] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:53.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:230:0) after 1m0s
[00:29:53.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:230:0)
[00:29:53.837] Timer tick, asking Buildbucket for the build status
[00:29:53.896] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:53.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:231:0) after 1m0s
[00:30:54.016] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:231:0)
[00:30:54.016] Timer tick, asking Buildbucket for the build status
[00:30:54.124] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:54.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:232:0) after 1m0s
[00:31:54.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:232:0)
[00:31:54.143] Timer tick, asking Buildbucket for the build status
[00:31:54.213] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:54.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:233:0) after 1m0s
[00:32:54.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:233:0)
[00:32:54.301] Timer tick, asking Buildbucket for the build status
[00:32:54.521] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:54.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:234:0) after 1m0s
[00:33:54.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:234:0)
[00:33:54.597] Timer tick, asking Buildbucket for the build status
[00:33:54.662] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:54.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:235:0) after 1m0s
[00:34:54.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:235:0)
[00:34:54.691] Timer tick, asking Buildbucket for the build status
[00:34:55.158] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:55.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:236:0) after 1m0s
[00:35:55.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:236:0)
[00:35:55.180] Timer tick, asking Buildbucket for the build status
[00:35:55.263] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:55.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:237:0) after 1m0s
[00:36:55.298] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:237:0)
[00:36:55.298] Timer tick, asking Buildbucket for the build status
[00:36:55.378] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:55.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:238:0) after 1m0s
[00:37:55.370] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:238:0)
[00:37:55.370] Timer tick, asking Buildbucket for the build status
[00:37:55.439] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:55.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:239:0) after 1m0s
[00:38:55.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:239:0)
[00:38:55.447] Timer tick, asking Buildbucket for the build status
[00:38:55.544] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:55.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:240:0) after 1m0s
[00:39:55.558] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:240:0)
[00:39:55.558] Timer tick, asking Buildbucket for the build status
[00:39:55.629] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:55.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:241:0) after 1m0s
[00:40:55.657] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:241:0)
[00:40:55.657] Timer tick, asking Buildbucket for the build status
[00:40:55.760] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:55.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:242:0) after 1m0s
[00:41:55.817] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:242:0)
[00:41:55.817] Timer tick, asking Buildbucket for the build status
[00:41:55.939] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:55.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:243:0) after 1m0s
[00:42:55.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:243:0)
[00:42:55.986] Timer tick, asking Buildbucket for the build status
[00:42:56.107] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:56.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:244:0) after 1m0s
[00:43:56.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:244:0)
[00:43:56.136] Timer tick, asking Buildbucket for the build status
[00:43:56.424] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:56.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:245:0) after 1m0s
[00:44:56.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:245:0)
[00:44:56.515] Timer tick, asking Buildbucket for the build status
[00:44:56.616] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:56.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:246:0) after 1m0s
[00:45:56.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:246:0)
[00:45:56.706] Timer tick, asking Buildbucket for the build status
[00:45:56.945] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:56.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:247:0) after 1m0s
[00:46:56.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:247:0)
[00:46:56.961] Timer tick, asking Buildbucket for the build status
[00:46:57.347] Build 8853567775342564512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:57.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018997837569781920:248:0) after 1m0s
[00:47:19.872] Received PubSub notification, asking Buildbucket for the build status
[00:47:19.956] Build 8853567775342564512: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:47:19.956] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1614991638700225",
    "created_by": "project:chromium",
    "created_ts": "1614976826301109",
    "id": "8853567775342564512",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"54eebbdc802d943b3ad9bfe73ab364ceb5b6d203\"}}",
    "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\": \"54eebbdc802d943b3ad9bfe73ab364ceb5b6d203\", \"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-2-bv67\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1696, \"got_angle_revision\": \"40ed11b7e261221d403ac49edd3e2420246d5b2b\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"54eebbdc802d943b3ad9bfe73ab364ceb5b6d203\", \"got_revision_cp\": \"refs/heads/master@{#860346}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"6846389f25cad4233a4bd04fd3fc6c60ae30ff35\", \"got_v8_revision\": \"8dbf230b3378ff324a554d7f827dc14928c40e3f\", \"got_v8_revision_cp\": \"refs/heads/9.1.53@{#1}\", \"got_webrtc_revision\": \"1413e2db4c9b186176a54e70c52f5b673c2cb939\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33387}\", \"is_cached\": true, \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"54eebbdc802d943b3ad9bfe73ab364ceb5b6d203\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_1daffed6dde8d2010ab2a7aee555237ff999d968966bfcf42bbce4ac98bb7a23_v2\", \"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-2-bv67\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5725-1a0d85e\"], \"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": "1614976958882811",
    "status": "COMPLETED",
    "status_changed_ts": "1614991639151952",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1696",
      "builder:win-official",
      "buildset:commit/git/54eebbdc802d943b3ad9bfe73ab364ceb5b6d203",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/54eebbdc802d943b3ad9bfe73ab364ceb5b6d203",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9018997837569781920",
      "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/8853567775342564512/+/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:521cf046d239a410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1614991639182614",
    "url": "https://ci.chromium.org/b/8853567775342564512",
    "utcnow_ts": "1614991639945176"
  }
}
[00:47:19.956] Invocation finished in 4h6m55.162017932s with status SUCCEEDED