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

• e9bf2a700b2ff0378d842ac3636464eaf4308243 (4 years ago)
• 928157072cb3bc2c20bf2d90d124737a31ae6be0 (4 years ago)
• 816be761336a6895c06b78e5285eae33a0dbe141 (4 years ago)
• 0e9b54ea59a35bc2c79a30ad095e82f62f61a36b (4 years ago)
• 56f6926a7e6b17dc9f53e983a201b2e9ae214c72 (4 years ago)

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

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

[00:47:28.185] New invocation is queued and will start shortly
[00:47:29.316] Starting the invocation (attempt 1)
[00:47:29.351] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:47:29.353] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:47:29.353] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9020703636510061936",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"56f6926a7e6b17dc9f53e983a201b2e9ae214c72\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9020703636510061936",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/56f6926a7e6b17dc9f53e983a201b2e9ae214c72",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56f6926a7e6b17dc9f53e983a201b2e9ae214c72",
    "gitiles_ref:refs/heads/master"
  ]
}
[00:47:30.887] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1613350049455655",
    "id": "8855273574501194192",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56f6926a7e6b17dc9f53e983a201b2e9ae214c72\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1613350050696353",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1600",
      "builder:win-official",
      "buildset:commit/git/56f6926a7e6b17dc9f53e983a201b2e9ae214c72",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56f6926a7e6b17dc9f53e983a201b2e9ae214c72",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020703636510061936",
      "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/8855273574501194192/+/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": "1613350050696457",
    "url": "https://ci.chromium.org/b/8855273574501194192",
    "utcnow_ts": "1613350050849522"
  }
}
[00:47:30.887] Task URL: https://ci.chromium.org/b/8855273574501194192
[00:47:30.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:2:0) after 1m0s
[00:48:30.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:2:0)
[00:48:30.909] Timer tick, asking Buildbucket for the build status
[00:48:31.114] Build 8855273574501194192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:31.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:3:0) after 1m0s
[00:49:21.228] Received PubSub notification, asking Buildbucket for the build status
[00:49:21.383] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:31.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:3:0)
[00:49:31.196] Timer tick, asking Buildbucket for the build status
[00:49:31.274] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:31.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:5:0) after 1m0s
[00:50:31.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:5:0)
[00:50:31.324] Timer tick, asking Buildbucket for the build status
[00:50:31.406] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:31.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:6:0) after 1m0s
[00:51:31.465] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:6:0)
[00:51:31.465] Timer tick, asking Buildbucket for the build status
[00:51:31.536] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:31.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:7:0) after 1m0s
[00:52:31.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:7:0)
[00:52:31.595] Timer tick, asking Buildbucket for the build status
[00:52:31.667] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:31.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:8:0) after 1m0s
[00:53:31.708] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:8:0)
[00:53:31.708] Timer tick, asking Buildbucket for the build status
[00:53:31.827] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:31.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:9:0) after 1m0s
[00:54:31.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:9:0)
[00:54:31.941] Timer tick, asking Buildbucket for the build status
[00:54:32.013] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:32.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:10:0) after 1m0s
[00:55:32.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:10:0)
[00:55:32.089] Timer tick, asking Buildbucket for the build status
[00:55:32.169] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:32.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:11:0) after 1m0s
[00:56:32.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:11:0)
[00:56:32.184] Timer tick, asking Buildbucket for the build status
[00:56:32.507] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:32.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:12:0) after 1m0s
[00:57:32.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:12:0)
[00:57:32.534] Timer tick, asking Buildbucket for the build status
[00:57:32.623] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:32.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:13:0) after 1m0s
[00:58:32.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:13:0)
[00:58:32.639] Timer tick, asking Buildbucket for the build status
[00:58:32.715] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:32.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:14:0) after 1m0s
[00:59:32.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:14:0)
[00:59:32.777] Timer tick, asking Buildbucket for the build status
[00:59:32.991] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:32.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:15:0) after 1m0s
[01:00:38.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:15:0)
[01:00:38.114] Timer tick, asking Buildbucket for the build status
[01:00:38.217] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:38.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:16:0) after 1m0s
[01:01:38.250] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:16:0)
[01:01:38.250] Timer tick, asking Buildbucket for the build status
[01:01:38.556] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:38.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:17:0) after 1m0s
[01:02:38.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:17:0)
[01:02:38.572] Timer tick, asking Buildbucket for the build status
[01:02:38.699] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:38.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:18:0) after 1m0s
[01:03:38.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:18:0)
[01:03:38.777] Timer tick, asking Buildbucket for the build status
[01:03:39.011] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:39.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:19:0) after 1m0s
[01:04:39.051] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:19:0)
[01:04:39.051] Timer tick, asking Buildbucket for the build status
[01:04:39.445] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:39.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:20:0) after 1m0s
[01:05:39.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:20:0)
[01:05:39.475] Timer tick, asking Buildbucket for the build status
[01:05:39.903] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:39.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:21:0) after 1m0s
[01:06:39.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:21:0)
[01:06:39.921] Timer tick, asking Buildbucket for the build status
[01:06:40.051] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:40.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:22:0) after 1m0s
[01:07:40.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:22:0)
[01:07:40.068] Timer tick, asking Buildbucket for the build status
[01:07:41.048] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:41.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:23:0) after 1m0s
[01:08:41.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:23:0)
[01:08:41.172] Timer tick, asking Buildbucket for the build status
[01:08:41.349] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:41.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:24:0) after 1m0s
[01:09:41.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:24:0)
[01:09:41.430] Timer tick, asking Buildbucket for the build status
[01:09:41.511] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:41.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:25:0) after 1m0s
[01:10:41.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:25:0)
[01:10:41.592] Timer tick, asking Buildbucket for the build status
[01:10:41.684] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:41.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:26:0) after 1m0s
[01:11:41.741] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:26:0)
[01:11:41.741] Timer tick, asking Buildbucket for the build status
[01:11:41.833] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:41.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:27:0) after 1m0s
[01:12:41.864] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:27:0)
[01:12:41.864] Timer tick, asking Buildbucket for the build status
[01:12:42.400] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:42.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:28:0) after 1m0s
[01:13:42.509] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:28:0)
[01:13:42.509] Timer tick, asking Buildbucket for the build status
[01:13:42.732] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:42.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:29:0) after 1m0s
[01:14:42.820] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:29:0)
[01:14:42.820] Timer tick, asking Buildbucket for the build status
[01:14:42.888] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:42.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:30:0) after 1m0s
[01:15:42.952] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:30:0)
[01:15:42.952] Timer tick, asking Buildbucket for the build status
[01:15:43.105] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:43.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:31:0) after 1m0s
[01:16:43.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:31:0)
[01:16:43.122] Timer tick, asking Buildbucket for the build status
[01:16:43.248] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:43.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:32:0) after 1m0s
[01:17:43.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:32:0)
[01:17:43.264] Timer tick, asking Buildbucket for the build status
[01:17:43.363] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:43.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:33:0) after 1m0s
[01:18:43.405] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:33:0)
[01:18:43.405] Timer tick, asking Buildbucket for the build status
[01:18:43.728] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:43.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:34:0) after 1m0s
[01:19:43.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:34:0)
[01:19:43.774] Timer tick, asking Buildbucket for the build status
[01:19:43.849] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:43.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:35:0) after 1m0s
[01:20:43.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:35:0)
[01:20:43.882] Timer tick, asking Buildbucket for the build status
[01:20:43.984] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:43.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:36:0) after 1m0s
[01:21:44.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:36:0)
[01:21:44.046] Timer tick, asking Buildbucket for the build status
[01:21:44.122] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:44.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:37:0) after 1m0s
[01:22:44.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:37:0)
[01:22:44.184] Timer tick, asking Buildbucket for the build status
[01:22:44.289] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:44.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:38:0) after 1m0s
[01:23:44.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:38:0)
[01:23:44.358] Timer tick, asking Buildbucket for the build status
[01:23:44.428] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:44.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:39:0) after 1m0s
[01:24:44.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:39:0)
[01:24:44.492] Timer tick, asking Buildbucket for the build status
[01:24:44.816] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:44.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:40:0) after 1m0s
[01:25:44.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:40:0)
[01:25:44.940] Timer tick, asking Buildbucket for the build status
[01:25:45.023] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:45.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:41:0) after 1m0s
[01:26:45.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:41:0)
[01:26:45.078] Timer tick, asking Buildbucket for the build status
[01:26:45.172] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:45.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:42:0) after 1m0s
[01:27:45.198] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:42:0)
[01:27:45.198] Timer tick, asking Buildbucket for the build status
[01:27:45.322] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:45.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:43:0) after 1m0s
[01:28:45.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:43:0)
[01:28:45.357] Timer tick, asking Buildbucket for the build status
[01:28:45.607] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:45.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:44:0) after 1m0s
[01:29:45.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:44:0)
[01:29:45.697] Timer tick, asking Buildbucket for the build status
[01:29:45.804] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:45.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:45:0) after 1m0s
[01:30:45.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:45:0)
[01:30:45.857] Timer tick, asking Buildbucket for the build status
[01:30:45.943] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:45.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:46:0) after 1m0s
[01:31:46.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:46:0)
[01:31:46.086] Timer tick, asking Buildbucket for the build status
[01:31:46.449] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:46.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:47:0) after 1m0s
[01:32:46.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:47:0)
[01:32:46.634] Timer tick, asking Buildbucket for the build status
[01:32:47.023] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:47.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:48:0) after 1m0s
[01:33:47.179] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:48:0)
[01:33:47.179] Timer tick, asking Buildbucket for the build status
[01:33:47.253] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:47.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:49:0) after 1m0s
[01:34:47.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:49:0)
[01:34:47.373] Timer tick, asking Buildbucket for the build status
[01:34:47.457] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:47.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:50:0) after 1m0s
[01:35:47.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:50:0)
[01:35:47.502] Timer tick, asking Buildbucket for the build status
[01:35:47.767] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:47.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:51:0) after 1m0s
[01:36:47.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:51:0)
[01:36:47.811] Timer tick, asking Buildbucket for the build status
[01:36:47.896] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:47.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:52:0) after 1m0s
[01:37:47.994] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:52:0)
[01:37:47.994] Timer tick, asking Buildbucket for the build status
[01:37:48.106] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:48.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:53:0) after 1m0s
[01:38:48.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:53:0)
[01:38:48.268] Timer tick, asking Buildbucket for the build status
[01:38:48.428] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:48.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:54:0) after 1m0s
[01:39:48.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:54:0)
[01:39:48.408] Timer tick, asking Buildbucket for the build status
[01:39:48.503] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:48.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:55:0) after 1m0s
[01:40:48.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:55:0)
[01:40:48.679] Timer tick, asking Buildbucket for the build status
[01:40:48.789] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:48.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:56:0) after 1m0s
[01:41:48.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:56:0)
[01:41:48.834] Timer tick, asking Buildbucket for the build status
[01:41:48.918] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:48.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:57:0) after 1m0s
[01:42:49.027] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:57:0)
[01:42:49.027] Timer tick, asking Buildbucket for the build status
[01:42:49.117] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:49.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:58:0) after 1m0s
[01:43:49.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:58:0)
[01:43:49.259] Timer tick, asking Buildbucket for the build status
[01:43:49.332] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:49.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:59:0) after 1m0s
[01:44:49.424] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:59:0)
[01:44:49.424] Timer tick, asking Buildbucket for the build status
[01:44:49.503] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:49.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:60:0) after 1m0s
[01:45:49.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:60:0)
[01:45:49.645] Timer tick, asking Buildbucket for the build status
[01:45:49.721] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:49.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:61:0) after 1m0s
[01:46:49.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:61:0)
[01:46:49.799] Timer tick, asking Buildbucket for the build status
[01:46:49.868] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:49.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:62:0) after 1m0s
[01:47:49.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:62:0)
[01:47:49.912] Timer tick, asking Buildbucket for the build status
[01:47:50.036] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:50.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:63:0) after 1m0s
[01:48:50.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:63:0)
[01:48:50.094] Timer tick, asking Buildbucket for the build status
[01:48:50.331] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:50.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:64:0) after 1m0s
[01:49:50.391] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:64:0)
[01:49:50.391] Timer tick, asking Buildbucket for the build status
[01:49:50.744] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:50.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:65:0) after 1m0s
[01:50:50.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:65:0)
[01:50:50.844] Timer tick, asking Buildbucket for the build status
[01:50:50.931] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:50.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:66:0) after 1m0s
[01:51:50.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:66:0)
[01:51:50.976] Timer tick, asking Buildbucket for the build status
[01:51:51.076] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:51.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:67:0) after 1m0s
[01:52:51.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:67:0)
[01:52:51.076] Timer tick, asking Buildbucket for the build status
[01:52:51.322] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:51.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:68:0) after 1m0s
[01:53:51.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:68:0)
[01:53:51.382] Timer tick, asking Buildbucket for the build status
[01:53:51.450] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:51.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:69:0) after 1m0s
[01:54:51.508] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:69:0)
[01:54:51.508] Timer tick, asking Buildbucket for the build status
[01:54:51.580] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:51.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:70:0) after 1m0s
[01:55:51.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:70:0)
[01:55:51.631] Timer tick, asking Buildbucket for the build status
[01:55:51.937] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:51.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:71:0) after 1m0s
[01:56:52.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:71:0)
[01:56:52.066] Timer tick, asking Buildbucket for the build status
[01:56:52.145] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:52.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:72:0) after 1m0s
[01:57:52.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:72:0)
[01:57:52.176] Timer tick, asking Buildbucket for the build status
[01:57:52.267] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:52.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:73:0) after 1m0s
[01:58:52.248] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:73:0)
[01:58:52.248] Timer tick, asking Buildbucket for the build status
[01:58:52.339] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:52.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:74:0) after 1m0s
[01:59:52.415] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:74:0)
[01:59:52.415] Timer tick, asking Buildbucket for the build status
[01:59:52.674] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:52.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:75:0) after 1m0s
[02:00:52.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:75:0)
[02:00:52.760] Timer tick, asking Buildbucket for the build status
[02:00:52.843] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:52.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:76:0) after 1m0s
[02:01:52.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:76:0)
[02:01:52.871] Timer tick, asking Buildbucket for the build status
[02:01:53.000] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:53.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:77:0) after 1m0s
[02:02:53.134] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:77:0)
[02:02:53.134] Timer tick, asking Buildbucket for the build status
[02:02:53.258] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:53.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:78:0) after 1m0s
[02:03:53.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:78:0)
[02:03:53.329] Timer tick, asking Buildbucket for the build status
[02:03:53.625] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:53.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:79:0) after 1m0s
[02:04:53.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:79:0)
[02:04:53.616] Timer tick, asking Buildbucket for the build status
[02:04:53.686] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:53.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:80:0) after 1m0s
[02:05:53.786] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:80:0)
[02:05:53.786] Timer tick, asking Buildbucket for the build status
[02:05:53.867] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:53.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:81:0) after 1m0s
[02:06:54.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:81:0)
[02:06:54.457] Timer tick, asking Buildbucket for the build status
[02:06:54.545] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:54.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:82:0) after 1m0s
[02:07:54.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:82:0)
[02:07:54.633] Timer tick, asking Buildbucket for the build status
[02:07:54.726] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:54.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:83:0) after 1m0s
[02:08:54.953] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:83:0)
[02:08:54.953] Timer tick, asking Buildbucket for the build status
[02:08:55.237] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:55.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:84:0) after 1m0s
[02:09:55.335] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:84:0)
[02:09:55.335] Timer tick, asking Buildbucket for the build status
[02:09:55.419] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:55.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:85:0) after 1m0s
[02:10:55.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:85:0)
[02:10:55.499] Timer tick, asking Buildbucket for the build status
[02:10:55.593] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:55.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:86:0) after 1m0s
[02:11:55.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:86:0)
[02:11:55.717] Timer tick, asking Buildbucket for the build status
[02:11:55.794] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:55.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:87:0) after 1m0s
[02:12:55.858] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:87:0)
[02:12:55.858] Timer tick, asking Buildbucket for the build status
[02:12:55.956] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:55.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:88:0) after 1m0s
[02:13:55.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:88:0)
[02:13:55.943] Timer tick, asking Buildbucket for the build status
[02:13:56.300] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:56.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:89:0) after 1m0s
[02:14:56.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:89:0)
[02:14:56.331] Timer tick, asking Buildbucket for the build status
[02:14:56.633] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:56.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:90:0) after 1m0s
[02:15:56.704] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:90:0)
[02:15:56.704] Timer tick, asking Buildbucket for the build status
[02:15:57.137] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:57.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:91:0) after 1m0s
[02:16:57.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:91:0)
[02:16:57.175] Timer tick, asking Buildbucket for the build status
[02:16:57.250] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:57.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:92:0) after 1m0s
[02:17:57.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:92:0)
[02:17:57.312] Timer tick, asking Buildbucket for the build status
[02:17:57.395] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:57.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:93:0) after 1m0s
[02:18:57.602] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:93:0)
[02:18:57.602] Timer tick, asking Buildbucket for the build status
[02:18:57.703] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:57.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:94:0) after 1m0s
[02:19:57.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:94:0)
[02:19:57.746] Timer tick, asking Buildbucket for the build status
[02:19:57.829] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:57.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:95:0) after 1m0s
[02:20:57.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:95:0)
[02:20:57.850] Timer tick, asking Buildbucket for the build status
[02:20:58.240] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:58.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:96:0) after 1m0s
[02:21:58.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:96:0)
[02:21:58.271] Timer tick, asking Buildbucket for the build status
[02:21:58.550] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:58.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:97:0) after 1m0s
[02:22:58.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:97:0)
[02:22:58.577] Timer tick, asking Buildbucket for the build status
[02:22:58.733] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:58.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:98:0) after 1m0s
[02:23:58.848] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:98:0)
[02:23:58.848] Timer tick, asking Buildbucket for the build status
[02:23:58.921] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:58.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:99:0) after 1m0s
[02:24:58.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:99:0)
[02:24:58.996] Timer tick, asking Buildbucket for the build status
[02:24:59.079] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:59.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:100:0) after 1m0s
[02:25:59.104] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:100:0)
[02:25:59.104] Timer tick, asking Buildbucket for the build status
[02:25:59.189] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:59.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:101:0) after 1m0s
[02:26:59.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:101:0)
[02:26:59.293] Timer tick, asking Buildbucket for the build status
[02:26:59.393] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:59.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:102:0) after 1m0s
[02:27:59.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:102:0)
[02:27:59.530] Timer tick, asking Buildbucket for the build status
[02:27:59.616] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:59.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:103:0) after 1m0s
[02:28:59.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:103:0)
[02:28:59.730] Timer tick, asking Buildbucket for the build status
[02:28:59.807] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:59.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:104:0) after 1m0s
[02:29:59.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:104:0)
[02:29:59.881] Timer tick, asking Buildbucket for the build status
[02:29:59.974] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:59.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:105:0) after 1m0s
[02:31:00.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:105:0)
[02:31:00.071] Timer tick, asking Buildbucket for the build status
[02:31:00.152] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:00.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:106:0) after 1m0s
[02:32:00.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:106:0)
[02:32:00.187] Timer tick, asking Buildbucket for the build status
[02:32:00.321] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:00.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:107:0) after 1m0s
[02:33:00.300] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:107:0)
[02:33:00.300] Timer tick, asking Buildbucket for the build status
[02:33:00.390] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:00.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:108:0) after 1m0s
[02:34:00.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:108:0)
[02:34:00.580] Timer tick, asking Buildbucket for the build status
[02:34:00.734] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:00.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:109:0) after 1m0s
[02:35:00.833] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:109:0)
[02:35:00.833] Timer tick, asking Buildbucket for the build status
[02:35:00.908] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:00.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:110:0) after 1m0s
[02:36:01.927] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:110:0)
[02:36:01.927] Timer tick, asking Buildbucket for the build status
[02:36:02.049] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:02.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:111:0) after 1m0s
[02:37:02.078] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:111:0)
[02:37:02.078] Timer tick, asking Buildbucket for the build status
[02:37:02.156] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:02.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:112:0) after 1m0s
[02:38:02.276] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:112:0)
[02:38:02.276] Timer tick, asking Buildbucket for the build status
[02:38:02.494] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:02.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:113:0) after 1m0s
[02:39:02.600] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:113:0)
[02:39:02.600] Timer tick, asking Buildbucket for the build status
[02:39:02.815] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:02.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:114:0) after 1m0s
[02:40:02.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:114:0)
[02:40:02.925] Timer tick, asking Buildbucket for the build status
[02:40:03.032] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:03.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:115:0) after 1m0s
[02:41:03.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:115:0)
[02:41:03.139] Timer tick, asking Buildbucket for the build status
[02:41:03.454] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:03.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:116:0) after 1m0s
[02:42:03.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:116:0)
[02:42:03.524] Timer tick, asking Buildbucket for the build status
[02:42:03.616] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:03.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:117:0) after 1m0s
[02:43:03.707] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:117:0)
[02:43:03.707] Timer tick, asking Buildbucket for the build status
[02:43:03.791] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:03.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:118:0) after 1m0s
[02:44:03.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:118:0)
[02:44:03.861] Timer tick, asking Buildbucket for the build status
[02:44:03.978] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:03.979] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:119:0) after 1m0s
[02:45:03.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:119:0)
[02:45:03.997] Timer tick, asking Buildbucket for the build status
[02:45:04.089] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:04.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:120:0) after 1m0s
[02:46:04.150] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:120:0)
[02:46:04.150] Timer tick, asking Buildbucket for the build status
[02:46:04.392] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:04.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:121:0) after 1m0s
[02:47:04.544] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:121:0)
[02:47:04.544] Timer tick, asking Buildbucket for the build status
[02:47:04.700] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:04.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:122:0) after 1m0s
[02:48:04.745] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:122:0)
[02:48:04.745] Timer tick, asking Buildbucket for the build status
[02:48:05.097] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:05.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:123:0) after 1m0s
[02:49:05.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:123:0)
[02:49:05.109] Timer tick, asking Buildbucket for the build status
[02:49:05.180] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:05.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:124:0) after 1m0s
[02:50:05.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:124:0)
[02:50:05.203] Timer tick, asking Buildbucket for the build status
[02:50:05.434] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:05.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:125:0) after 1m0s
[02:51:05.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:125:0)
[02:51:05.501] Timer tick, asking Buildbucket for the build status
[02:51:05.567] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:05.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:126:0) after 1m0s
[02:52:05.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:126:0)
[02:52:05.614] Timer tick, asking Buildbucket for the build status
[02:52:05.750] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:05.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:127:0) after 1m0s
[02:53:05.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:127:0)
[02:53:05.802] Timer tick, asking Buildbucket for the build status
[02:53:05.883] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:05.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:128:0) after 1m0s
[02:54:05.956] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:128:0)
[02:54:05.956] Timer tick, asking Buildbucket for the build status
[02:54:06.026] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:06.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:129:0) after 1m0s
[02:55:06.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:129:0)
[02:55:06.062] Timer tick, asking Buildbucket for the build status
[02:55:06.258] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:06.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:130:0) after 1m0s
[02:56:06.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:130:0)
[02:56:06.340] Timer tick, asking Buildbucket for the build status
[02:56:06.417] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:06.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:131:0) after 1m0s
[02:57:06.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:131:0)
[02:57:06.485] Timer tick, asking Buildbucket for the build status
[02:57:06.793] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:06.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:132:0) after 1m0s
[02:58:06.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:132:0)
[02:58:06.840] Timer tick, asking Buildbucket for the build status
[02:58:06.956] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:06.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:133:0) after 1m0s
[02:59:07.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:133:0)
[02:59:07.392] Timer tick, asking Buildbucket for the build status
[02:59:07.615] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:07.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:134:0) after 1m0s
[03:00:07.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:134:0)
[03:00:07.772] Timer tick, asking Buildbucket for the build status
[03:00:07.856] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:07.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:135:0) after 1m0s
[03:01:07.883] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:135:0)
[03:01:07.883] Timer tick, asking Buildbucket for the build status
[03:01:07.977] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:07.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:136:0) after 1m0s
[03:02:08.020] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:136:0)
[03:02:08.020] Timer tick, asking Buildbucket for the build status
[03:02:08.090] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:08.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:137:0) after 1m0s
[03:03:08.118] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:137:0)
[03:03:08.118] Timer tick, asking Buildbucket for the build status
[03:03:08.290] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:08.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:138:0) after 1m0s
[03:04:08.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:138:0)
[03:04:08.279] Timer tick, asking Buildbucket for the build status
[03:04:08.446] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:08.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:139:0) after 1m0s
[03:05:08.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:139:0)
[03:05:08.495] Timer tick, asking Buildbucket for the build status
[03:05:08.576] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:08.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:140:0) after 1m0s
[03:06:08.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:140:0)
[03:06:08.629] Timer tick, asking Buildbucket for the build status
[03:06:08.703] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:08.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:141:0) after 1m0s
[03:07:08.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:141:0)
[03:07:08.797] Timer tick, asking Buildbucket for the build status
[03:07:08.880] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:08.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:142:0) after 1m0s
[03:08:08.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:142:0)
[03:08:08.989] Timer tick, asking Buildbucket for the build status
[03:08:09.228] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:09.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:143:0) after 1m0s
[03:09:09.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:143:0)
[03:09:09.586] Timer tick, asking Buildbucket for the build status
[03:09:09.752] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:09.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:144:0) after 1m0s
[03:10:09.890] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:144:0)
[03:10:09.890] Timer tick, asking Buildbucket for the build status
[03:10:09.960] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:09.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:145:0) after 1m0s
[03:11:10.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:145:0)
[03:11:10.151] Timer tick, asking Buildbucket for the build status
[03:11:10.627] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:10.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:146:0) after 1m0s
[03:12:10.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:146:0)
[03:12:10.685] Timer tick, asking Buildbucket for the build status
[03:12:10.769] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:10.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:147:0) after 1m0s
[03:13:10.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:147:0)
[03:13:10.871] Timer tick, asking Buildbucket for the build status
[03:13:11.101] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:11.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:148:0) after 1m0s
[03:14:11.200] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:148:0)
[03:14:11.200] Timer tick, asking Buildbucket for the build status
[03:14:11.271] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:11.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:149:0) after 1m0s
[03:15:11.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:149:0)
[03:15:11.275] Timer tick, asking Buildbucket for the build status
[03:15:11.365] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:11.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:150:0) after 1m0s
[03:16:11.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:150:0)
[03:16:11.355] Timer tick, asking Buildbucket for the build status
[03:16:11.646] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:11.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:151:0) after 1m0s
[03:17:11.681] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:151:0)
[03:17:11.681] Timer tick, asking Buildbucket for the build status
[03:17:11.891] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:11.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:152:0) after 1m0s
[03:18:11.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:152:0)
[03:18:11.978] Timer tick, asking Buildbucket for the build status
[03:18:12.074] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:12.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:153:0) after 1m0s
[03:19:12.129] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:153:0)
[03:19:12.129] Timer tick, asking Buildbucket for the build status
[03:19:12.527] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:12.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:154:0) after 1m0s
[03:20:12.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:154:0)
[03:20:12.598] Timer tick, asking Buildbucket for the build status
[03:20:12.744] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:12.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:155:0) after 1m0s
[03:21:12.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:155:0)
[03:21:12.825] Timer tick, asking Buildbucket for the build status
[03:21:12.893] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:12.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:156:0) after 1m0s
[03:22:12.971] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:156:0)
[03:22:12.971] Timer tick, asking Buildbucket for the build status
[03:22:13.244] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:13.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:157:0) after 1m0s
[03:23:13.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:157:0)
[03:23:13.343] Timer tick, asking Buildbucket for the build status
[03:23:13.460] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:13.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:158:0) after 1m0s
[03:24:13.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:158:0)
[03:24:13.497] Timer tick, asking Buildbucket for the build status
[03:24:13.582] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:13.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:159:0) after 1m0s
[03:25:13.565] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:159:0)
[03:25:13.565] Timer tick, asking Buildbucket for the build status
[03:25:13.634] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:13.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:160:0) after 1m0s
[03:26:13.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:160:0)
[03:26:13.763] Timer tick, asking Buildbucket for the build status
[03:26:14.032] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:14.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:161:0) after 1m0s
[03:27:14.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:161:0)
[03:27:14.081] Timer tick, asking Buildbucket for the build status
[03:27:14.350] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:14.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:162:0) after 1m0s
[03:28:14.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:162:0)
[03:28:14.457] Timer tick, asking Buildbucket for the build status
[03:28:14.553] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:14.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:163:0) after 1m0s
[03:29:14.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:163:0)
[03:29:14.592] Timer tick, asking Buildbucket for the build status
[03:29:14.940] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:14.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:164:0) after 1m0s
[03:30:15.018] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:164:0)
[03:30:15.018] Timer tick, asking Buildbucket for the build status
[03:30:15.113] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:15.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:165:0) after 1m0s
[03:31:15.136] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:165:0)
[03:31:15.136] Timer tick, asking Buildbucket for the build status
[03:31:15.207] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:15.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:166:0) after 1m0s
[03:32:15.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:166:0)
[03:32:15.246] Timer tick, asking Buildbucket for the build status
[03:32:15.450] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:15.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:167:0) after 1m0s
[03:33:15.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:167:0)
[03:33:15.512] Timer tick, asking Buildbucket for the build status
[03:33:15.610] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:15.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:168:0) after 1m0s
[03:34:15.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:168:0)
[03:34:15.634] Timer tick, asking Buildbucket for the build status
[03:34:16.021] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:16.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:169:0) after 1m0s
[03:35:16.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:169:0)
[03:35:16.042] Timer tick, asking Buildbucket for the build status
[03:35:16.314] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:16.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:170:0) after 1m0s
[03:36:16.306] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:170:0)
[03:36:16.306] Timer tick, asking Buildbucket for the build status
[03:36:16.512] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:16.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:171:0) after 1m0s
[03:37:16.578] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:171:0)
[03:37:16.578] Timer tick, asking Buildbucket for the build status
[03:37:16.664] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:16.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:172:0) after 1m0s
[03:38:16.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:172:0)
[03:38:16.677] Timer tick, asking Buildbucket for the build status
[03:38:16.779] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:16.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:173:0) after 1m0s
[03:39:16.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:173:0)
[03:39:16.779] Timer tick, asking Buildbucket for the build status
[03:39:16.861] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:16.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:174:0) after 1m0s
[03:40:16.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:174:0)
[03:40:16.914] Timer tick, asking Buildbucket for the build status
[03:40:16.982] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:16.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:175:0) after 1m0s
[03:41:17.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:175:0)
[03:41:17.012] Timer tick, asking Buildbucket for the build status
[03:41:17.082] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:17.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:176:0) after 1m0s
[03:42:17.114] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:176:0)
[03:42:17.114] Timer tick, asking Buildbucket for the build status
[03:42:17.189] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:17.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:177:0) after 1m0s
[03:43:17.215] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:177:0)
[03:43:17.215] Timer tick, asking Buildbucket for the build status
[03:43:17.345] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:17.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:178:0) after 1m0s
[03:44:17.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:178:0)
[03:44:17.503] Timer tick, asking Buildbucket for the build status
[03:44:17.604] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:17.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:179:0) after 1m0s
[03:45:17.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:179:0)
[03:45:17.720] Timer tick, asking Buildbucket for the build status
[03:45:17.847] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:17.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:180:0) after 1m0s
[03:46:18.327] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:180:0)
[03:46:18.327] Timer tick, asking Buildbucket for the build status
[03:46:18.453] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:18.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:181:0) after 1m0s
[03:47:18.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:181:0)
[03:47:18.463] Timer tick, asking Buildbucket for the build status
[03:47:18.731] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:18.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:182:0) after 1m0s
[03:48:18.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:182:0)
[03:48:18.856] Timer tick, asking Buildbucket for the build status
[03:48:19.011] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:19.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:183:0) after 1m0s
[03:49:19.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:183:0)
[03:49:19.098] Timer tick, asking Buildbucket for the build status
[03:49:19.252] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:19.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:184:0) after 1m0s
[03:50:19.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:184:0)
[03:50:19.312] Timer tick, asking Buildbucket for the build status
[03:50:19.378] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:19.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:185:0) after 1m0s
[03:51:22.927] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:185:0)
[03:51:22.927] Timer tick, asking Buildbucket for the build status
[03:51:22.995] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:22.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:186:0) after 1m0s
[03:52:23.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:186:0)
[03:52:23.082] Timer tick, asking Buildbucket for the build status
[03:52:23.157] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:23.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:187:0) after 1m0s
[03:53:23.181] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:187:0)
[03:53:23.181] Timer tick, asking Buildbucket for the build status
[03:53:23.603] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:23.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:188:0) after 1m0s
[03:54:23.726] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:188:0)
[03:54:23.726] Timer tick, asking Buildbucket for the build status
[03:54:24.163] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:24.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:189:0) after 1m0s
[03:55:24.231] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:189:0)
[03:55:24.231] Timer tick, asking Buildbucket for the build status
[03:55:24.614] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:24.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:190:0) after 1m0s
[03:56:24.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:190:0)
[03:56:24.680] Timer tick, asking Buildbucket for the build status
[03:56:24.754] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:24.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:191:0) after 1m0s
[03:57:24.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:191:0)
[03:57:24.831] Timer tick, asking Buildbucket for the build status
[03:57:25.074] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:25.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:192:0) after 1m0s
[03:58:25.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:192:0)
[03:58:25.152] Timer tick, asking Buildbucket for the build status
[03:58:25.241] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:25.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:193:0) after 1m0s
[03:59:25.305] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:193:0)
[03:59:25.305] Timer tick, asking Buildbucket for the build status
[03:59:25.386] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:25.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:194:0) after 1m0s
[04:00:25.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:194:0)
[04:00:25.502] Timer tick, asking Buildbucket for the build status
[04:00:25.581] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:25.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:195:0) after 1m0s
[04:01:25.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:195:0)
[04:01:25.670] Timer tick, asking Buildbucket for the build status
[04:01:25.812] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:25.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:196:0) after 1m0s
[04:02:25.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:196:0)
[04:02:25.951] Timer tick, asking Buildbucket for the build status
[04:02:26.042] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:26.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:197:0) after 1m0s
[04:03:26.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:197:0)
[04:03:26.053] Timer tick, asking Buildbucket for the build status
[04:03:26.299] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:26.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:198:0) after 1m0s
[04:04:26.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:198:0)
[04:04:26.323] Timer tick, asking Buildbucket for the build status
[04:04:26.419] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:26.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:199:0) after 1m0s
[04:05:26.496] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:199:0)
[04:05:26.496] Timer tick, asking Buildbucket for the build status
[04:05:26.826] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:26.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:200:0) after 1m0s
[04:06:26.905] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:200:0)
[04:06:26.905] Timer tick, asking Buildbucket for the build status
[04:06:27.211] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:27.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:201:0) after 1m0s
[04:07:27.225] Handling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:201:0)
[04:07:27.225] Timer tick, asking Buildbucket for the build status
[04:07:27.300] Build 8855273574501194192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:27.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9020703636510061936:202:0) after 1m0s
[04:07:37.046] Received PubSub notification, asking Buildbucket for the build status
[04:07:37.120] Build 8855273574501194192: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:07:37.120] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1613362056064865",
    "created_by": "project:chromium",
    "created_ts": "1613350049455655",
    "id": "8855273574501194192",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56f6926a7e6b17dc9f53e983a201b2e9ae214c72\"}}",
    "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\": \"56f6926a7e6b17dc9f53e983a201b2e9ae214c72\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-4-9ws1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1600, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"56f6926a7e6b17dc9f53e983a201b2e9ae214c72\", \"got_revision_cp\": \"refs/heads/master@{#853927}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"554b7ee535b3eca3f041dc45d00de5cbd490729c\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56f6926a7e6b17dc9f53e983a201b2e9ae214c72\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"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-4-9ws1\"], \"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\": [\"5690-40331dd\"], \"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": "1613350160342217",
    "status": "COMPLETED",
    "status_changed_ts": "1613362056781538",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1600",
      "builder:win-official",
      "buildset:commit/git/56f6926a7e6b17dc9f53e983a201b2e9ae214c72",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56f6926a7e6b17dc9f53e983a201b2e9ae214c72",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020703636510061936",
      "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/8855273574501194192/+/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:51bbf9a4d2992b10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1613362056786539",
    "url": "https://ci.chromium.org/b/8855273574501194192",
    "utcnow_ts": "1613362057113013"
  }
}
[04:07:37.121] Invocation finished in 3h20m8.966095023s with status SUCCEEDED