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

• d7a58c0bd5338fd047256e606b01f4aa0247cfa1 (4 years ago)
• 3e2f06d1812f16aec58e0853ef346d35c87ac7b4 (4 years ago)
• 4ef4d82b8f8413cb7c52301b4913395316ea099b (4 years ago)
• 39980ed731ff1ad5079d225f320f511538a4046d (4 years ago)
• b68277e87098ab509103c46ad5d51654762ab2a9 (4 years ago)
• 20f0d7747a903c72f89a77f0c436fab41997e2cd (4 years ago)

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

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

[02:43:17.244] New invocation is queued and will start shortly
[02:43:18.330] Starting the invocation (attempt 1)
[02:43:18.360] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:43:18.360] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:43:18.360] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9018884410549109744",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"20f0d7747a903c72f89a77f0c436fab41997e2cd\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9018884410549109744",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/20f0d7747a903c72f89a77f0c436fab41997e2cd",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20f0d7747a903c72f89a77f0c436fab41997e2cd",
    "gitiles_ref:refs/heads/master"
  ]
}
[02:43:20.196] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1615084998505451",
    "id": "8853454348566131376",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"20f0d7747a903c72f89a77f0c436fab41997e2cd\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1615084999508782",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1704",
      "builder:win-official",
      "buildset:commit/git/20f0d7747a903c72f89a77f0c436fab41997e2cd",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20f0d7747a903c72f89a77f0c436fab41997e2cd",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9018884410549109744",
      "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/8853454348566131376/+/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": "1615084999512210",
    "url": "https://ci.chromium.org/b/8853454348566131376",
    "utcnow_ts": "1615085000183587"
  }
}
[02:43:20.196] Task URL: https://ci.chromium.org/b/8853454348566131376
[02:43:20.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:2:0) after 1m0s
[02:43:21.831] Received PubSub notification, asking Buildbucket for the build status
[02:43:21.910] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:20.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:2:0)
[02:44:20.265] Timer tick, asking Buildbucket for the build status
[02:44:20.327] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:20.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:4:0) after 1m0s
[02:45:20.369] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:4:0)
[02:45:20.369] Timer tick, asking Buildbucket for the build status
[02:45:20.646] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:20.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:5:0) after 1m0s
[02:46:20.689] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:5:0)
[02:46:20.689] Timer tick, asking Buildbucket for the build status
[02:46:21.033] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:21.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:6:0) after 1m0s
[02:47:21.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:6:0)
[02:47:21.085] Timer tick, asking Buildbucket for the build status
[02:47:21.151] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:21.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:7:0) after 1m0s
[02:48:21.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:7:0)
[02:48:21.121] Timer tick, asking Buildbucket for the build status
[02:48:21.191] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:21.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:8:0) after 1m0s
[02:49:21.222] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:8:0)
[02:49:21.222] Timer tick, asking Buildbucket for the build status
[02:49:21.298] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:21.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:9:0) after 1m0s
[02:50:21.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:9:0)
[02:50:21.457] Timer tick, asking Buildbucket for the build status
[02:50:21.714] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:21.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:10:0) after 1m0s
[02:51:21.738] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:10:0)
[02:51:21.738] Timer tick, asking Buildbucket for the build status
[02:51:21.810] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:21.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:11:0) after 1m0s
[02:52:21.869] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:11:0)
[02:52:21.869] Timer tick, asking Buildbucket for the build status
[02:52:21.951] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:21.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:12:0) after 1m0s
[02:53:21.951] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:12:0)
[02:53:21.951] Timer tick, asking Buildbucket for the build status
[02:53:22.036] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:22.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:13:0) after 1m0s
[02:54:22.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:13:0)
[02:54:22.124] Timer tick, asking Buildbucket for the build status
[02:54:22.205] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:22.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:14:0) after 1m0s
[02:55:22.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:14:0)
[02:55:22.263] Timer tick, asking Buildbucket for the build status
[02:55:22.362] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:22.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:15:0) after 1m0s
[02:56:22.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:15:0)
[02:56:22.446] Timer tick, asking Buildbucket for the build status
[02:56:22.511] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:22.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:16:0) after 1m0s
[02:57:22.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:16:0)
[02:57:22.583] Timer tick, asking Buildbucket for the build status
[02:57:22.642] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:22.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:17:0) after 1m0s
[02:58:22.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:17:0)
[02:58:22.656] Timer tick, asking Buildbucket for the build status
[02:58:22.747] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:22.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:18:0) after 1m0s
[02:59:22.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:18:0)
[02:59:22.798] Timer tick, asking Buildbucket for the build status
[02:59:22.859] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:22.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:19:0) after 1m0s
[03:00:22.902] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:19:0)
[03:00:22.902] Timer tick, asking Buildbucket for the build status
[03:00:23.103] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:23.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:20:0) after 1m0s
[03:01:23.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:20:0)
[03:01:23.143] Timer tick, asking Buildbucket for the build status
[03:01:23.396] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:23.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:21:0) after 1m0s
[03:02:23.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:21:0)
[03:02:23.413] Timer tick, asking Buildbucket for the build status
[03:02:23.485] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:23.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:22:0) after 1m0s
[03:03:23.581] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:22:0)
[03:03:23.582] Timer tick, asking Buildbucket for the build status
[03:03:23.682] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:23.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:23:0) after 1m0s
[03:04:23.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:23:0)
[03:04:23.763] Timer tick, asking Buildbucket for the build status
[03:04:23.967] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:23.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:24:0) after 1m0s
[03:05:23.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:24:0)
[03:05:23.983] Timer tick, asking Buildbucket for the build status
[03:05:24.052] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:24.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:25:0) after 1m0s
[03:06:24.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:25:0)
[03:06:24.083] Timer tick, asking Buildbucket for the build status
[03:06:24.191] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:24.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:26:0) after 1m0s
[03:07:24.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:26:0)
[03:07:24.229] Timer tick, asking Buildbucket for the build status
[03:07:24.417] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:24.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:27:0) after 1m0s
[03:08:24.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:27:0)
[03:08:24.476] Timer tick, asking Buildbucket for the build status
[03:08:24.603] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:24.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:28:0) after 1m0s
[03:09:24.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:28:0)
[03:09:24.653] Timer tick, asking Buildbucket for the build status
[03:09:24.764] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:24.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:29:0) after 1m0s
[03:10:24.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:29:0)
[03:10:24.844] Timer tick, asking Buildbucket for the build status
[03:10:24.910] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:24.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:30:0) after 1m0s
[03:11:25.027] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:30:0)
[03:11:25.027] Timer tick, asking Buildbucket for the build status
[03:11:25.093] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:25.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:31:0) after 1m0s
[03:12:25.283] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:31:0)
[03:12:25.283] Timer tick, asking Buildbucket for the build status
[03:12:25.359] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:25.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:32:0) after 1m0s
[03:13:25.374] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:32:0)
[03:13:25.374] Timer tick, asking Buildbucket for the build status
[03:13:25.445] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:25.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:33:0) after 1m0s
[03:14:25.471] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:33:0)
[03:14:25.471] Timer tick, asking Buildbucket for the build status
[03:14:25.578] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:25.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:34:0) after 1m0s
[03:15:25.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:34:0)
[03:15:25.596] Timer tick, asking Buildbucket for the build status
[03:15:25.656] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:25.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:35:0) after 1m0s
[03:16:25.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:35:0)
[03:16:25.690] Timer tick, asking Buildbucket for the build status
[03:16:25.758] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:25.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:36:0) after 1m0s
[03:17:25.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:36:0)
[03:17:25.791] Timer tick, asking Buildbucket for the build status
[03:17:25.939] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:25.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:37:0) after 1m0s
[03:18:25.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:37:0)
[03:18:25.957] Timer tick, asking Buildbucket for the build status
[03:18:26.052] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:26.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:38:0) after 1m0s
[03:19:26.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:38:0)
[03:19:26.111] Timer tick, asking Buildbucket for the build status
[03:19:26.316] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:26.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:39:0) after 1m0s
[03:20:26.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:39:0)
[03:20:26.299] Timer tick, asking Buildbucket for the build status
[03:20:26.842] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:26.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:40:0) after 1m0s
[03:21:26.820] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:40:0)
[03:21:26.820] Timer tick, asking Buildbucket for the build status
[03:21:26.893] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:26.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:41:0) after 1m0s
[03:22:26.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:41:0)
[03:22:26.909] Timer tick, asking Buildbucket for the build status
[03:22:27.111] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:27.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:42:0) after 1m0s
[03:23:27.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:42:0)
[03:23:27.095] Timer tick, asking Buildbucket for the build status
[03:23:27.251] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:27.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:43:0) after 1m0s
[03:24:27.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:43:0)
[03:24:27.266] Timer tick, asking Buildbucket for the build status
[03:24:27.337] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:27.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:44:0) after 1m0s
[03:25:27.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:44:0)
[03:25:27.398] Timer tick, asking Buildbucket for the build status
[03:25:27.609] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:27.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:45:0) after 1m0s
[03:26:27.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:45:0)
[03:26:27.697] Timer tick, asking Buildbucket for the build status
[03:26:27.938] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:27.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:46:0) after 1m0s
[03:27:27.967] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:46:0)
[03:27:27.967] Timer tick, asking Buildbucket for the build status
[03:27:28.111] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:28.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:47:0) after 1m0s
[03:28:28.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:47:0)
[03:28:28.120] Timer tick, asking Buildbucket for the build status
[03:28:28.296] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:28.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:48:0) after 1m0s
[03:29:28.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:48:0)
[03:29:28.354] Timer tick, asking Buildbucket for the build status
[03:29:28.499] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:28.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:49:0) after 1m0s
[03:30:28.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:49:0)
[03:30:28.528] Timer tick, asking Buildbucket for the build status
[03:30:28.692] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:28.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:50:0) after 1m0s
[03:31:28.720] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:50:0)
[03:31:28.720] Timer tick, asking Buildbucket for the build status
[03:31:28.781] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:28.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:51:0) after 1m0s
[03:32:28.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:51:0)
[03:32:28.797] Timer tick, asking Buildbucket for the build status
[03:32:28.863] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:28.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:52:0) after 1m0s
[03:33:28.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:52:0)
[03:33:28.881] Timer tick, asking Buildbucket for the build status
[03:33:29.130] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:29.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:53:0) after 1m0s
[03:34:29.205] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:53:0)
[03:34:29.205] Timer tick, asking Buildbucket for the build status
[03:34:29.337] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:29.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:54:0) after 1m0s
[03:35:29.385] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:54:0)
[03:35:29.385] Timer tick, asking Buildbucket for the build status
[03:35:29.464] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:29.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:55:0) after 1m0s
[03:36:29.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:55:0)
[03:36:29.434] Timer tick, asking Buildbucket for the build status
[03:36:29.501] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:29.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:56:0) after 1m0s
[03:37:29.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:56:0)
[03:37:29.595] Timer tick, asking Buildbucket for the build status
[03:37:29.660] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:29.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:57:0) after 1m0s
[03:38:29.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:57:0)
[03:38:29.679] Timer tick, asking Buildbucket for the build status
[03:38:29.828] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:29.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:58:0) after 1m0s
[03:39:29.894] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:58:0)
[03:39:29.894] Timer tick, asking Buildbucket for the build status
[03:39:29.966] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:29.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:59:0) after 1m0s
[03:40:29.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:59:0)
[03:40:29.957] Timer tick, asking Buildbucket for the build status
[03:40:30.124] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:30.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:60:0) after 1m0s
[03:41:30.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:60:0)
[03:41:30.512] Timer tick, asking Buildbucket for the build status
[03:41:30.926] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:30.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:61:0) after 1m0s
[03:42:30.919] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:61:0)
[03:42:30.919] Timer tick, asking Buildbucket for the build status
[03:42:31.031] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:31.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:62:0) after 1m0s
[03:43:31.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:62:0)
[03:43:31.047] Timer tick, asking Buildbucket for the build status
[03:43:31.160] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:31.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:63:0) after 1m0s
[03:44:31.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:63:0)
[03:44:31.255] Timer tick, asking Buildbucket for the build status
[03:44:31.357] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:31.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:64:0) after 1m0s
[03:45:31.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:64:0)
[03:45:31.414] Timer tick, asking Buildbucket for the build status
[03:45:31.625] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:31.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:65:0) after 1m0s
[03:46:31.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:65:0)
[03:46:31.649] Timer tick, asking Buildbucket for the build status
[03:46:33.703] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:33.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:66:0) after 1m0s
[03:47:34.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:66:0)
[03:47:34.131] Timer tick, asking Buildbucket for the build status
[03:47:34.208] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:34.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:67:0) after 1m0s
[03:48:34.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:67:0)
[03:48:34.574] Timer tick, asking Buildbucket for the build status
[03:48:34.899] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:34.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:68:0) after 1m0s
[03:49:35.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:68:0)
[03:49:35.022] Timer tick, asking Buildbucket for the build status
[03:49:35.327] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:35.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:69:0) after 1m0s
[03:50:35.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:69:0)
[03:50:35.472] Timer tick, asking Buildbucket for the build status
[03:50:35.539] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:35.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:70:0) after 1m0s
[03:51:35.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:70:0)
[03:51:35.722] Timer tick, asking Buildbucket for the build status
[03:51:35.804] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:35.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:71:0) after 1m0s
[03:52:35.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:71:0)
[03:52:35.777] Timer tick, asking Buildbucket for the build status
[03:52:35.841] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:35.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:72:0) after 1m0s
[03:53:35.844] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:72:0)
[03:53:35.844] Timer tick, asking Buildbucket for the build status
[03:53:36.099] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:36.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:73:0) after 1m0s
[03:54:36.153] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:73:0)
[03:54:36.153] Timer tick, asking Buildbucket for the build status
[03:54:36.223] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:36.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:74:0) after 1m0s
[03:55:36.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:74:0)
[03:55:36.395] Timer tick, asking Buildbucket for the build status
[03:55:36.659] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:36.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:75:0) after 1m0s
[03:56:36.790] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:75:0)
[03:56:36.790] Timer tick, asking Buildbucket for the build status
[03:56:36.957] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:36.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:76:0) after 1m0s
[03:57:37.015] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:76:0)
[03:57:37.015] Timer tick, asking Buildbucket for the build status
[03:57:40.747] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:40.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:77:0) after 1m0s
[03:58:44.357] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:77:0)
[03:58:44.357] Timer tick, asking Buildbucket for the build status
[03:58:44.601] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:44.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:78:0) after 1m0s
[03:59:44.659] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:78:0)
[03:59:44.659] Timer tick, asking Buildbucket for the build status
[03:59:44.747] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:44.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:79:0) after 1m0s
[04:00:44.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:79:0)
[04:00:44.798] Timer tick, asking Buildbucket for the build status
[04:00:44.928] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:44.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:80:0) after 1m0s
[04:01:44.970] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:80:0)
[04:01:44.971] Timer tick, asking Buildbucket for the build status
[04:01:45.145] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:45.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:81:0) after 1m0s
[04:02:45.194] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:81:0)
[04:02:45.194] Timer tick, asking Buildbucket for the build status
[04:02:45.430] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:45.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:82:0) after 1m0s
[04:03:45.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:82:0)
[04:03:45.517] Timer tick, asking Buildbucket for the build status
[04:03:45.641] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:45.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:83:0) after 1m0s
[04:04:45.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:83:0)
[04:04:45.699] Timer tick, asking Buildbucket for the build status
[04:04:45.807] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:45.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:84:0) after 1m0s
[04:05:45.823] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:84:0)
[04:05:45.823] Timer tick, asking Buildbucket for the build status
[04:05:45.942] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:45.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:85:0) after 1m0s
[04:06:45.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:85:0)
[04:06:45.995] Timer tick, asking Buildbucket for the build status
[04:06:46.198] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:46.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:86:0) after 1m0s
[04:07:46.219] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:86:0)
[04:07:46.219] Timer tick, asking Buildbucket for the build status
[04:07:46.443] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:46.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:87:0) after 1m0s
[04:08:46.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:87:0)
[04:08:46.463] Timer tick, asking Buildbucket for the build status
[04:08:46.548] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:46.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:88:0) after 1m0s
[04:09:46.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:88:0)
[04:09:46.603] Timer tick, asking Buildbucket for the build status
[04:09:46.677] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:46.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:89:0) after 1m0s
[04:10:46.766] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:89:0)
[04:10:46.766] Timer tick, asking Buildbucket for the build status
[04:10:47.118] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:47.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:90:0) after 1m0s
[04:11:47.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:90:0)
[04:11:47.444] Timer tick, asking Buildbucket for the build status
[04:11:47.632] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:47.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:91:0) after 1m0s
[04:12:47.626] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:91:0)
[04:12:47.626] Timer tick, asking Buildbucket for the build status
[04:12:47.838] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:47.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:92:0) after 1m0s
[04:13:47.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:92:0)
[04:13:47.860] Timer tick, asking Buildbucket for the build status
[04:13:47.933] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:47.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:93:0) after 1m0s
[04:14:47.953] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:93:0)
[04:14:47.953] Timer tick, asking Buildbucket for the build status
[04:14:48.123] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:48.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:94:0) after 1m0s
[04:15:48.146] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:94:0)
[04:15:48.146] Timer tick, asking Buildbucket for the build status
[04:15:48.407] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:48.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:95:0) after 1m0s
[04:16:48.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:95:0)
[04:16:48.445] Timer tick, asking Buildbucket for the build status
[04:16:48.512] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:48.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:96:0) after 1m0s
[04:17:48.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:96:0)
[04:17:48.531] Timer tick, asking Buildbucket for the build status
[04:17:48.597] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:48.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:97:0) after 1m0s
[04:18:48.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:97:0)
[04:18:48.634] Timer tick, asking Buildbucket for the build status
[04:18:48.755] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:48.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:98:0) after 1m0s
[04:19:48.773] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:98:0)
[04:19:48.773] Timer tick, asking Buildbucket for the build status
[04:19:48.844] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:48.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:99:0) after 1m0s
[04:20:48.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:99:0)
[04:20:48.866] Timer tick, asking Buildbucket for the build status
[04:20:48.943] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:48.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:100:0) after 1m0s
[04:21:48.918] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:100:0)
[04:21:48.918] Timer tick, asking Buildbucket for the build status
[04:21:49.016] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:49.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:101:0) after 1m0s
[04:22:49.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:101:0)
[04:22:49.038] Timer tick, asking Buildbucket for the build status
[04:22:49.108] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:49.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:102:0) after 1m0s
[04:23:49.142] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:102:0)
[04:23:49.142] Timer tick, asking Buildbucket for the build status
[04:23:49.326] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:49.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:103:0) after 1m0s
[04:24:49.387] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:103:0)
[04:24:49.387] Timer tick, asking Buildbucket for the build status
[04:24:49.752] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:49.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:104:0) after 1m0s
[04:25:49.854] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:104:0)
[04:25:49.854] Timer tick, asking Buildbucket for the build status
[04:25:49.923] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:49.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:105:0) after 1m0s
[04:26:50.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:105:0)
[04:26:50.003] Timer tick, asking Buildbucket for the build status
[04:26:50.079] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:50.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:106:0) after 1m0s
[04:27:50.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:106:0)
[04:27:50.184] Timer tick, asking Buildbucket for the build status
[04:27:50.357] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:50.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:107:0) after 1m0s
[04:28:50.434] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:107:0)
[04:28:50.434] Timer tick, asking Buildbucket for the build status
[04:28:50.543] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:50.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:108:0) after 1m0s
[04:29:50.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:108:0)
[04:29:50.591] Timer tick, asking Buildbucket for the build status
[04:29:50.719] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:50.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:109:0) after 1m0s
[04:30:50.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:109:0)
[04:30:50.744] Timer tick, asking Buildbucket for the build status
[04:30:50.859] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:50.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:110:0) after 1m0s
[04:31:50.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:110:0)
[04:31:50.916] Timer tick, asking Buildbucket for the build status
[04:31:51.118] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:51.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:111:0) after 1m0s
[04:32:51.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:111:0)
[04:32:51.137] Timer tick, asking Buildbucket for the build status
[04:32:51.309] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:51.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:112:0) after 1m0s
[04:33:51.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:112:0)
[04:33:51.329] Timer tick, asking Buildbucket for the build status
[04:33:51.530] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:51.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:113:0) after 1m0s
[04:34:51.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:113:0)
[04:34:51.554] Timer tick, asking Buildbucket for the build status
[04:34:51.640] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:51.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:114:0) after 1m0s
[04:35:51.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:114:0)
[04:35:51.676] Timer tick, asking Buildbucket for the build status
[04:35:51.747] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:51.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:115:0) after 1m0s
[04:36:51.769] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:115:0)
[04:36:51.769] Timer tick, asking Buildbucket for the build status
[04:36:51.926] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:51.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:116:0) after 1m0s
[04:37:51.991] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:116:0)
[04:37:51.991] Timer tick, asking Buildbucket for the build status
[04:37:52.140] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:52.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:117:0) after 1m0s
[04:38:52.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:117:0)
[04:38:52.162] Timer tick, asking Buildbucket for the build status
[04:38:52.236] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:52.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:118:0) after 1m0s
[04:39:52.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:118:0)
[04:39:52.278] Timer tick, asking Buildbucket for the build status
[04:39:52.503] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:52.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:119:0) after 1m0s
[04:40:52.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:119:0)
[04:40:52.526] Timer tick, asking Buildbucket for the build status
[04:40:52.585] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:52.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:120:0) after 1m0s
[04:41:52.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:120:0)
[04:41:52.615] Timer tick, asking Buildbucket for the build status
[04:41:52.691] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:52.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:121:0) after 1m0s
[04:42:52.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:121:0)
[04:42:52.740] Timer tick, asking Buildbucket for the build status
[04:42:52.815] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:52.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:122:0) after 1m0s
[04:43:52.847] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:122:0)
[04:43:52.847] Timer tick, asking Buildbucket for the build status
[04:43:52.922] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:52.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:123:0) after 1m0s
[04:44:53.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:123:0)
[04:44:53.240] Timer tick, asking Buildbucket for the build status
[04:44:53.305] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:53.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:124:0) after 1m0s
[04:45:53.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:124:0)
[04:45:53.372] Timer tick, asking Buildbucket for the build status
[04:45:53.488] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:53.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:125:0) after 1m0s
[04:46:53.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:125:0)
[04:46:53.562] Timer tick, asking Buildbucket for the build status
[04:46:53.629] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:53.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:126:0) after 1m0s
[04:47:53.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:126:0)
[04:47:53.700] Timer tick, asking Buildbucket for the build status
[04:47:53.768] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:53.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:127:0) after 1m0s
[04:48:53.894] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:127:0)
[04:48:53.894] Timer tick, asking Buildbucket for the build status
[04:48:53.996] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:53.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:128:0) after 1m0s
[04:49:54.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:128:0)
[04:49:54.017] Timer tick, asking Buildbucket for the build status
[04:49:54.085] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:54.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:129:0) after 1m0s
[04:50:54.118] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:129:0)
[04:50:54.118] Timer tick, asking Buildbucket for the build status
[04:50:54.304] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:54.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:130:0) after 1m0s
[04:51:54.409] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:130:0)
[04:51:54.409] Timer tick, asking Buildbucket for the build status
[04:51:54.688] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:54.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:131:0) after 1m0s
[04:52:54.720] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:131:0)
[04:52:54.720] Timer tick, asking Buildbucket for the build status
[04:52:55.032] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:55.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:132:0) after 1m0s
[04:53:55.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:132:0)
[04:53:55.054] Timer tick, asking Buildbucket for the build status
[04:53:55.265] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:55.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:133:0) after 1m0s
[04:54:55.284] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:133:0)
[04:54:55.284] Timer tick, asking Buildbucket for the build status
[04:54:55.527] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:55.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:134:0) after 1m0s
[04:55:55.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:134:0)
[04:55:55.573] Timer tick, asking Buildbucket for the build status
[04:55:55.798] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:55.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:135:0) after 1m0s
[04:56:55.820] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:135:0)
[04:56:55.820] Timer tick, asking Buildbucket for the build status
[04:56:56.101] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:56.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:136:0) after 1m0s
[04:57:56.174] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:136:0)
[04:57:56.174] Timer tick, asking Buildbucket for the build status
[04:57:56.240] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:56.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:137:0) after 1m0s
[04:58:56.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:137:0)
[04:58:56.287] Timer tick, asking Buildbucket for the build status
[04:58:56.382] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:56.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:138:0) after 1m0s
[04:59:56.421] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:138:0)
[04:59:56.421] Timer tick, asking Buildbucket for the build status
[04:59:56.504] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:56.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:139:0) after 1m0s
[05:00:56.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:139:0)
[05:00:56.526] Timer tick, asking Buildbucket for the build status
[05:00:56.613] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:56.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:140:0) after 1m0s
[05:01:56.634] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:140:0)
[05:01:56.634] Timer tick, asking Buildbucket for the build status
[05:01:56.813] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:56.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:141:0) after 1m0s
[05:02:56.838] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:141:0)
[05:02:56.838] Timer tick, asking Buildbucket for the build status
[05:02:56.908] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:56.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:142:0) after 1m0s
[05:03:56.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:142:0)
[05:03:56.935] Timer tick, asking Buildbucket for the build status
[05:03:57.150] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:57.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:143:0) after 1m0s
[05:04:57.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:143:0)
[05:04:57.185] Timer tick, asking Buildbucket for the build status
[05:04:57.247] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:57.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:144:0) after 1m0s
[05:05:57.396] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:144:0)
[05:05:57.396] Timer tick, asking Buildbucket for the build status
[05:05:57.494] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:57.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:145:0) after 1m0s
[05:06:57.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:145:0)
[05:06:57.530] Timer tick, asking Buildbucket for the build status
[05:06:57.632] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:57.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:146:0) after 1m0s
[05:07:57.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:146:0)
[05:07:57.716] Timer tick, asking Buildbucket for the build status
[05:07:57.774] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:57.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:147:0) after 1m0s
[05:08:57.795] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:147:0)
[05:08:57.795] Timer tick, asking Buildbucket for the build status
[05:08:57.869] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:57.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:148:0) after 1m0s
[05:09:57.934] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:148:0)
[05:09:57.934] Timer tick, asking Buildbucket for the build status
[05:09:57.997] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:57.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:149:0) after 1m0s
[05:10:58.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:149:0)
[05:10:58.094] Timer tick, asking Buildbucket for the build status
[05:10:58.156] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:58.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:150:0) after 1m0s
[05:11:58.318] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:150:0)
[05:11:58.318] Timer tick, asking Buildbucket for the build status
[05:11:58.429] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:58.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:151:0) after 1m0s
[05:12:58.533] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:151:0)
[05:12:58.533] Timer tick, asking Buildbucket for the build status
[05:12:58.594] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:58.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:152:0) after 1m0s
[05:13:58.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:152:0)
[05:13:58.740] Timer tick, asking Buildbucket for the build status
[05:13:58.850] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:58.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:153:0) after 1m0s
[05:14:59.024] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:153:0)
[05:14:59.024] Timer tick, asking Buildbucket for the build status
[05:14:59.084] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:59.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:154:0) after 1m0s
[05:15:59.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:154:0)
[05:15:59.216] Timer tick, asking Buildbucket for the build status
[05:15:59.281] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:59.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:155:0) after 1m0s
[05:16:59.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:155:0)
[05:16:59.407] Timer tick, asking Buildbucket for the build status
[05:16:59.459] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:59.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:156:0) after 1m0s
[05:17:59.690] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:156:0)
[05:17:59.690] Timer tick, asking Buildbucket for the build status
[05:17:59.860] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:59.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:157:0) after 1m0s
[05:18:59.918] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:157:0)
[05:18:59.918] Timer tick, asking Buildbucket for the build status
[05:19:00.180] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:00.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:158:0) after 1m0s
[05:20:00.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:158:0)
[05:20:00.223] Timer tick, asking Buildbucket for the build status
[05:20:00.503] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:00.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:159:0) after 1m0s
[05:21:00.532] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:159:0)
[05:21:00.532] Timer tick, asking Buildbucket for the build status
[05:21:00.597] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:00.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:160:0) after 1m0s
[05:22:01.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:160:0)
[05:22:01.224] Timer tick, asking Buildbucket for the build status
[05:22:01.296] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:01.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:161:0) after 1m0s
[05:23:01.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:161:0)
[05:23:01.624] Timer tick, asking Buildbucket for the build status
[05:23:01.755] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:01.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:162:0) after 1m0s
[05:24:01.852] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:162:0)
[05:24:01.852] Timer tick, asking Buildbucket for the build status
[05:24:01.964] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:01.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:163:0) after 1m0s
[05:25:02.058] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:163:0)
[05:25:02.058] Timer tick, asking Buildbucket for the build status
[05:25:02.123] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:02.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:164:0) after 1m0s
[05:26:02.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:164:0)
[05:26:02.275] Timer tick, asking Buildbucket for the build status
[05:26:02.339] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:02.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:165:0) after 1m0s
[05:27:02.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:165:0)
[05:27:02.384] Timer tick, asking Buildbucket for the build status
[05:27:02.619] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:02.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:166:0) after 1m0s
[05:28:02.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:166:0)
[05:28:02.781] Timer tick, asking Buildbucket for the build status
[05:28:03.043] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:03.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:167:0) after 1m0s
[05:29:03.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:167:0)
[05:29:03.162] Timer tick, asking Buildbucket for the build status
[05:29:03.297] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:03.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:168:0) after 1m0s
[05:30:03.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:168:0)
[05:30:03.410] Timer tick, asking Buildbucket for the build status
[05:30:03.725] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:03.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:169:0) after 1m0s
[05:31:03.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:169:0)
[05:31:03.783] Timer tick, asking Buildbucket for the build status
[05:31:03.862] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:03.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:170:0) after 1m0s
[05:32:04.015] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:170:0)
[05:32:04.015] Timer tick, asking Buildbucket for the build status
[05:32:04.096] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:04.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:171:0) after 1m0s
[05:33:04.292] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:171:0)
[05:33:04.292] Timer tick, asking Buildbucket for the build status
[05:33:04.416] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:04.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:172:0) after 1m0s
[05:34:04.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:172:0)
[05:34:04.503] Timer tick, asking Buildbucket for the build status
[05:34:04.667] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:04.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:173:0) after 1m0s
[05:35:04.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:173:0)
[05:35:04.779] Timer tick, asking Buildbucket for the build status
[05:35:04.910] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:04.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:174:0) after 1m0s
[05:36:05.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:174:0)
[05:36:05.002] Timer tick, asking Buildbucket for the build status
[05:36:05.196] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:05.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:175:0) after 1m0s
[05:37:05.249] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:175:0)
[05:37:05.249] Timer tick, asking Buildbucket for the build status
[05:37:05.391] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:05.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:176:0) after 1m0s
[05:38:05.464] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:176:0)
[05:38:05.464] Timer tick, asking Buildbucket for the build status
[05:38:05.543] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:05.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:177:0) after 1m0s
[05:39:05.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:177:0)
[05:39:05.929] Timer tick, asking Buildbucket for the build status
[05:39:06.426] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:06.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:178:0) after 1m0s
[05:40:06.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:178:0)
[05:40:06.573] Timer tick, asking Buildbucket for the build status
[05:40:06.674] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:06.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:179:0) after 1m0s
[05:41:06.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:179:0)
[05:41:06.717] Timer tick, asking Buildbucket for the build status
[05:41:06.774] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:06.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:180:0) after 1m0s
[05:42:06.990] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:180:0)
[05:42:06.990] Timer tick, asking Buildbucket for the build status
[05:42:07.053] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:07.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:181:0) after 1m0s
[05:43:07.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:181:0)
[05:43:07.398] Timer tick, asking Buildbucket for the build status
[05:43:07.547] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:07.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:182:0) after 1m0s
[05:44:07.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:182:0)
[05:44:07.622] Timer tick, asking Buildbucket for the build status
[05:44:07.692] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:07.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:183:0) after 1m0s
[05:45:07.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:183:0)
[05:45:07.815] Timer tick, asking Buildbucket for the build status
[05:45:07.884] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:07.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:184:0) after 1m0s
[05:46:07.953] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:184:0)
[05:46:07.953] Timer tick, asking Buildbucket for the build status
[05:46:08.010] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:08.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:185:0) after 1m0s
[05:47:08.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:185:0)
[05:47:08.172] Timer tick, asking Buildbucket for the build status
[05:47:08.237] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:08.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:186:0) after 1m0s
[05:48:08.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:186:0)
[05:48:08.458] Timer tick, asking Buildbucket for the build status
[05:48:08.567] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:08.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:187:0) after 1m0s
[05:49:08.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:187:0)
[05:49:08.777] Timer tick, asking Buildbucket for the build status
[05:49:08.856] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:08.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:188:0) after 1m0s
[05:50:09.020] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:188:0)
[05:50:09.020] Timer tick, asking Buildbucket for the build status
[05:50:09.088] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:09.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:189:0) after 1m0s
[05:51:09.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:189:0)
[05:51:09.108] Timer tick, asking Buildbucket for the build status
[05:51:09.256] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:09.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:190:0) after 1m0s
[05:52:09.813] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:190:0)
[05:52:09.813] Timer tick, asking Buildbucket for the build status
[05:52:09.873] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:09.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:191:0) after 1m0s
[05:53:10.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:191:0)
[05:53:10.062] Timer tick, asking Buildbucket for the build status
[05:53:10.129] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:10.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:192:0) after 1m0s
[05:54:10.174] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:192:0)
[05:54:10.174] Timer tick, asking Buildbucket for the build status
[05:54:10.253] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:10.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:193:0) after 1m0s
[05:55:10.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:193:0)
[05:55:10.299] Timer tick, asking Buildbucket for the build status
[05:55:10.384] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:10.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:194:0) after 1m0s
[05:56:10.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:194:0)
[05:56:10.406] Timer tick, asking Buildbucket for the build status
[05:56:10.533] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:10.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:195:0) after 1m0s
[05:57:11.068] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:195:0)
[05:57:11.068] Timer tick, asking Buildbucket for the build status
[05:57:11.224] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:11.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:196:0) after 1m0s
[05:58:11.297] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:196:0)
[05:58:11.297] Timer tick, asking Buildbucket for the build status
[05:58:11.358] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:11.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:197:0) after 1m0s
[05:59:11.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:197:0)
[05:59:11.439] Timer tick, asking Buildbucket for the build status
[05:59:11.515] Build 8853454348566131376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:11.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018884410549109744:198:0) after 1m0s
[05:59:22.156] Received PubSub notification, asking Buildbucket for the build status
[05:59:22.265] Build 8853454348566131376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:59:22.265] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1615096761309456",
    "created_by": "project:chromium",
    "created_ts": "1615084998505451",
    "id": "8853454348566131376",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"20f0d7747a903c72f89a77f0c436fab41997e2cd\"}}",
    "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\": \"20f0d7747a903c72f89a77f0c436fab41997e2cd\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-2-bv67\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1704, \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"20f0d7747a903c72f89a77f0c436fab41997e2cd\", \"got_revision_cp\": \"refs/heads/master@{#860569}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"f8b883fbba96b155409eb00da93826216bea9fc0\", \"got_v8_revision_cp\": \"refs/heads/9.1.60@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"20f0d7747a903c72f89a77f0c436fab41997e2cd\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_1daffed6dde8d2010ab2a7aee555237ff999d968966bfcf42bbce4ac98bb7a23_v2\", \"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-2-bv67\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1615085001303037",
    "status": "COMPLETED",
    "status_changed_ts": "1615096761551137",
    "tags": [
      "build_address:luci.chromium.ci/win-official/1704",
      "builder:win-official",
      "buildset:commit/git/20f0d7747a903c72f89a77f0c436fab41997e2cd",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20f0d7747a903c72f89a77f0c436fab41997e2cd",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9018884410549109744",
      "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/8853454348566131376/+/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:522362ddde6c5010",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1615096761556816",
    "url": "https://ci.chromium.org/b/8853454348566131376",
    "utcnow_ts": "1615096762255517"
  }
}
[05:59:22.265] Invocation finished in 3h16m5.03523881s with status SUCCEEDED