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

• 07d6d038aaa9df251ba6bdf307bc28ecf0de082d (5 years ago)
• eef7c1cf971b08a59d7088d6f01fe808061ca81c (5 years ago)
• f79b1513420778734014302fedddd83e3568efc8 (5 years ago)
• cd2f1bed1f8278978df9a3d30f6cdb6d872a72c3 (5 years ago)
• a8c0c42e8340b922689b6b802585fafc196933b7 (5 years ago)
• 185a4c4316b38d3e07420e28d283854dbb088ceb (5 years ago)
• 0d7fc21be654169e10b1803510d589bb27d89eb8 (5 years ago)
• 5b080a7ba999fc95b6435f0896898d84b26f966a (5 years ago)
• 2d7f00fe7a72dc6ee6c6f6725a53e32050bd56f5 (5 years ago)
• bf65024f1630c29ee292da4ae632f52f91f52018 (5 years ago)
• 23843cdff8b264d7ecc10a8046fdf43b6f721843 (5 years ago)
• e1886ae31f12f3f25499c01268a3fb867f31fe63 (5 years ago)

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

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

[06:20:34.597] New invocation is queued and will start shortly
[06:20:35.631] Starting the invocation (attempt 1)
[06:20:35.663] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:20:35.663] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:20:35.663] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9032279090922216896",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e1886ae31f12f3f25499c01268a3fb867f31fe63\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9032279090922216896",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/e1886ae31f12f3f25499c01268a3fb867f31fe63",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1886ae31f12f3f25499c01268a3fb867f31fe63",
    "gitiles_ref:refs/heads/master"
  ]
}
[06:20:36.517] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1602310835780072",
    "id": "8866849029018887600",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e1886ae31f12f3f25499c01268a3fb867f31fe63\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1602310836419839",
    "tags": [
      "build_address:luci.chromium.ci/win-official/781",
      "builder:win-official",
      "buildset:commit/git/e1886ae31f12f3f25499c01268a3fb867f31fe63",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1886ae31f12f3f25499c01268a3fb867f31fe63",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9032279090922216896",
      "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/8866849029018887600/+/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": "1602310836419984",
    "url": "https://ci.chromium.org/b/8866849029018887600",
    "utcnow_ts": "1602310836509142"
  }
}
[06:20:36.517] Task URL: https://ci.chromium.org/b/8866849029018887600
[06:20:36.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:2:0) after 1m0s
[06:21:36.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:2:0)
[06:21:36.548] Timer tick, asking Buildbucket for the build status
[06:21:36.873] Build 8866849029018887600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:21:36.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:3:0) after 1m0s
[06:22:36.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:3:0)
[06:22:36.914] Timer tick, asking Buildbucket for the build status
[06:22:36.996] Build 8866849029018887600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:22:36.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:4:0) after 1m0s
[06:22:43.810] Received PubSub notification, asking Buildbucket for the build status
[06:22:43.928] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:37.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:4:0)
[06:23:37.206] Timer tick, asking Buildbucket for the build status
[06:23:37.415] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:37.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:6:0) after 1m0s
[06:24:37.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:6:0)
[06:24:37.599] Timer tick, asking Buildbucket for the build status
[06:24:37.672] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:37.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:7:0) after 1m0s
[06:25:37.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:7:0)
[06:25:37.873] Timer tick, asking Buildbucket for the build status
[06:25:38.042] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:38.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:8:0) after 1m0s
[06:26:38.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:8:0)
[06:26:38.257] Timer tick, asking Buildbucket for the build status
[06:26:38.374] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:38.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:9:0) after 1m0s
[06:27:38.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:9:0)
[06:27:38.363] Timer tick, asking Buildbucket for the build status
[06:27:38.669] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:38.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:10:0) after 1m0s
[06:28:38.691] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:10:0)
[06:28:38.691] Timer tick, asking Buildbucket for the build status
[06:28:38.835] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:38.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:11:0) after 1m0s
[06:29:38.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:11:0)
[06:29:38.855] Timer tick, asking Buildbucket for the build status
[06:29:38.931] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:38.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:12:0) after 1m0s
[06:30:38.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:12:0)
[06:30:38.959] Timer tick, asking Buildbucket for the build status
[06:30:39.147] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:39.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:13:0) after 1m0s
[06:31:39.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:13:0)
[06:31:39.212] Timer tick, asking Buildbucket for the build status
[06:31:39.365] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:39.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:14:0) after 1m0s
[06:32:39.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:14:0)
[06:32:39.440] Timer tick, asking Buildbucket for the build status
[06:32:39.582] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:39.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:15:0) after 1m0s
[06:33:39.606] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:15:0)
[06:33:39.606] Timer tick, asking Buildbucket for the build status
[06:33:39.671] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:39.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:16:0) after 1m0s
[06:34:39.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:16:0)
[06:34:39.696] Timer tick, asking Buildbucket for the build status
[06:34:39.916] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:39.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:17:0) after 1m0s
[06:35:39.956] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:17:0)
[06:35:39.956] Timer tick, asking Buildbucket for the build status
[06:35:40.076] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:40.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:18:0) after 1m0s
[06:36:40.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:18:0)
[06:36:40.151] Timer tick, asking Buildbucket for the build status
[06:36:40.227] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:40.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:19:0) after 1m0s
[06:37:40.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:19:0)
[06:37:40.349] Timer tick, asking Buildbucket for the build status
[06:37:40.419] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:40.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:20:0) after 1m0s
[06:38:40.490] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:20:0)
[06:38:40.490] Timer tick, asking Buildbucket for the build status
[06:38:40.586] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:40.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:21:0) after 1m0s
[06:39:40.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:21:0)
[06:39:40.671] Timer tick, asking Buildbucket for the build status
[06:39:40.834] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:40.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:22:0) after 1m0s
[06:40:40.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:22:0)
[06:40:40.825] Timer tick, asking Buildbucket for the build status
[06:40:40.920] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:40.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:23:0) after 1m0s
[06:41:40.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:23:0)
[06:41:40.951] Timer tick, asking Buildbucket for the build status
[06:41:41.046] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:41.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:24:0) after 1m0s
[06:42:41.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:24:0)
[06:42:41.082] Timer tick, asking Buildbucket for the build status
[06:42:41.511] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:41.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:25:0) after 1m0s
[06:43:41.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:25:0)
[06:43:41.579] Timer tick, asking Buildbucket for the build status
[06:43:41.639] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:41.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:26:0) after 1m0s
[06:44:41.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:26:0)
[06:44:41.661] Timer tick, asking Buildbucket for the build status
[06:44:41.733] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:41.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:27:0) after 1m0s
[06:45:42.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:27:0)
[06:45:42.575] Timer tick, asking Buildbucket for the build status
[06:45:42.731] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:42.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:28:0) after 1m0s
[06:46:42.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:28:0)
[06:46:42.757] Timer tick, asking Buildbucket for the build status
[06:46:42.828] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:42.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:29:0) after 1m0s
[06:47:42.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:29:0)
[06:47:42.855] Timer tick, asking Buildbucket for the build status
[06:47:42.915] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:42.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:30:0) after 1m0s
[06:48:42.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:30:0)
[06:48:42.935] Timer tick, asking Buildbucket for the build status
[06:48:42.994] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:42.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:31:0) after 1m0s
[06:49:43.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:31:0)
[06:49:43.112] Timer tick, asking Buildbucket for the build status
[06:49:43.171] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:43.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:32:0) after 1m0s
[06:50:43.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:32:0)
[06:50:43.198] Timer tick, asking Buildbucket for the build status
[06:50:43.304] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:43.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:33:0) after 1m0s
[06:51:43.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:33:0)
[06:51:43.282] Timer tick, asking Buildbucket for the build status
[06:51:43.350] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:43.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:34:0) after 1m0s
[06:52:43.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:34:0)
[06:52:43.373] Timer tick, asking Buildbucket for the build status
[06:52:43.432] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:43.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:35:0) after 1m0s
[06:53:43.442] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:35:0)
[06:53:43.442] Timer tick, asking Buildbucket for the build status
[06:53:43.502] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:43.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:36:0) after 1m0s
[06:54:43.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:36:0)
[06:54:43.529] Timer tick, asking Buildbucket for the build status
[06:54:43.646] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:43.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:37:0) after 1m0s
[06:55:43.692] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:37:0)
[06:55:43.692] Timer tick, asking Buildbucket for the build status
[06:55:44.114] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:44.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:38:0) after 1m0s
[06:56:44.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:38:0)
[06:56:44.121] Timer tick, asking Buildbucket for the build status
[06:56:44.215] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:44.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:39:0) after 1m0s
[06:57:44.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:39:0)
[06:57:44.244] Timer tick, asking Buildbucket for the build status
[06:57:44.306] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:44.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:40:0) after 1m0s
[06:58:44.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:40:0)
[06:58:44.331] Timer tick, asking Buildbucket for the build status
[06:58:44.398] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:44.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:41:0) after 1m0s
[06:59:44.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:41:0)
[06:59:44.423] Timer tick, asking Buildbucket for the build status
[06:59:44.515] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:44.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:42:0) after 1m0s
[07:00:44.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:42:0)
[07:00:44.517] Timer tick, asking Buildbucket for the build status
[07:00:44.640] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:44.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:43:0) after 1m0s
[07:01:44.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:43:0)
[07:01:44.680] Timer tick, asking Buildbucket for the build status
[07:01:44.923] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:44.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:44:0) after 1m0s
[07:02:44.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:44:0)
[07:02:44.986] Timer tick, asking Buildbucket for the build status
[07:02:45.485] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:45.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:45:0) after 1m0s
[07:03:45.514] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:45:0)
[07:03:45.514] Timer tick, asking Buildbucket for the build status
[07:03:45.572] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:45.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:46:0) after 1m0s
[07:04:45.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:46:0)
[07:04:45.599] Timer tick, asking Buildbucket for the build status
[07:04:45.916] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:45.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:47:0) after 1m0s
[07:05:45.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:47:0)
[07:05:45.942] Timer tick, asking Buildbucket for the build status
[07:05:46.038] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:46.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:48:0) after 1m0s
[07:06:46.073] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:48:0)
[07:06:46.073] Timer tick, asking Buildbucket for the build status
[07:06:46.393] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:46.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:49:0) after 1m0s
[07:07:46.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:49:0)
[07:07:46.452] Timer tick, asking Buildbucket for the build status
[07:07:46.623] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:46.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:50:0) after 1m0s
[07:08:46.689] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:50:0)
[07:08:46.689] Timer tick, asking Buildbucket for the build status
[07:08:46.752] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:46.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:51:0) after 1m0s
[07:09:46.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:51:0)
[07:09:46.774] Timer tick, asking Buildbucket for the build status
[07:09:46.854] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:46.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:52:0) after 1m0s
[07:10:46.896] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:52:0)
[07:10:46.896] Timer tick, asking Buildbucket for the build status
[07:10:47.014] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:47.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:53:0) after 1m0s
[07:11:47.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:53:0)
[07:11:47.037] Timer tick, asking Buildbucket for the build status
[07:11:47.108] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:47.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:54:0) after 1m0s
[07:12:47.189] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:54:0)
[07:12:47.189] Timer tick, asking Buildbucket for the build status
[07:12:47.375] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:47.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:55:0) after 1m0s
[07:13:47.370] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:55:0)
[07:13:47.370] Timer tick, asking Buildbucket for the build status
[07:13:47.435] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:47.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:56:0) after 1m0s
[07:14:47.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:56:0)
[07:14:47.440] Timer tick, asking Buildbucket for the build status
[07:14:47.507] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:47.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:57:0) after 1m0s
[07:15:47.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:57:0)
[07:15:47.564] Timer tick, asking Buildbucket for the build status
[07:15:47.828] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:47.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:58:0) after 1m0s
[07:16:47.849] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:58:0)
[07:16:47.849] Timer tick, asking Buildbucket for the build status
[07:16:47.921] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:47.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:59:0) after 1m0s
[07:17:47.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:59:0)
[07:17:47.946] Timer tick, asking Buildbucket for the build status
[07:17:48.005] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:48.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:60:0) after 1m0s
[07:18:48.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:60:0)
[07:18:48.401] Timer tick, asking Buildbucket for the build status
[07:18:48.479] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:48.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:61:0) after 1m0s
[07:19:48.693] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:61:0)
[07:19:48.693] Timer tick, asking Buildbucket for the build status
[07:19:48.998] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:48.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:62:0) after 1m0s
[07:20:49.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:62:0)
[07:20:49.122] Timer tick, asking Buildbucket for the build status
[07:20:49.253] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:49.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:63:0) after 1m0s
[07:21:49.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:63:0)
[07:21:49.291] Timer tick, asking Buildbucket for the build status
[07:21:54.369] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:54.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:64:0) after 1m0s
[07:22:54.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:64:0)
[07:22:54.706] Timer tick, asking Buildbucket for the build status
[07:22:54.768] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:54.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:65:0) after 1m0s
[07:23:55.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:65:0)
[07:23:55.143] Timer tick, asking Buildbucket for the build status
[07:23:55.297] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:55.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:66:0) after 1m0s
[07:24:55.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:66:0)
[07:24:55.419] Timer tick, asking Buildbucket for the build status
[07:24:55.497] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:55.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:67:0) after 1m0s
[07:25:55.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:67:0)
[07:25:55.676] Timer tick, asking Buildbucket for the build status
[07:25:55.814] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:55.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:68:0) after 1m0s
[07:26:55.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:68:0)
[07:26:55.876] Timer tick, asking Buildbucket for the build status
[07:26:56.206] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:56.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:69:0) after 1m0s
[07:27:56.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:69:0)
[07:27:56.324] Timer tick, asking Buildbucket for the build status
[07:27:56.391] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:56.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:70:0) after 1m0s
[07:28:56.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:70:0)
[07:28:56.480] Timer tick, asking Buildbucket for the build status
[07:28:56.563] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:56.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:71:0) after 1m0s
[07:29:56.767] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:71:0)
[07:29:56.767] Timer tick, asking Buildbucket for the build status
[07:29:56.840] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:56.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:72:0) after 1m0s
[07:30:56.993] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:72:0)
[07:30:56.993] Timer tick, asking Buildbucket for the build status
[07:30:57.417] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:57.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:73:0) after 1m0s
[07:31:57.454] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:73:0)
[07:31:57.454] Timer tick, asking Buildbucket for the build status
[07:31:57.742] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:57.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:74:0) after 1m0s
[07:32:57.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:74:0)
[07:32:57.730] Timer tick, asking Buildbucket for the build status
[07:32:57.888] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:57.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:75:0) after 1m0s
[07:33:57.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:75:0)
[07:33:57.915] Timer tick, asking Buildbucket for the build status
[07:33:58.087] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:58.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:76:0) after 1m0s
[07:34:58.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:76:0)
[07:34:58.111] Timer tick, asking Buildbucket for the build status
[07:34:58.303] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:58.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:77:0) after 1m0s
[07:35:58.325] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:77:0)
[07:35:58.326] Timer tick, asking Buildbucket for the build status
[07:35:58.700] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:58.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:78:0) after 1m0s
[07:36:58.766] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:78:0)
[07:36:58.766] Timer tick, asking Buildbucket for the build status
[07:36:59.089] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:59.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:79:0) after 1m0s
[07:37:59.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:79:0)
[07:37:59.371] Timer tick, asking Buildbucket for the build status
[07:37:59.593] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:59.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:80:0) after 1m0s
[07:38:59.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:80:0)
[07:38:59.740] Timer tick, asking Buildbucket for the build status
[07:39:00.235] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:00.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:81:0) after 1m0s
[07:40:00.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:81:0)
[07:40:00.313] Timer tick, asking Buildbucket for the build status
[07:40:00.479] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:00.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:82:0) after 1m0s
[07:41:00.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:82:0)
[07:41:00.569] Timer tick, asking Buildbucket for the build status
[07:41:00.708] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:00.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:83:0) after 1m0s
[07:42:01.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:83:0)
[07:42:01.005] Timer tick, asking Buildbucket for the build status
[07:42:01.197] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:01.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:84:0) after 1m0s
[07:43:01.305] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:84:0)
[07:43:01.305] Timer tick, asking Buildbucket for the build status
[07:43:01.547] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:01.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:85:0) after 1m0s
[07:44:01.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:85:0)
[07:44:01.603] Timer tick, asking Buildbucket for the build status
[07:44:02.074] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:02.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:86:0) after 1m0s
[07:45:02.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:86:0)
[07:45:02.581] Timer tick, asking Buildbucket for the build status
[07:45:02.678] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:02.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:87:0) after 1m0s
[07:46:02.827] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:87:0)
[07:46:02.827] Timer tick, asking Buildbucket for the build status
[07:46:03.199] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:03.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:88:0) after 1m0s
[07:47:03.442] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:88:0)
[07:47:03.442] Timer tick, asking Buildbucket for the build status
[07:47:03.502] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:03.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:89:0) after 1m0s
[07:48:03.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:89:0)
[07:48:03.586] Timer tick, asking Buildbucket for the build status
[07:48:03.664] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:03.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:90:0) after 1m0s
[07:49:03.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:90:0)
[07:49:03.715] Timer tick, asking Buildbucket for the build status
[07:49:03.773] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:03.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:91:0) after 1m0s
[07:50:03.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:91:0)
[07:50:03.823] Timer tick, asking Buildbucket for the build status
[07:50:03.888] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:03.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:92:0) after 1m0s
[07:51:03.980] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:92:0)
[07:51:03.980] Timer tick, asking Buildbucket for the build status
[07:51:04.098] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:04.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:93:0) after 1m0s
[07:52:04.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:93:0)
[07:52:04.324] Timer tick, asking Buildbucket for the build status
[07:52:04.398] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:04.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:94:0) after 1m0s
[07:53:04.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:94:0)
[07:53:04.504] Timer tick, asking Buildbucket for the build status
[07:53:04.681] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:04.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:95:0) after 1m0s
[07:54:04.710] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:95:0)
[07:54:04.710] Timer tick, asking Buildbucket for the build status
[07:54:04.799] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:04.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:96:0) after 1m0s
[07:55:04.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:96:0)
[07:55:04.881] Timer tick, asking Buildbucket for the build status
[07:55:04.984] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:04.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:97:0) after 1m0s
[07:56:05.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:97:0)
[07:56:05.082] Timer tick, asking Buildbucket for the build status
[07:56:05.548] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:05.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:98:0) after 1m0s
[07:57:05.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:98:0)
[07:57:05.888] Timer tick, asking Buildbucket for the build status
[07:57:06.112] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:06.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:99:0) after 1m0s
[07:58:06.514] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:99:0)
[07:58:06.514] Timer tick, asking Buildbucket for the build status
[07:58:06.575] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:06.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:100:0) after 1m0s
[07:59:07.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:100:0)
[07:59:07.089] Timer tick, asking Buildbucket for the build status
[07:59:07.152] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:07.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:101:0) after 1m0s
[08:00:07.147] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:101:0)
[08:00:07.147] Timer tick, asking Buildbucket for the build status
[08:00:07.224] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:07.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:102:0) after 1m0s
[08:01:08.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:102:0)
[08:01:08.430] Timer tick, asking Buildbucket for the build status
[08:01:08.795] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:08.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:103:0) after 1m0s
[08:02:08.924] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:103:0)
[08:02:08.924] Timer tick, asking Buildbucket for the build status
[08:02:09.116] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:09.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:104:0) after 1m0s
[08:03:09.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:104:0)
[08:03:09.185] Timer tick, asking Buildbucket for the build status
[08:03:09.595] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:09.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:105:0) after 1m0s
[08:04:09.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:105:0)
[08:04:09.642] Timer tick, asking Buildbucket for the build status
[08:04:09.738] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:09.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:106:0) after 1m0s
[08:05:09.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:106:0)
[08:05:09.889] Timer tick, asking Buildbucket for the build status
[08:05:09.945] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:09.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:107:0) after 1m0s
[08:06:10.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:107:0)
[08:06:10.022] Timer tick, asking Buildbucket for the build status
[08:06:10.249] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:10.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:108:0) after 1m0s
[08:07:10.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:108:0)
[08:07:10.234] Timer tick, asking Buildbucket for the build status
[08:07:10.350] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:10.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:109:0) after 1m0s
[08:08:10.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:109:0)
[08:08:10.580] Timer tick, asking Buildbucket for the build status
[08:08:10.663] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:10.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:110:0) after 1m0s
[08:09:10.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:110:0)
[08:09:10.780] Timer tick, asking Buildbucket for the build status
[08:09:10.849] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:10.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:111:0) after 1m0s
[08:10:10.917] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:111:0)
[08:10:10.917] Timer tick, asking Buildbucket for the build status
[08:10:10.980] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:10.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:112:0) after 1m0s
[08:11:11.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:112:0)
[08:11:11.240] Timer tick, asking Buildbucket for the build status
[08:11:11.368] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:11.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:113:0) after 1m0s
[08:12:11.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:113:0)
[08:12:11.526] Timer tick, asking Buildbucket for the build status
[08:12:11.584] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:11.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:114:0) after 1m0s
[08:13:11.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:114:0)
[08:13:11.704] Timer tick, asking Buildbucket for the build status
[08:13:11.786] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:11.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:115:0) after 1m0s
[08:14:11.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:115:0)
[08:14:11.961] Timer tick, asking Buildbucket for the build status
[08:14:12.029] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:12.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:116:0) after 1m0s
[08:15:12.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:116:0)
[08:15:12.111] Timer tick, asking Buildbucket for the build status
[08:15:12.167] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:12.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:117:0) after 1m0s
[08:16:12.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:117:0)
[08:16:12.308] Timer tick, asking Buildbucket for the build status
[08:16:12.415] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:12.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:118:0) after 1m0s
[08:17:12.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:118:0)
[08:17:12.517] Timer tick, asking Buildbucket for the build status
[08:17:12.578] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:12.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:119:0) after 1m0s
[08:18:12.727] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:119:0)
[08:18:12.727] Timer tick, asking Buildbucket for the build status
[08:18:12.793] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:12.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:120:0) after 1m0s
[08:19:12.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:120:0)
[08:19:12.998] Timer tick, asking Buildbucket for the build status
[08:19:13.063] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:13.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:121:0) after 1m0s
[08:20:13.190] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:121:0)
[08:20:13.190] Timer tick, asking Buildbucket for the build status
[08:20:13.313] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:13.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:122:0) after 1m0s
[08:21:13.467] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:122:0)
[08:21:13.467] Timer tick, asking Buildbucket for the build status
[08:21:13.658] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:13.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:123:0) after 1m0s
[08:22:13.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:123:0)
[08:22:13.807] Timer tick, asking Buildbucket for the build status
[08:22:13.918] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:13.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:124:0) after 1m0s
[08:23:13.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:124:0)
[08:23:13.968] Timer tick, asking Buildbucket for the build status
[08:23:14.033] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:14.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:125:0) after 1m0s
[08:24:14.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:125:0)
[08:24:14.144] Timer tick, asking Buildbucket for the build status
[08:24:14.211] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:14.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:126:0) after 1m0s
[08:25:14.326] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:126:0)
[08:25:14.326] Timer tick, asking Buildbucket for the build status
[08:25:14.390] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:14.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:127:0) after 1m0s
[08:26:14.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:127:0)
[08:26:14.528] Timer tick, asking Buildbucket for the build status
[08:26:14.703] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:14.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:128:0) after 1m0s
[08:27:14.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:128:0)
[08:27:14.774] Timer tick, asking Buildbucket for the build status
[08:27:14.840] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:14.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:129:0) after 1m0s
[08:28:14.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:129:0)
[08:28:14.879] Timer tick, asking Buildbucket for the build status
[08:28:14.940] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:14.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:130:0) after 1m0s
[08:29:15.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:130:0)
[08:29:15.042] Timer tick, asking Buildbucket for the build status
[08:29:15.182] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:15.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:131:0) after 1m0s
[08:30:15.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:131:0)
[08:30:15.256] Timer tick, asking Buildbucket for the build status
[08:30:15.328] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:15.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:132:0) after 1m0s
[08:31:15.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:132:0)
[08:31:15.488] Timer tick, asking Buildbucket for the build status
[08:31:15.908] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:15.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:133:0) after 1m0s
[08:32:15.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:133:0)
[08:32:15.968] Timer tick, asking Buildbucket for the build status
[08:32:16.030] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:16.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:134:0) after 1m0s
[08:33:16.147] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:134:0)
[08:33:16.147] Timer tick, asking Buildbucket for the build status
[08:33:16.214] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:16.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:135:0) after 1m0s
[08:34:16.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:135:0)
[08:34:16.255] Timer tick, asking Buildbucket for the build status
[08:34:16.522] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:16.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:136:0) after 1m0s
[08:35:16.555] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:136:0)
[08:35:16.555] Timer tick, asking Buildbucket for the build status
[08:35:16.614] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:16.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:137:0) after 1m0s
[08:36:16.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:137:0)
[08:36:16.803] Timer tick, asking Buildbucket for the build status
[08:36:17.096] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:17.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:138:0) after 1m0s
[08:37:17.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:138:0)
[08:37:17.308] Timer tick, asking Buildbucket for the build status
[08:37:17.504] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:17.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:139:0) after 1m0s
[08:38:17.582] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:139:0)
[08:38:17.582] Timer tick, asking Buildbucket for the build status
[08:38:17.648] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:17.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:140:0) after 1m0s
[08:39:17.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:140:0)
[08:39:17.761] Timer tick, asking Buildbucket for the build status
[08:39:17.838] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:17.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:141:0) after 1m0s
[08:40:17.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:141:0)
[08:40:17.920] Timer tick, asking Buildbucket for the build status
[08:40:17.978] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:17.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:142:0) after 1m0s
[08:41:18.008] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:142:0)
[08:41:18.008] Timer tick, asking Buildbucket for the build status
[08:41:18.142] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:18.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:143:0) after 1m0s
[08:42:18.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:143:0)
[08:42:18.237] Timer tick, asking Buildbucket for the build status
[08:42:18.307] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:18.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:144:0) after 1m0s
[08:43:18.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:144:0)
[08:43:18.320] Timer tick, asking Buildbucket for the build status
[08:43:18.382] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:18.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:145:0) after 1m0s
[08:44:18.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:145:0)
[08:44:18.412] Timer tick, asking Buildbucket for the build status
[08:44:18.471] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:18.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:146:0) after 1m0s
[08:45:18.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:146:0)
[08:45:18.550] Timer tick, asking Buildbucket for the build status
[08:45:18.607] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:18.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:147:0) after 1m0s
[08:46:18.684] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:147:0)
[08:46:18.684] Timer tick, asking Buildbucket for the build status
[08:46:18.799] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:18.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:148:0) after 1m0s
[08:47:18.875] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:148:0)
[08:47:18.875] Timer tick, asking Buildbucket for the build status
[08:47:19.029] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:19.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:149:0) after 1m0s
[08:48:19.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:149:0)
[08:48:19.131] Timer tick, asking Buildbucket for the build status
[08:48:19.389] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:19.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:150:0) after 1m0s
[08:49:19.478] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:150:0)
[08:49:19.478] Timer tick, asking Buildbucket for the build status
[08:49:19.544] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:19.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:151:0) after 1m0s
[08:50:19.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:151:0)
[08:50:19.687] Timer tick, asking Buildbucket for the build status
[08:50:19.800] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:19.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:152:0) after 1m0s
[08:51:19.901] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:152:0)
[08:51:19.901] Timer tick, asking Buildbucket for the build status
[08:51:20.015] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:20.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:153:0) after 1m0s
[08:52:20.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:153:0)
[08:52:20.104] Timer tick, asking Buildbucket for the build status
[08:52:20.280] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:20.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:154:0) after 1m0s
[08:53:20.327] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:154:0)
[08:53:20.327] Timer tick, asking Buildbucket for the build status
[08:53:20.390] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:20.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:155:0) after 1m0s
[08:54:20.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:155:0)
[08:54:20.502] Timer tick, asking Buildbucket for the build status
[08:54:20.833] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:20.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:156:0) after 1m0s
[08:55:20.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:156:0)
[08:55:20.916] Timer tick, asking Buildbucket for the build status
[08:55:20.970] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:20.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:157:0) after 1m0s
[08:56:21.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:157:0)
[08:56:21.036] Timer tick, asking Buildbucket for the build status
[08:56:21.149] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:21.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:158:0) after 1m0s
[08:57:21.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:158:0)
[08:57:21.151] Timer tick, asking Buildbucket for the build status
[08:57:21.229] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:21.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:159:0) after 1m0s
[08:58:21.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:159:0)
[08:58:21.391] Timer tick, asking Buildbucket for the build status
[08:58:21.585] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:21.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:160:0) after 1m0s
[08:59:21.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:160:0)
[08:59:21.662] Timer tick, asking Buildbucket for the build status
[08:59:21.779] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:21.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:161:0) after 1m0s
[09:00:21.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:161:0)
[09:00:21.925] Timer tick, asking Buildbucket for the build status
[09:00:22.551] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:22.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:162:0) after 1m0s
[09:01:22.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:162:0)
[09:01:22.535] Timer tick, asking Buildbucket for the build status
[09:01:22.691] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:22.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:163:0) after 1m0s
[09:02:22.736] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:163:0)
[09:02:22.736] Timer tick, asking Buildbucket for the build status
[09:02:22.874] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:22.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:164:0) after 1m0s
[09:03:22.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:164:0)
[09:03:22.909] Timer tick, asking Buildbucket for the build status
[09:03:22.968] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:22.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:165:0) after 1m0s
[09:04:23.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:165:0)
[09:04:23.024] Timer tick, asking Buildbucket for the build status
[09:04:23.085] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:23.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:166:0) after 1m0s
[09:05:23.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:166:0)
[09:05:23.141] Timer tick, asking Buildbucket for the build status
[09:05:23.230] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:23.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:167:0) after 1m0s
[09:06:23.292] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:167:0)
[09:06:23.293] Timer tick, asking Buildbucket for the build status
[09:06:24.204] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:24.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:168:0) after 1m0s
[09:07:24.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:168:0)
[09:07:24.306] Timer tick, asking Buildbucket for the build status
[09:07:24.416] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:24.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:169:0) after 1m0s
[09:08:24.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:169:0)
[09:08:24.500] Timer tick, asking Buildbucket for the build status
[09:08:24.621] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:24.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:170:0) after 1m0s
[09:09:24.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:170:0)
[09:09:24.651] Timer tick, asking Buildbucket for the build status
[09:09:24.772] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:24.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:171:0) after 1m0s
[09:10:24.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:171:0)
[09:10:24.822] Timer tick, asking Buildbucket for the build status
[09:10:24.891] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:24.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:172:0) after 1m0s
[09:11:24.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:172:0)
[09:11:24.939] Timer tick, asking Buildbucket for the build status
[09:11:25.071] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:25.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:173:0) after 1m0s
[09:12:25.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:173:0)
[09:12:25.256] Timer tick, asking Buildbucket for the build status
[09:12:25.509] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:25.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:174:0) after 1m0s
[09:13:25.659] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:174:0)
[09:13:25.659] Timer tick, asking Buildbucket for the build status
[09:13:26.082] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:26.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:175:0) after 1m0s
[09:14:26.073] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:175:0)
[09:14:26.073] Timer tick, asking Buildbucket for the build status
[09:14:26.133] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:26.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:176:0) after 1m0s
[09:15:26.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:176:0)
[09:15:26.157] Timer tick, asking Buildbucket for the build status
[09:15:26.230] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:26.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:177:0) after 1m0s
[09:16:26.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:177:0)
[09:16:26.381] Timer tick, asking Buildbucket for the build status
[09:16:26.718] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:26.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:178:0) after 1m0s
[09:17:26.770] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:178:0)
[09:17:26.771] Timer tick, asking Buildbucket for the build status
[09:17:27.304] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:27.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:179:0) after 1m0s
[09:18:27.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:179:0)
[09:18:27.371] Timer tick, asking Buildbucket for the build status
[09:18:27.486] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:27.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:180:0) after 1m0s
[09:19:27.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:180:0)
[09:19:27.721] Timer tick, asking Buildbucket for the build status
[09:19:28.198] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:28.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:181:0) after 1m0s
[09:20:28.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:181:0)
[09:20:28.242] Timer tick, asking Buildbucket for the build status
[09:20:28.491] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:28.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:182:0) after 1m0s
[09:21:28.552] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:182:0)
[09:21:28.552] Timer tick, asking Buildbucket for the build status
[09:21:28.660] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:28.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:183:0) after 1m0s
[09:22:28.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:183:0)
[09:22:28.867] Timer tick, asking Buildbucket for the build status
[09:22:28.933] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:28.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:184:0) after 1m0s
[09:23:28.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:184:0)
[09:23:28.970] Timer tick, asking Buildbucket for the build status
[09:23:29.050] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:29.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:185:0) after 1m0s
[09:24:29.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:185:0)
[09:24:29.076] Timer tick, asking Buildbucket for the build status
[09:24:29.171] Build 8866849029018887600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:29.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9032279090922216896:186:0) after 1m0s
[09:24:54.575] Received PubSub notification, asking Buildbucket for the build status
[09:24:54.641] Build 8866849029018887600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:24:54.641] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1602321894036637",
    "created_by": "project:chromium",
    "created_ts": "1602310835780072",
    "id": "8866849029018887600",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e1886ae31f12f3f25499c01268a3fb867f31fe63\"}}",
    "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\": \"e1886ae31f12f3f25499c01268a3fb867f31fe63\", \"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-8-379q\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 781, \"got_angle_revision\": \"b2ff69f856d98312bbfe14f80d084b7d8795281f\", \"got_dawn_revision\": \"1c25198384e7ecfebbd3ac84203d3b1d46a0e228\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"e1886ae31f12f3f25499c01268a3fb867f31fe63\", \"got_revision_cp\": \"refs/heads/master@{#815920}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"139f5c351e1ff62e465526d4d2f40d3b08a27169\", \"got_v8_revision\": \"07b0b1dcde4a99294b8028d83f4ea244885cc091\", \"got_v8_revision_cp\": \"refs/heads/8.8.62@{#1}\", \"got_webrtc_revision\": \"3326535126e435f1ba647885ce43a8f0f3d317eb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32375}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e1886ae31f12f3f25499c01268a3fb867f31fe63\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-8-379q\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5570-fa4adf0\"], \"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": "1602310962912520",
    "status": "COMPLETED",
    "status_changed_ts": "1602321894343058",
    "tags": [
      "build_address:luci.chromium.ci/win-official/781",
      "builder:win-official",
      "buildset:commit/git/e1886ae31f12f3f25499c01268a3fb867f31fe63",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1886ae31f12f3f25499c01268a3fb867f31fe63",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9032279090922216896",
      "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/8866849029018887600/+/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:4f29fc9a86241410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1602321894357258",
    "url": "https://ci.chromium.org/b/8866849029018887600",
    "utcnow_ts": "1602321894633880"
  }
}
[09:24:54.641] Invocation finished in 3h4m20.05906816s with status SUCCEEDED