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

Definition (rev 78c0d5df70183bb8def771b10cda93cb5e976ee8)

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

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[08:39:14.422] New invocation is queued and will start shortly
[08:39:21.730] Starting the invocation (attempt 1)
[08:39:21.766] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:39:21.766] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:39:21.766] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9039518124268511824",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3026c265f66d8f1d301173552c026711fc2f939d\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9039518124268511824",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/3026c265f66d8f1d301173552c026711fc2f939d",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3026c265f66d8f1d301173552c026711fc2f939d",
    "gitiles_ref:refs/heads/master"
  ]
}
[08:39:23.112] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1595407161894471",
    "id": "8874088055768109584",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3026c265f66d8f1d301173552c026711fc2f939d\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1595407162862924",
    "tags": [
      "build_address:luci.chromium.ci/win-official/145",
      "builder:win-official",
      "buildset:commit/git/3026c265f66d8f1d301173552c026711fc2f939d",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3026c265f66d8f1d301173552c026711fc2f939d",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9039518124268511824",
      "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/8874088055768109584/+/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": "1595407162863050",
    "url": "https://ci.chromium.org/b/8874088055768109584",
    "utcnow_ts": "1595407163101166"
  }
}
[08:39:23.112] Task URL: https://ci.chromium.org/b/8874088055768109584
[08:39:23.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:2:0) after 1m0s
[08:39:28.286] Received PubSub notification, asking Buildbucket for the build status
[08:39:28.377] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:23.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:2:0)
[08:40:23.217] Timer tick, asking Buildbucket for the build status
[08:40:23.518] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:23.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:4:0) after 1m0s
[08:41:23.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:4:0)
[08:41:23.550] Timer tick, asking Buildbucket for the build status
[08:41:23.696] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:23.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:5:0) after 1m0s
[08:42:23.817] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:5:0)
[08:42:23.817] Timer tick, asking Buildbucket for the build status
[08:42:23.998] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:23.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:6:0) after 1m0s
[08:43:24.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:6:0)
[08:43:24.084] Timer tick, asking Buildbucket for the build status
[08:43:24.245] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:24.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:7:0) after 1m0s
[08:44:24.294] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:7:0)
[08:44:24.294] Timer tick, asking Buildbucket for the build status
[08:44:24.427] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:24.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:8:0) after 1m0s
[08:45:24.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:8:0)
[08:45:24.425] Timer tick, asking Buildbucket for the build status
[08:45:24.611] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:24.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:9:0) after 1m0s
[08:46:24.609] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:9:0)
[08:46:24.609] Timer tick, asking Buildbucket for the build status
[08:46:24.869] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:24.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:10:0) after 1m0s
[08:47:25.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:10:0)
[08:47:25.038] Timer tick, asking Buildbucket for the build status
[08:47:25.135] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:25.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:11:0) after 1m0s
[08:48:25.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:11:0)
[08:48:25.203] Timer tick, asking Buildbucket for the build status
[08:48:25.530] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:25.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:12:0) after 1m0s
[08:49:25.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:12:0)
[08:49:25.583] Timer tick, asking Buildbucket for the build status
[08:49:25.721] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:25.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:13:0) after 1m0s
[08:50:25.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:13:0)
[08:50:25.900] Timer tick, asking Buildbucket for the build status
[08:50:25.988] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:25.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:14:0) after 1m0s
[08:51:26.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:14:0)
[08:51:26.098] Timer tick, asking Buildbucket for the build status
[08:51:26.218] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:26.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:15:0) after 1m0s
[08:52:26.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:15:0)
[08:52:26.301] Timer tick, asking Buildbucket for the build status
[08:52:26.512] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:26.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:16:0) after 1m0s
[08:53:26.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:16:0)
[08:53:26.614] Timer tick, asking Buildbucket for the build status
[08:53:26.690] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:26.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:17:0) after 1m0s
[08:54:26.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:17:0)
[08:54:26.716] Timer tick, asking Buildbucket for the build status
[08:54:26.882] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:26.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:18:0) after 1m0s
[08:55:27.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:18:0)
[08:55:27.011] Timer tick, asking Buildbucket for the build status
[08:55:27.093] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:27.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:19:0) after 1m0s
[08:56:27.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:19:0)
[08:56:27.202] Timer tick, asking Buildbucket for the build status
[08:56:27.276] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:27.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:20:0) after 1m0s
[08:57:27.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:20:0)
[08:57:27.468] Timer tick, asking Buildbucket for the build status
[08:57:27.538] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:27.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:21:0) after 1m0s
[08:58:27.566] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:21:0)
[08:58:27.566] Timer tick, asking Buildbucket for the build status
[08:58:27.688] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:27.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:22:0) after 1m0s
[08:59:27.725] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:22:0)
[08:59:27.725] Timer tick, asking Buildbucket for the build status
[08:59:28.309] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:28.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:23:0) after 1m0s
[09:00:28.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:23:0)
[09:00:28.444] Timer tick, asking Buildbucket for the build status
[09:00:28.605] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:28.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:24:0) after 1m0s
[09:01:28.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:24:0)
[09:01:28.803] Timer tick, asking Buildbucket for the build status
[09:01:28.884] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:28.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:25:0) after 1m0s
[09:02:29.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:25:0)
[09:02:29.007] Timer tick, asking Buildbucket for the build status
[09:02:29.137] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:29.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:26:0) after 1m0s
[09:03:29.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:26:0)
[09:03:29.156] Timer tick, asking Buildbucket for the build status
[09:03:29.231] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:29.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:27:0) after 1m0s
[09:04:29.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:27:0)
[09:04:29.384] Timer tick, asking Buildbucket for the build status
[09:04:29.586] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:29.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:28:0) after 1m0s
[09:05:29.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:28:0)
[09:05:29.672] Timer tick, asking Buildbucket for the build status
[09:05:29.999] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:29.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:29:0) after 1m0s
[09:06:30.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:29:0)
[09:06:30.086] Timer tick, asking Buildbucket for the build status
[09:06:30.399] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:30.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:30:0) after 1m0s
[09:07:30.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:30:0)
[09:07:30.392] Timer tick, asking Buildbucket for the build status
[09:07:30.518] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:30.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:31:0) after 1m0s
[09:08:30.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:31:0)
[09:08:30.546] Timer tick, asking Buildbucket for the build status
[09:08:30.775] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:30.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:32:0) after 1m0s
[09:09:30.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:32:0)
[09:09:30.850] Timer tick, asking Buildbucket for the build status
[09:09:31.012] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:31.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:33:0) after 1m0s
[09:10:31.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:33:0)
[09:10:31.096] Timer tick, asking Buildbucket for the build status
[09:10:31.177] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:31.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:34:0) after 1m0s
[09:11:31.200] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:34:0)
[09:11:31.200] Timer tick, asking Buildbucket for the build status
[09:11:31.324] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:31.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:35:0) after 1m0s
[09:12:31.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:35:0)
[09:12:31.585] Timer tick, asking Buildbucket for the build status
[09:12:31.661] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:31.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:36:0) after 1m0s
[09:13:31.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:36:0)
[09:13:31.765] Timer tick, asking Buildbucket for the build status
[09:13:31.848] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:31.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:37:0) after 1m0s
[09:14:31.875] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:37:0)
[09:14:31.875] Timer tick, asking Buildbucket for the build status
[09:14:32.420] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:32.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:38:0) after 1m0s
[09:15:32.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:38:0)
[09:15:32.499] Timer tick, asking Buildbucket for the build status
[09:15:32.592] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:32.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:39:0) after 1m0s
[09:16:32.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:39:0)
[09:16:32.646] Timer tick, asking Buildbucket for the build status
[09:16:32.848] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:32.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:40:0) after 1m0s
[09:17:32.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:40:0)
[09:17:32.985] Timer tick, asking Buildbucket for the build status
[09:17:33.064] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:33.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:41:0) after 1m0s
[09:18:33.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:41:0)
[09:18:33.162] Timer tick, asking Buildbucket for the build status
[09:18:33.305] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:33.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:42:0) after 1m0s
[09:19:33.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:42:0)
[09:19:33.380] Timer tick, asking Buildbucket for the build status
[09:19:33.785] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:33.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:43:0) after 1m0s
[09:20:33.910] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:43:0)
[09:20:33.910] Timer tick, asking Buildbucket for the build status
[09:20:34.215] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:34.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:44:0) after 1m0s
[09:21:34.316] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:44:0)
[09:21:34.316] Timer tick, asking Buildbucket for the build status
[09:21:34.396] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:34.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:45:0) after 1m0s
[09:22:34.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:45:0)
[09:22:34.572] Timer tick, asking Buildbucket for the build status
[09:22:34.642] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:34.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:46:0) after 1m0s
[09:23:34.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:46:0)
[09:23:34.733] Timer tick, asking Buildbucket for the build status
[09:23:34.804] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:34.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:47:0) after 1m0s
[09:24:34.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:47:0)
[09:24:34.965] Timer tick, asking Buildbucket for the build status
[09:24:35.124] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:35.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:48:0) after 1m0s
[09:25:35.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:48:0)
[09:25:35.167] Timer tick, asking Buildbucket for the build status
[09:25:35.488] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:35.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:49:0) after 1m0s
[09:26:35.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:49:0)
[09:26:35.617] Timer tick, asking Buildbucket for the build status
[09:26:35.710] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:35.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:50:0) after 1m0s
[09:27:35.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:50:0)
[09:27:35.723] Timer tick, asking Buildbucket for the build status
[09:27:35.800] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:35.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:51:0) after 1m0s
[09:28:35.898] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:51:0)
[09:28:35.898] Timer tick, asking Buildbucket for the build status
[09:28:36.027] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:36.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:52:0) after 1m0s
[09:29:36.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:52:0)
[09:29:36.098] Timer tick, asking Buildbucket for the build status
[09:29:36.339] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:36.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:53:0) after 1m0s
[09:30:36.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:53:0)
[09:30:36.402] Timer tick, asking Buildbucket for the build status
[09:30:36.477] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:36.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:54:0) after 1m0s
[09:31:36.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:54:0)
[09:31:36.528] Timer tick, asking Buildbucket for the build status
[09:31:36.652] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:36.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:55:0) after 1m0s
[09:32:36.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:55:0)
[09:32:36.680] Timer tick, asking Buildbucket for the build status
[09:32:36.880] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:36.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:56:0) after 1m0s
[09:33:36.926] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:56:0)
[09:33:36.926] Timer tick, asking Buildbucket for the build status
[09:33:37.041] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:37.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:57:0) after 1m0s
[09:34:37.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:57:0)
[09:34:37.079] Timer tick, asking Buildbucket for the build status
[09:34:37.274] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:37.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:58:0) after 1m0s
[09:35:37.314] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:58:0)
[09:35:37.314] Timer tick, asking Buildbucket for the build status
[09:35:37.414] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:37.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:59:0) after 1m0s
[09:36:37.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:59:0)
[09:36:37.430] Timer tick, asking Buildbucket for the build status
[09:36:37.507] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:37.507] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:60:0) after 1m0s
[09:37:37.528] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:60:0)
[09:37:37.528] Timer tick, asking Buildbucket for the build status
[09:37:37.603] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:37.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:61:0) after 1m0s
[09:38:37.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:61:0)
[09:38:37.655] Timer tick, asking Buildbucket for the build status
[09:38:37.951] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:37.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:62:0) after 1m0s
[09:39:37.971] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:62:0)
[09:39:37.971] Timer tick, asking Buildbucket for the build status
[09:39:38.527] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:38.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:63:0) after 1m0s
[09:40:38.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:63:0)
[09:40:38.670] Timer tick, asking Buildbucket for the build status
[09:40:38.735] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:38.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:64:0) after 1m0s
[09:41:38.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:64:0)
[09:41:38.734] Timer tick, asking Buildbucket for the build status
[09:41:38.798] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:38.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:65:0) after 1m0s
[09:42:38.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:65:0)
[09:42:38.941] Timer tick, asking Buildbucket for the build status
[09:42:39.071] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:39.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:66:0) after 1m0s
[09:43:39.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:66:0)
[09:43:39.223] Timer tick, asking Buildbucket for the build status
[09:43:39.319] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:39.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:67:0) after 1m0s
[09:44:39.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:67:0)
[09:44:39.375] Timer tick, asking Buildbucket for the build status
[09:44:39.687] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:39.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:68:0) after 1m0s
[09:45:39.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:68:0)
[09:45:39.779] Timer tick, asking Buildbucket for the build status
[09:45:40.081] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:40.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:69:0) after 1m0s
[09:46:40.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:69:0)
[09:46:40.141] Timer tick, asking Buildbucket for the build status
[09:46:40.446] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:40.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:70:0) after 1m0s
[09:47:40.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:70:0)
[09:47:40.542] Timer tick, asking Buildbucket for the build status
[09:47:40.681] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:40.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:71:0) after 1m0s
[09:48:40.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:71:0)
[09:48:40.804] Timer tick, asking Buildbucket for the build status
[09:48:40.992] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:40.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:72:0) after 1m0s
[09:49:41.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:72:0)
[09:49:41.007] Timer tick, asking Buildbucket for the build status
[09:49:41.321] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:41.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:73:0) after 1m0s
[09:50:41.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:73:0)
[09:50:41.356] Timer tick, asking Buildbucket for the build status
[09:50:41.598] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:41.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:74:0) after 1m0s
[09:51:41.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:74:0)
[09:51:41.624] Timer tick, asking Buildbucket for the build status
[09:51:41.697] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:41.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:75:0) after 1m0s
[09:52:41.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:75:0)
[09:52:41.719] Timer tick, asking Buildbucket for the build status
[09:52:41.791] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:41.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:76:0) after 1m0s
[09:53:41.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:76:0)
[09:53:41.915] Timer tick, asking Buildbucket for the build status
[09:53:41.998] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:41.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:77:0) after 1m0s
[09:54:42.061] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:77:0)
[09:54:42.061] Timer tick, asking Buildbucket for the build status
[09:54:42.204] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:42.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:78:0) after 1m0s
[09:55:42.189] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:78:0)
[09:55:42.189] Timer tick, asking Buildbucket for the build status
[09:55:42.287] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:42.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:79:0) after 1m0s
[09:56:42.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:79:0)
[09:56:42.361] Timer tick, asking Buildbucket for the build status
[09:56:42.439] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:42.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:80:0) after 1m0s
[09:57:42.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:80:0)
[09:57:42.559] Timer tick, asking Buildbucket for the build status
[09:57:42.652] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:42.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:81:0) after 1m0s
[09:58:42.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:81:0)
[09:58:42.694] Timer tick, asking Buildbucket for the build status
[09:58:42.764] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:42.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:82:0) after 1m0s
[09:59:42.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:82:0)
[09:59:42.840] Timer tick, asking Buildbucket for the build status
[09:59:42.990] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:42.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:83:0) after 1m0s
[10:00:43.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:83:0)
[10:00:43.109] Timer tick, asking Buildbucket for the build status
[10:00:43.216] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:43.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:84:0) after 1m0s
[10:01:43.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:84:0)
[10:01:43.242] Timer tick, asking Buildbucket for the build status
[10:01:43.342] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:43.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:85:0) after 1m0s
[10:02:43.832] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:85:0)
[10:02:43.832] Timer tick, asking Buildbucket for the build status
[10:02:43.920] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:43.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:86:0) after 1m0s
[10:03:43.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:86:0)
[10:03:43.968] Timer tick, asking Buildbucket for the build status
[10:03:44.036] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:44.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:87:0) after 1m0s
[10:04:44.142] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:87:0)
[10:04:44.142] Timer tick, asking Buildbucket for the build status
[10:04:44.476] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:44.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:88:0) after 1m0s
[10:05:44.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:88:0)
[10:05:44.564] Timer tick, asking Buildbucket for the build status
[10:05:44.647] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:44.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:89:0) after 1m0s
[10:06:44.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:89:0)
[10:06:44.702] Timer tick, asking Buildbucket for the build status
[10:06:44.786] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:44.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:90:0) after 1m0s
[10:07:44.922] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:90:0)
[10:07:44.923] Timer tick, asking Buildbucket for the build status
[10:07:44.989] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:44.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:91:0) after 1m0s
[10:08:45.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:91:0)
[10:08:45.017] Timer tick, asking Buildbucket for the build status
[10:08:45.108] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:45.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:92:0) after 1m0s
[10:09:45.146] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:92:0)
[10:09:45.146] Timer tick, asking Buildbucket for the build status
[10:09:45.313] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:45.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:93:0) after 1m0s
[10:10:45.374] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:93:0)
[10:10:45.374] Timer tick, asking Buildbucket for the build status
[10:10:45.452] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:45.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:94:0) after 1m0s
[10:11:45.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:94:0)
[10:11:45.506] Timer tick, asking Buildbucket for the build status
[10:11:45.577] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:45.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:95:0) after 1m0s
[10:12:45.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:95:0)
[10:12:45.629] Timer tick, asking Buildbucket for the build status
[10:12:45.806] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:45.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:96:0) after 1m0s
[10:13:45.854] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:96:0)
[10:13:45.854] Timer tick, asking Buildbucket for the build status
[10:13:46.067] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:46.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:97:0) after 1m0s
[10:14:46.215] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:97:0)
[10:14:46.215] Timer tick, asking Buildbucket for the build status
[10:14:46.582] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:46.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:98:0) after 1m0s
[10:15:46.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:98:0)
[10:15:46.654] Timer tick, asking Buildbucket for the build status
[10:15:46.806] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:46.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:99:0) after 1m0s
[10:16:46.829] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:99:0)
[10:16:46.829] Timer tick, asking Buildbucket for the build status
[10:16:46.993] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:46.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:100:0) after 1m0s
[10:17:47.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:100:0)
[10:17:47.042] Timer tick, asking Buildbucket for the build status
[10:17:47.185] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:47.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:101:0) after 1m0s
[10:18:47.385] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:101:0)
[10:18:47.385] Timer tick, asking Buildbucket for the build status
[10:18:47.510] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:47.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:102:0) after 1m0s
[10:19:47.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:102:0)
[10:19:47.584] Timer tick, asking Buildbucket for the build status
[10:19:47.713] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:47.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:103:0) after 1m0s
[10:20:47.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:103:0)
[10:20:47.747] Timer tick, asking Buildbucket for the build status
[10:20:48.029] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:48.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:104:0) after 1m0s
[10:21:48.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:104:0)
[10:21:48.224] Timer tick, asking Buildbucket for the build status
[10:21:48.484] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:48.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:105:0) after 1m0s
[10:22:48.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:105:0)
[10:22:48.662] Timer tick, asking Buildbucket for the build status
[10:22:48.757] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:48.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:106:0) after 1m0s
[10:23:48.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:106:0)
[10:23:48.757] Timer tick, asking Buildbucket for the build status
[10:23:49.427] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:49.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:107:0) after 1m0s
[10:24:49.535] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:107:0)
[10:24:49.535] Timer tick, asking Buildbucket for the build status
[10:24:49.790] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:49.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:108:0) after 1m0s
[10:25:49.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:108:0)
[10:25:49.965] Timer tick, asking Buildbucket for the build status
[10:25:50.062] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:50.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:109:0) after 1m0s
[10:26:50.277] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:109:0)
[10:26:50.277] Timer tick, asking Buildbucket for the build status
[10:26:50.344] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:50.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:110:0) after 1m0s
[10:27:50.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:110:0)
[10:27:50.480] Timer tick, asking Buildbucket for the build status
[10:27:50.533] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:50.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:111:0) after 1m0s
[10:28:50.766] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:111:0)
[10:28:50.766] Timer tick, asking Buildbucket for the build status
[10:28:50.875] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:50.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:112:0) after 1m0s
[10:29:51.046] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:112:0)
[10:29:51.046] Timer tick, asking Buildbucket for the build status
[10:29:51.170] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:51.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:113:0) after 1m0s
[10:30:51.302] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:113:0)
[10:30:51.302] Timer tick, asking Buildbucket for the build status
[10:30:51.472] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:51.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:114:0) after 1m0s
[10:31:51.541] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:114:0)
[10:31:51.541] Timer tick, asking Buildbucket for the build status
[10:31:51.887] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:51.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:115:0) after 1m0s
[10:32:52.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:115:0)
[10:32:52.008] Timer tick, asking Buildbucket for the build status
[10:32:52.194] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:52.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:116:0) after 1m0s
[10:33:52.274] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:116:0)
[10:33:52.274] Timer tick, asking Buildbucket for the build status
[10:33:52.351] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:52.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:117:0) after 1m0s
[10:34:52.378] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:117:0)
[10:34:52.378] Timer tick, asking Buildbucket for the build status
[10:34:52.515] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:52.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:118:0) after 1m0s
[10:35:52.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:118:0)
[10:35:52.534] Timer tick, asking Buildbucket for the build status
[10:35:52.804] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:52.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:119:0) after 1m0s
[10:36:52.864] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:119:0)
[10:36:52.864] Timer tick, asking Buildbucket for the build status
[10:36:52.955] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:52.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:120:0) after 1m0s
[10:37:53.075] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:120:0)
[10:37:53.075] Timer tick, asking Buildbucket for the build status
[10:37:53.154] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:53.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:121:0) after 1m0s
[10:38:53.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:121:0)
[10:38:53.253] Timer tick, asking Buildbucket for the build status
[10:38:53.365] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:53.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:122:0) after 1m0s
[10:39:53.516] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:122:0)
[10:39:53.516] Timer tick, asking Buildbucket for the build status
[10:39:53.626] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:53.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:123:0) after 1m0s
[10:40:53.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:123:0)
[10:40:53.677] Timer tick, asking Buildbucket for the build status
[10:40:53.810] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:53.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:124:0) after 1m0s
[10:41:53.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:124:0)
[10:41:53.935] Timer tick, asking Buildbucket for the build status
[10:41:54.298] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:54.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:125:0) after 1m0s
[10:42:54.328] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:125:0)
[10:42:54.328] Timer tick, asking Buildbucket for the build status
[10:42:54.418] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:54.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:126:0) after 1m0s
[10:43:54.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:126:0)
[10:43:54.488] Timer tick, asking Buildbucket for the build status
[10:43:54.703] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:54.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:127:0) after 1m0s
[10:44:54.753] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:127:0)
[10:44:54.753] Timer tick, asking Buildbucket for the build status
[10:44:54.890] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:54.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:128:0) after 1m0s
[10:45:54.880] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:128:0)
[10:45:54.880] Timer tick, asking Buildbucket for the build status
[10:45:55.095] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:55.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:129:0) after 1m0s
[10:46:55.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:129:0)
[10:46:55.157] Timer tick, asking Buildbucket for the build status
[10:46:55.491] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:55.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:130:0) after 1m0s
[10:47:55.488] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:130:0)
[10:47:55.488] Timer tick, asking Buildbucket for the build status
[10:47:55.581] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:55.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:131:0) after 1m0s
[10:48:55.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:131:0)
[10:48:55.612] Timer tick, asking Buildbucket for the build status
[10:48:55.799] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:55.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:132:0) after 1m0s
[10:49:55.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:132:0)
[10:49:55.877] Timer tick, asking Buildbucket for the build status
[10:49:56.009] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:56.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:133:0) after 1m0s
[10:50:56.045] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:133:0)
[10:50:56.045] Timer tick, asking Buildbucket for the build status
[10:50:56.304] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:56.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:134:0) after 1m0s
[10:51:56.377] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:134:0)
[10:51:56.377] Timer tick, asking Buildbucket for the build status
[10:51:56.455] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:56.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:135:0) after 1m0s
[10:52:56.526] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:135:0)
[10:52:56.526] Timer tick, asking Buildbucket for the build status
[10:52:56.618] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:56.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:136:0) after 1m0s
[10:53:56.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:136:0)
[10:53:56.699] Timer tick, asking Buildbucket for the build status
[10:53:56.799] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:56.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:137:0) after 1m0s
[10:54:56.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:137:0)
[10:54:56.831] Timer tick, asking Buildbucket for the build status
[10:54:57.247] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:57.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:138:0) after 1m0s
[10:55:57.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:138:0)
[10:55:57.252] Timer tick, asking Buildbucket for the build status
[10:55:57.335] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:57.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:139:0) after 1m0s
[10:56:57.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:139:0)
[10:56:57.414] Timer tick, asking Buildbucket for the build status
[10:56:57.482] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:57.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:140:0) after 1m0s
[10:57:57.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:140:0)
[10:57:57.563] Timer tick, asking Buildbucket for the build status
[10:57:57.702] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:57.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:141:0) after 1m0s
[10:58:57.796] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:141:0)
[10:58:57.796] Timer tick, asking Buildbucket for the build status
[10:58:57.890] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:57.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:142:0) after 1m0s
[10:59:57.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:142:0)
[10:59:57.949] Timer tick, asking Buildbucket for the build status
[10:59:58.220] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:58.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:143:0) after 1m0s
[11:00:58.262] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:143:0)
[11:00:58.262] Timer tick, asking Buildbucket for the build status
[11:00:58.428] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:58.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:144:0) after 1m0s
[11:01:58.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:144:0)
[11:01:58.702] Timer tick, asking Buildbucket for the build status
[11:01:58.782] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:58.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:145:0) after 1m0s
[11:02:59.153] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:145:0)
[11:02:59.153] Timer tick, asking Buildbucket for the build status
[11:02:59.298] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:59.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:146:0) after 1m0s
[11:03:59.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:146:0)
[11:03:59.361] Timer tick, asking Buildbucket for the build status
[11:03:59.577] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:59.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:147:0) after 1m0s
[11:04:59.642] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:147:0)
[11:04:59.642] Timer tick, asking Buildbucket for the build status
[11:04:59.815] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:59.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:148:0) after 1m0s
[11:05:59.946] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:148:0)
[11:05:59.946] Timer tick, asking Buildbucket for the build status
[11:06:00.144] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:00.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:149:0) after 1m0s
[11:07:00.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:149:0)
[11:07:00.253] Timer tick, asking Buildbucket for the build status
[11:07:00.329] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:00.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:150:0) after 1m0s
[11:08:00.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:150:0)
[11:08:00.362] Timer tick, asking Buildbucket for the build status
[11:08:00.437] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:00.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:151:0) after 1m0s
[11:09:00.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:151:0)
[11:09:00.979] Timer tick, asking Buildbucket for the build status
[11:09:01.299] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:01.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:152:0) after 1m0s
[11:10:01.374] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:152:0)
[11:10:01.374] Timer tick, asking Buildbucket for the build status
[11:10:01.549] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:01.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:153:0) after 1m0s
[11:11:01.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:153:0)
[11:11:01.591] Timer tick, asking Buildbucket for the build status
[11:11:01.718] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:01.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:154:0) after 1m0s
[11:12:01.757] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:154:0)
[11:12:01.757] Timer tick, asking Buildbucket for the build status
[11:12:01.912] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:01.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:155:0) after 1m0s
[11:13:02.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:155:0)
[11:13:02.223] Timer tick, asking Buildbucket for the build status
[11:13:02.355] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:02.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:156:0) after 1m0s
[11:14:02.449] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:156:0)
[11:14:02.449] Timer tick, asking Buildbucket for the build status
[11:14:02.640] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:02.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:157:0) after 1m0s
[11:15:02.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:157:0)
[11:15:02.674] Timer tick, asking Buildbucket for the build status
[11:15:02.861] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:02.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:158:0) after 1m0s
[11:16:02.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:158:0)
[11:16:02.897] Timer tick, asking Buildbucket for the build status
[11:16:03.122] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:03.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:159:0) after 1m0s
[11:17:03.229] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:159:0)
[11:17:03.229] Timer tick, asking Buildbucket for the build status
[11:17:03.577] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:03.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:160:0) after 1m0s
[11:18:03.658] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:160:0)
[11:18:03.658] Timer tick, asking Buildbucket for the build status
[11:18:03.771] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:03.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:161:0) after 1m0s
[11:19:03.820] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:161:0)
[11:19:03.820] Timer tick, asking Buildbucket for the build status
[11:19:04.976] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:04.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:162:0) after 1m0s
[11:20:05.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:162:0)
[11:20:05.052] Timer tick, asking Buildbucket for the build status
[11:20:05.793] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:05.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:163:0) after 1m0s
[11:21:05.892] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:163:0)
[11:21:05.892] Timer tick, asking Buildbucket for the build status
[11:21:05.992] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:05.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:164:0) after 1m0s
[11:22:06.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:164:0)
[11:22:06.053] Timer tick, asking Buildbucket for the build status
[11:22:06.211] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:06.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:165:0) after 1m0s
[11:23:06.303] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:165:0)
[11:23:06.303] Timer tick, asking Buildbucket for the build status
[11:23:06.491] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:06.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:166:0) after 1m0s
[11:24:06.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:166:0)
[11:24:06.529] Timer tick, asking Buildbucket for the build status
[11:24:06.612] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:06.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:167:0) after 1m0s
[11:25:06.761] Handling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:167:0)
[11:25:06.761] Timer tick, asking Buildbucket for the build status
[11:25:06.901] Build 8874088055768109584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:06.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9039518124268511824:168:0) after 1m0s
[11:25:27.619] Received PubSub notification, asking Buildbucket for the build status
[11:25:27.695] Build 8874088055768109584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:25:27.695] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1595417126531426",
    "created_by": "project:chromium",
    "created_ts": "1595407161894471",
    "id": "8874088055768109584",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3026c265f66d8f1d301173552c026711fc2f939d\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-25c2\", \"branch\": \"refs/heads/master\", \"buildername\": \"win-official\", \"buildnumber\": 145, \"got_angle_revision\": \"f6659b3df0281485a743afeda56c6d0601bebf1b\", \"got_dawn_revision\": \"c4cebc7efae1e00f5b15e18aab6c4c0e61c9a1ad\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"3026c265f66d8f1d301173552c026711fc2f939d\", \"got_revision_cp\": \"refs/heads/master@{#790754}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"f272427bda39a1abf3aa6e1a1bdd9b628b5ea5b1\", \"got_v8_revision\": \"1501159524ac28ffd0dfe35d1259e8a4917255e3\", \"got_v8_revision_cp\": \"refs/heads/8.6.211@{#1}\", \"got_webrtc_revision\": \"a5d9c1a45c2bd748b7ec7b6456b7ddddfc46d2d6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31772}\", \"mastername\": \"chromium\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3026c265f66d8f1d301173552c026711fc2f939d\"}, \"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-25c2\"], \"image\": [\"chrome-win10-1703-20071600-faa8609efbc\"], \"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\": [\"5425-e4e3059\"], \"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": "1595407167423641",
    "status": "COMPLETED",
    "status_changed_ts": "1595417127325864",
    "tags": [
      "build_address:luci.chromium.ci/win-official/145",
      "builder:win-official",
      "buildset:commit/git/3026c265f66d8f1d301173552c026711fc2f939d",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3026c265f66d8f1d301173552c026711fc2f939d",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9039518124268511824",
      "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/8874088055768109584/+/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:4d8e7ee81a0f4c10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1595417127336179",
    "url": "https://ci.chromium.org/b/8874088055768109584",
    "utcnow_ts": "1595417127687723"
  }
}
[11:25:27.695] Invocation finished in 2h46m13.291554539s with status SUCCEEDED