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

Definition (rev 61da5958bb1bf61dc6dab9a9ab14fa46798b5d0f)

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": "ef9bd275e5bf8dad8acad493aeef19cf2d294eb9"
}

Incoming tags

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

Debug log (UTC)

[12:42:08.490] New invocation is queued and will start shortly
[12:42:09.923] Starting the invocation (attempt 1)
[12:42:10.057] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:42:10.058] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:42:10.058] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9038868663567134352",
  "parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ef9bd275e5bf8dad8acad493aeef19cf2d294eb9\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win-official",
    "scheduler_invocation_id:9038868663567134352",
    "scheduler_job_id:chromium/win-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/ef9bd275e5bf8dad8acad493aeef19cf2d294eb9",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef9bd275e5bf8dad8acad493aeef19cf2d294eb9",
    "gitiles_ref:refs/heads/master"
  ]
}
[12:42:11.126] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1596026530260600",
    "id": "8873438600964454384",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef9bd275e5bf8dad8acad493aeef19cf2d294eb9\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1596026530926604",
    "tags": [
      "build_address:luci.chromium.ci/win-official/196",
      "builder:win-official",
      "buildset:commit/git/ef9bd275e5bf8dad8acad493aeef19cf2d294eb9",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef9bd275e5bf8dad8acad493aeef19cf2d294eb9",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9038868663567134352",
      "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/8873438600964454384/+/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": "1596026530926998",
    "url": "https://ci.chromium.org/b/8873438600964454384",
    "utcnow_ts": "1596026531117547"
  }
}
[12:42:11.126] Task URL: https://ci.chromium.org/b/8873438600964454384
[12:42:11.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:2:0) after 1m0s
[12:43:11.151] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:2:0)
[12:43:11.151] Timer tick, asking Buildbucket for the build status
[12:43:11.371] Build 8873438600964454384: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:43:11.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:3:0) after 1m0s
[12:44:11.433] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:3:0)
[12:44:11.433] Timer tick, asking Buildbucket for the build status
[12:44:11.539] Build 8873438600964454384: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:44:11.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:4:0) after 1m0s
[12:44:13.162] Received PubSub notification, asking Buildbucket for the build status
[12:44:13.246] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:11.527] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:4:0)
[12:45:11.527] Timer tick, asking Buildbucket for the build status
[12:45:11.617] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:11.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:6:0) after 1m0s
[12:46:11.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:6:0)
[12:46:11.731] Timer tick, asking Buildbucket for the build status
[12:46:13.294] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:13.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:7:0) after 1m0s
[12:47:13.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:7:0)
[12:47:13.319] Timer tick, asking Buildbucket for the build status
[12:47:14.059] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:14.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:8:0) after 1m0s
[12:48:14.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:8:0)
[12:48:14.139] Timer tick, asking Buildbucket for the build status
[12:48:14.235] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:14.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:9:0) after 1m0s
[12:49:14.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:9:0)
[12:49:14.333] Timer tick, asking Buildbucket for the build status
[12:49:14.417] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:14.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:10:0) after 1m0s
[12:50:14.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:10:0)
[12:50:14.480] Timer tick, asking Buildbucket for the build status
[12:50:14.555] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:14.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:11:0) after 1m0s
[12:51:14.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:11:0)
[12:51:14.641] Timer tick, asking Buildbucket for the build status
[12:51:14.741] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:14.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:12:0) after 1m0s
[12:52:14.839] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:12:0)
[12:52:14.839] Timer tick, asking Buildbucket for the build status
[12:52:16.162] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:16.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:13:0) after 1m0s
[12:53:16.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:13:0)
[12:53:16.217] Timer tick, asking Buildbucket for the build status
[12:53:16.627] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:16.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:14:0) after 1m0s
[12:54:16.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:14:0)
[12:54:16.696] Timer tick, asking Buildbucket for the build status
[12:54:16.869] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:16.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:15:0) after 1m0s
[12:55:16.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:15:0)
[12:55:16.909] Timer tick, asking Buildbucket for the build status
[12:55:17.306] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:17.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:16:0) after 1m0s
[12:56:17.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:16:0)
[12:56:17.382] Timer tick, asking Buildbucket for the build status
[12:56:17.539] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:17.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:17:0) after 1m0s
[12:57:17.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:17:0)
[12:57:17.744] Timer tick, asking Buildbucket for the build status
[12:57:17.950] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:17.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:18:0) after 1m0s
[12:58:17.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:18:0)
[12:58:17.976] Timer tick, asking Buildbucket for the build status
[12:58:19.031] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:19.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:19:0) after 1m0s
[12:59:19.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:19:0)
[12:59:19.261] Timer tick, asking Buildbucket for the build status
[12:59:19.351] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:19.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:20:0) after 1m0s
[13:00:19.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:20:0)
[13:00:19.476] Timer tick, asking Buildbucket for the build status
[13:00:19.596] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:19.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:21:0) after 1m0s
[13:01:19.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:21:0)
[13:01:19.762] Timer tick, asking Buildbucket for the build status
[13:01:19.854] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:19.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:22:0) after 1m0s
[13:02:19.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:22:0)
[13:02:19.860] Timer tick, asking Buildbucket for the build status
[13:02:20.169] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:20.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:23:0) after 1m0s
[13:03:20.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:23:0)
[13:03:20.237] Timer tick, asking Buildbucket for the build status
[13:03:20.350] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:20.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:24:0) after 1m0s
[13:04:20.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:24:0)
[13:04:20.343] Timer tick, asking Buildbucket for the build status
[13:04:20.740] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:20.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:25:0) after 1m0s
[13:05:20.806] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:25:0)
[13:05:20.806] Timer tick, asking Buildbucket for the build status
[13:05:20.876] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:20.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:26:0) after 1m0s
[13:06:20.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:26:0)
[13:06:20.955] Timer tick, asking Buildbucket for the build status
[13:06:21.092] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:21.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:27:0) after 1m0s
[13:07:21.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:27:0)
[13:07:21.187] Timer tick, asking Buildbucket for the build status
[13:07:21.362] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:21.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:28:0) after 1m0s
[13:08:21.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:28:0)
[13:08:21.384] Timer tick, asking Buildbucket for the build status
[13:08:21.564] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:21.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:29:0) after 1m0s
[13:09:21.590] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:29:0)
[13:09:21.590] Timer tick, asking Buildbucket for the build status
[13:09:21.874] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:21.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:30:0) after 1m0s
[13:10:21.938] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:30:0)
[13:10:21.938] Timer tick, asking Buildbucket for the build status
[13:10:22.025] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:22.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:31:0) after 1m0s
[13:11:22.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:31:0)
[13:11:22.099] Timer tick, asking Buildbucket for the build status
[13:11:22.295] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:22.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:32:0) after 1m0s
[13:12:22.397] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:32:0)
[13:12:22.397] Timer tick, asking Buildbucket for the build status
[13:12:22.541] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:22.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:33:0) after 1m0s
[13:13:22.619] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:33:0)
[13:13:22.619] Timer tick, asking Buildbucket for the build status
[13:13:22.751] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:22.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:34:0) after 1m0s
[13:14:22.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:34:0)
[13:14:22.779] Timer tick, asking Buildbucket for the build status
[13:14:22.880] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:22.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:35:0) after 1m0s
[13:15:23.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:35:0)
[13:15:23.023] Timer tick, asking Buildbucket for the build status
[13:15:23.129] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:23.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:36:0) after 1m0s
[13:16:23.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:36:0)
[13:16:23.313] Timer tick, asking Buildbucket for the build status
[13:16:23.420] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:23.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:37:0) after 1m0s
[13:17:23.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:37:0)
[13:17:23.486] Timer tick, asking Buildbucket for the build status
[13:17:23.727] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:23.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:38:0) after 1m0s
[13:18:23.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:38:0)
[13:18:23.784] Timer tick, asking Buildbucket for the build status
[13:18:23.891] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:23.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:39:0) after 1m0s
[13:19:23.962] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:39:0)
[13:19:23.962] Timer tick, asking Buildbucket for the build status
[13:19:24.035] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:24.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:40:0) after 1m0s
[13:20:24.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:40:0)
[13:20:24.062] Timer tick, asking Buildbucket for the build status
[13:20:24.331] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:24.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:41:0) after 1m0s
[13:21:24.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:41:0)
[13:21:24.400] Timer tick, asking Buildbucket for the build status
[13:21:24.518] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:24.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:42:0) after 1m0s
[13:22:24.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:42:0)
[13:22:24.498] Timer tick, asking Buildbucket for the build status
[13:22:24.650] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:24.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:43:0) after 1m0s
[13:23:24.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:43:0)
[13:23:24.647] Timer tick, asking Buildbucket for the build status
[13:23:24.776] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:24.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:44:0) after 1m0s
[13:24:24.786] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:44:0)
[13:24:24.786] Timer tick, asking Buildbucket for the build status
[13:24:24.879] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:24.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:45:0) after 1m0s
[13:25:24.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:45:0)
[13:25:24.943] Timer tick, asking Buildbucket for the build status
[13:25:25.096] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:25.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:46:0) after 1m0s
[13:26:25.228] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:46:0)
[13:26:25.228] Timer tick, asking Buildbucket for the build status
[13:26:26.025] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:26.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:47:0) after 1m0s
[13:27:26.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:47:0)
[13:27:26.144] Timer tick, asking Buildbucket for the build status
[13:27:27.937] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:27.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:48:0) after 1m0s
[13:28:28.231] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:48:0)
[13:28:28.231] Timer tick, asking Buildbucket for the build status
[13:28:28.368] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:28.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:49:0) after 1m0s
[13:29:28.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:49:0)
[13:29:28.538] Timer tick, asking Buildbucket for the build status
[13:29:28.833] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:28.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:50:0) after 1m0s
[13:30:28.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:50:0)
[13:30:28.968] Timer tick, asking Buildbucket for the build status
[13:30:29.199] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:29.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:51:0) after 1m0s
[13:31:29.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:51:0)
[13:31:29.224] Timer tick, asking Buildbucket for the build status
[13:31:29.589] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:29.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:52:0) after 1m0s
[13:32:29.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:52:0)
[13:32:29.763] Timer tick, asking Buildbucket for the build status
[13:32:30.070] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:30.070] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:53:0) after 1m0s
[13:33:30.099] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:53:0)
[13:33:30.099] Timer tick, asking Buildbucket for the build status
[13:33:32.681] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:32.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:54:0) after 1m0s
[13:34:32.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:54:0)
[13:34:32.680] Timer tick, asking Buildbucket for the build status
[13:34:32.754] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:32.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:55:0) after 1m0s
[13:35:32.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:55:0)
[13:35:32.810] Timer tick, asking Buildbucket for the build status
[13:35:32.991] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:32.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:56:0) after 1m0s
[13:36:33.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:56:0)
[13:36:33.052] Timer tick, asking Buildbucket for the build status
[13:36:33.139] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:33.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:57:0) after 1m0s
[13:37:33.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:57:0)
[13:37:33.180] Timer tick, asking Buildbucket for the build status
[13:37:33.325] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:33.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:58:0) after 1m0s
[13:38:33.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:58:0)
[13:38:33.371] Timer tick, asking Buildbucket for the build status
[13:38:36.190] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:36.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:59:0) after 1m0s
[13:39:36.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:59:0)
[13:39:36.536] Timer tick, asking Buildbucket for the build status
[13:39:39.501] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:39.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:60:0) after 1m0s
[13:40:40.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:60:0)
[13:40:40.102] Timer tick, asking Buildbucket for the build status
[13:40:40.378] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:40.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:61:0) after 1m0s
[13:41:40.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:61:0)
[13:41:40.503] Timer tick, asking Buildbucket for the build status
[13:41:41.754] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:41.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:62:0) after 1m0s
[13:42:41.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:62:0)
[13:42:41.804] Timer tick, asking Buildbucket for the build status
[13:42:42.126] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:42.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:63:0) after 1m0s
[13:43:42.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:63:0)
[13:43:42.188] Timer tick, asking Buildbucket for the build status
[13:43:42.343] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:42.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:64:0) after 1m0s
[13:44:42.793] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:64:0)
[13:44:42.793] Timer tick, asking Buildbucket for the build status
[13:44:42.897] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:42.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:65:0) after 1m0s
[13:45:51.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:65:0)
[13:45:51.371] Timer tick, asking Buildbucket for the build status
[13:45:52.472] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:52.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:66:0) after 1m0s
[13:46:54.173] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:66:0)
[13:46:54.173] Timer tick, asking Buildbucket for the build status
[13:46:54.254] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:54.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:67:0) after 1m0s
[13:47:54.399] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:67:0)
[13:47:54.399] Timer tick, asking Buildbucket for the build status
[13:47:54.534] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:54.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:68:0) after 1m0s
[13:48:54.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:68:0)
[13:48:54.699] Timer tick, asking Buildbucket for the build status
[13:48:54.865] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:54.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:69:0) after 1m0s
[13:49:55.125] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:69:0)
[13:49:55.125] Timer tick, asking Buildbucket for the build status
[13:49:55.194] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:55.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:70:0) after 1m0s
[13:50:55.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:70:0)
[13:50:55.317] Timer tick, asking Buildbucket for the build status
[13:50:57.562] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:57.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:71:0) after 1m0s
[13:51:57.606] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:71:0)
[13:51:57.606] Timer tick, asking Buildbucket for the build status
[13:52:00.099] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:00.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:72:0) after 1m0s
[13:53:00.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:72:0)
[13:53:00.175] Timer tick, asking Buildbucket for the build status
[13:53:00.332] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:00.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:73:0) after 1m0s
[13:54:01.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:73:0)
[13:54:01.811] Timer tick, asking Buildbucket for the build status
[13:54:01.998] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:01.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:74:0) after 1m0s
[13:55:02.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:74:0)
[13:55:02.055] Timer tick, asking Buildbucket for the build status
[13:55:02.201] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:02.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:75:0) after 1m0s
[13:56:02.456] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:75:0)
[13:56:02.456] Timer tick, asking Buildbucket for the build status
[13:56:02.571] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:02.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:76:0) after 1m0s
[13:57:02.587] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:76:0)
[13:57:02.587] Timer tick, asking Buildbucket for the build status
[13:57:02.652] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:02.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:77:0) after 1m0s
[13:58:02.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:77:0)
[13:58:02.715] Timer tick, asking Buildbucket for the build status
[13:58:03.350] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:03.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:78:0) after 1m0s
[13:59:03.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:78:0)
[13:59:03.411] Timer tick, asking Buildbucket for the build status
[13:59:03.516] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:03.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:79:0) after 1m0s
[14:00:03.608] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:79:0)
[14:00:03.608] Timer tick, asking Buildbucket for the build status
[14:00:03.850] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:03.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:80:0) after 1m0s
[14:01:03.874] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:80:0)
[14:01:03.874] Timer tick, asking Buildbucket for the build status
[14:01:03.988] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:03.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:81:0) after 1m0s
[14:02:04.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:81:0)
[14:02:04.023] Timer tick, asking Buildbucket for the build status
[14:02:04.132] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:04.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:82:0) after 1m0s
[14:03:04.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:82:0)
[14:03:04.139] Timer tick, asking Buildbucket for the build status
[14:03:04.815] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:04.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:83:0) after 1m0s
[14:04:04.889] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:83:0)
[14:04:04.889] Timer tick, asking Buildbucket for the build status
[14:04:04.973] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:04.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:84:0) after 1m0s
[14:05:05.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:84:0)
[14:05:05.055] Timer tick, asking Buildbucket for the build status
[14:05:05.302] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:05.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:85:0) after 1m0s
[14:06:05.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:85:0)
[14:06:05.362] Timer tick, asking Buildbucket for the build status
[14:06:05.458] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:05.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:86:0) after 1m0s
[14:07:05.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:86:0)
[14:07:05.563] Timer tick, asking Buildbucket for the build status
[14:07:05.912] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:05.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:87:0) after 1m0s
[14:08:05.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:87:0)
[14:08:05.981] Timer tick, asking Buildbucket for the build status
[14:08:06.301] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:06.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:88:0) after 1m0s
[14:09:06.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:88:0)
[14:09:06.398] Timer tick, asking Buildbucket for the build status
[14:09:06.817] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:06.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:89:0) after 1m0s
[14:10:06.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:89:0)
[14:10:06.913] Timer tick, asking Buildbucket for the build status
[14:10:07.118] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:07.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:90:0) after 1m0s
[14:11:07.204] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:90:0)
[14:11:07.204] Timer tick, asking Buildbucket for the build status
[14:11:07.301] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:07.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:91:0) after 1m0s
[14:12:07.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:91:0)
[14:12:07.350] Timer tick, asking Buildbucket for the build status
[14:12:07.539] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:07.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:92:0) after 1m0s
[14:13:07.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:92:0)
[14:13:07.615] Timer tick, asking Buildbucket for the build status
[14:13:08.066] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:08.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:93:0) after 1m0s
[14:14:08.164] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:93:0)
[14:14:08.164] Timer tick, asking Buildbucket for the build status
[14:14:08.469] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:08.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:94:0) after 1m0s
[14:15:08.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:94:0)
[14:15:08.512] Timer tick, asking Buildbucket for the build status
[14:15:08.807] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:08.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:95:0) after 1m0s
[14:16:08.834] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:95:0)
[14:16:08.834] Timer tick, asking Buildbucket for the build status
[14:16:08.899] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:08.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:96:0) after 1m0s
[14:17:08.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:96:0)
[14:17:08.920] Timer tick, asking Buildbucket for the build status
[14:17:09.099] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:09.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:97:0) after 1m0s
[14:18:09.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:97:0)
[14:18:09.161] Timer tick, asking Buildbucket for the build status
[14:18:09.299] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:09.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:98:0) after 1m0s
[14:19:09.326] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:98:0)
[14:19:09.326] Timer tick, asking Buildbucket for the build status
[14:19:09.658] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:09.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:99:0) after 1m0s
[14:20:09.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:99:0)
[14:20:09.866] Timer tick, asking Buildbucket for the build status
[14:20:11.052] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:11.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:100:0) after 1m0s
[14:21:11.267] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:100:0)
[14:21:11.267] Timer tick, asking Buildbucket for the build status
[14:21:11.362] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:11.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:101:0) after 1m0s
[14:22:11.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:101:0)
[14:22:11.457] Timer tick, asking Buildbucket for the build status
[14:22:11.641] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:11.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:102:0) after 1m0s
[14:23:11.825] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:102:0)
[14:23:11.825] Timer tick, asking Buildbucket for the build status
[14:23:11.992] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:11.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:103:0) after 1m0s
[14:24:11.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:103:0)
[14:24:11.996] Timer tick, asking Buildbucket for the build status
[14:24:12.067] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:12.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:104:0) after 1m0s
[14:25:12.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:104:0)
[14:25:12.187] Timer tick, asking Buildbucket for the build status
[14:25:12.273] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:12.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:105:0) after 1m0s
[14:26:12.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:105:0)
[14:26:12.375] Timer tick, asking Buildbucket for the build status
[14:26:12.582] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:12.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:106:0) after 1m0s
[14:27:12.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:106:0)
[14:27:12.718] Timer tick, asking Buildbucket for the build status
[14:27:12.831] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:12.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:107:0) after 1m0s
[14:28:12.890] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:107:0)
[14:28:12.890] Timer tick, asking Buildbucket for the build status
[14:28:13.052] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:13.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:108:0) after 1m0s
[14:29:13.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:108:0)
[14:29:13.086] Timer tick, asking Buildbucket for the build status
[14:29:13.193] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:13.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:109:0) after 1m0s
[14:30:13.368] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:109:0)
[14:30:13.368] Timer tick, asking Buildbucket for the build status
[14:30:13.465] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:13.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:110:0) after 1m0s
[14:31:13.519] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:110:0)
[14:31:13.519] Timer tick, asking Buildbucket for the build status
[14:31:13.619] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:13.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:111:0) after 1m0s
[14:32:13.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:111:0)
[14:32:13.760] Timer tick, asking Buildbucket for the build status
[14:32:13.914] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:13.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:112:0) after 1m0s
[14:33:14.874] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:112:0)
[14:33:14.874] Timer tick, asking Buildbucket for the build status
[14:33:15.236] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:15.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:113:0) after 1m0s
[14:34:15.562] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:113:0)
[14:34:15.562] Timer tick, asking Buildbucket for the build status
[14:34:15.735] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:15.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:114:0) after 1m0s
[14:35:15.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:114:0)
[14:35:15.855] Timer tick, asking Buildbucket for the build status
[14:35:16.007] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:16.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:115:0) after 1m0s
[14:36:16.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:115:0)
[14:36:16.144] Timer tick, asking Buildbucket for the build status
[14:36:16.216] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:16.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:116:0) after 1m0s
[14:37:16.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:116:0)
[14:37:16.383] Timer tick, asking Buildbucket for the build status
[14:37:16.489] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:16.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:117:0) after 1m0s
[14:38:16.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:117:0)
[14:38:16.655] Timer tick, asking Buildbucket for the build status
[14:38:17.202] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:17.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:118:0) after 1m0s
[14:39:17.332] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:118:0)
[14:39:17.332] Timer tick, asking Buildbucket for the build status
[14:39:17.539] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:17.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:119:0) after 1m0s
[14:40:17.613] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:119:0)
[14:40:17.613] Timer tick, asking Buildbucket for the build status
[14:40:17.737] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:17.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:120:0) after 1m0s
[14:41:17.749] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:120:0)
[14:41:17.749] Timer tick, asking Buildbucket for the build status
[14:41:17.837] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:17.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:121:0) after 1m0s
[14:42:18.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:121:0)
[14:42:18.007] Timer tick, asking Buildbucket for the build status
[14:42:18.502] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:18.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:122:0) after 1m0s
[14:43:18.600] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:122:0)
[14:43:18.600] Timer tick, asking Buildbucket for the build status
[14:43:18.766] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:18.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:123:0) after 1m0s
[14:44:18.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:123:0)
[14:44:18.815] Timer tick, asking Buildbucket for the build status
[14:44:19.117] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:19.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:124:0) after 1m0s
[14:45:19.118] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:124:0)
[14:45:19.118] Timer tick, asking Buildbucket for the build status
[14:45:19.327] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:19.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:125:0) after 1m0s
[14:46:19.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:125:0)
[14:46:19.407] Timer tick, asking Buildbucket for the build status
[14:46:19.487] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:19.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:126:0) after 1m0s
[14:47:19.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:126:0)
[14:47:19.586] Timer tick, asking Buildbucket for the build status
[14:47:19.705] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:19.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:127:0) after 1m0s
[14:48:19.902] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:127:0)
[14:48:19.902] Timer tick, asking Buildbucket for the build status
[14:48:20.168] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:20.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:128:0) after 1m0s
[14:49:20.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:128:0)
[14:49:20.398] Timer tick, asking Buildbucket for the build status
[14:49:20.475] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:20.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:129:0) after 1m0s
[14:50:20.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:129:0)
[14:50:20.614] Timer tick, asking Buildbucket for the build status
[14:50:20.817] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:20.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:130:0) after 1m0s
[14:51:20.983] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:130:0)
[14:51:20.983] Timer tick, asking Buildbucket for the build status
[14:51:21.555] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:21.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:131:0) after 1m0s
[14:52:21.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:131:0)
[14:52:21.647] Timer tick, asking Buildbucket for the build status
[14:52:21.868] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:21.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:132:0) after 1m0s
[14:53:21.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:132:0)
[14:53:21.941] Timer tick, asking Buildbucket for the build status
[14:53:22.084] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:22.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:133:0) after 1m0s
[14:54:22.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:133:0)
[14:54:22.144] Timer tick, asking Buildbucket for the build status
[14:54:22.330] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:22.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:134:0) after 1m0s
[14:55:22.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:134:0)
[14:55:22.402] Timer tick, asking Buildbucket for the build status
[14:55:22.470] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:22.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:135:0) after 1m0s
[14:56:22.627] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:135:0)
[14:56:22.627] Timer tick, asking Buildbucket for the build status
[14:56:22.735] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:22.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:136:0) after 1m0s
[14:57:26.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:136:0)
[14:57:26.364] Timer tick, asking Buildbucket for the build status
[14:57:26.540] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:26.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:137:0) after 1m0s
[14:58:27.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:137:0)
[14:58:27.255] Timer tick, asking Buildbucket for the build status
[14:58:27.340] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:27.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:138:0) after 1m0s
[14:59:27.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:138:0)
[14:59:27.466] Timer tick, asking Buildbucket for the build status
[14:59:27.738] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:27.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:139:0) after 1m0s
[15:00:27.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:139:0)
[15:00:27.807] Timer tick, asking Buildbucket for the build status
[15:00:28.075] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:28.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:140:0) after 1m0s
[15:01:28.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:140:0)
[15:01:28.184] Timer tick, asking Buildbucket for the build status
[15:01:28.799] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:28.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:141:0) after 1m0s
[15:02:28.890] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:141:0)
[15:02:28.890] Timer tick, asking Buildbucket for the build status
[15:02:28.998] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:28.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:142:0) after 1m0s
[15:03:29.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:142:0)
[15:03:29.072] Timer tick, asking Buildbucket for the build status
[15:03:29.286] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:29.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:143:0) after 1m0s
[15:04:29.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:143:0)
[15:04:29.364] Timer tick, asking Buildbucket for the build status
[15:04:30.446] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:30.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:144:0) after 1m0s
[15:05:30.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:144:0)
[15:05:30.510] Timer tick, asking Buildbucket for the build status
[15:05:31.329] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:31.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:145:0) after 1m0s
[15:06:31.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:145:0)
[15:06:31.381] Timer tick, asking Buildbucket for the build status
[15:06:31.633] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:31.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:146:0) after 1m0s
[15:07:31.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:146:0)
[15:07:31.643] Timer tick, asking Buildbucket for the build status
[15:07:32.097] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:32.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:147:0) after 1m0s
[15:08:32.124] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:147:0)
[15:08:32.124] Timer tick, asking Buildbucket for the build status
[15:08:32.222] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:32.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:148:0) after 1m0s
[15:09:32.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:148:0)
[15:09:32.354] Timer tick, asking Buildbucket for the build status
[15:09:32.825] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:32.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:149:0) after 1m0s
[15:10:32.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:149:0)
[15:10:32.853] Timer tick, asking Buildbucket for the build status
[15:10:32.932] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:32.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:150:0) after 1m0s
[15:11:33.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:150:0)
[15:11:33.036] Timer tick, asking Buildbucket for the build status
[15:11:33.124] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:33.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:151:0) after 1m0s
[15:12:33.199] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:151:0)
[15:12:33.199] Timer tick, asking Buildbucket for the build status
[15:12:33.647] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:33.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:152:0) after 1m0s
[15:13:34.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:152:0)
[15:13:34.366] Timer tick, asking Buildbucket for the build status
[15:13:34.432] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:34.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:153:0) after 1m0s
[15:14:34.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:153:0)
[15:14:34.771] Timer tick, asking Buildbucket for the build status
[15:14:34.871] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:34.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:154:0) after 1m0s
[15:15:35.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:154:0)
[15:15:35.212] Timer tick, asking Buildbucket for the build status
[15:15:35.305] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:35.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:155:0) after 1m0s
[15:16:35.576] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:155:0)
[15:16:35.576] Timer tick, asking Buildbucket for the build status
[15:16:36.821] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:36.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:156:0) after 1m0s
[15:17:37.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:156:0)
[15:17:37.021] Timer tick, asking Buildbucket for the build status
[15:17:37.377] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:37.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:157:0) after 1m0s
[15:18:37.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:157:0)
[15:18:37.428] Timer tick, asking Buildbucket for the build status
[15:18:37.637] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:37.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:158:0) after 1m0s
[15:19:37.923] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:158:0)
[15:19:37.923] Timer tick, asking Buildbucket for the build status
[15:19:38.048] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:38.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:159:0) after 1m0s
[15:20:38.126] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:159:0)
[15:20:38.126] Timer tick, asking Buildbucket for the build status
[15:20:38.224] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:38.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:160:0) after 1m0s
[15:21:38.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:160:0)
[15:21:38.310] Timer tick, asking Buildbucket for the build status
[15:21:38.611] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:38.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:161:0) after 1m0s
[15:22:38.872] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:161:0)
[15:22:38.872] Timer tick, asking Buildbucket for the build status
[15:22:39.073] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:39.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:162:0) after 1m0s
[15:23:39.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:162:0)
[15:23:39.240] Timer tick, asking Buildbucket for the build status
[15:23:39.325] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:39.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:163:0) after 1m0s
[15:24:39.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:163:0)
[15:24:39.598] Timer tick, asking Buildbucket for the build status
[15:24:40.606] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:40.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:164:0) after 1m0s
[15:25:40.929] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:164:0)
[15:25:40.929] Timer tick, asking Buildbucket for the build status
[15:25:41.108] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:41.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:165:0) after 1m0s
[15:26:41.426] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:165:0)
[15:26:41.426] Timer tick, asking Buildbucket for the build status
[15:26:41.504] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:41.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:166:0) after 1m0s
[15:27:41.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:166:0)
[15:27:41.672] Timer tick, asking Buildbucket for the build status
[15:27:41.853] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:41.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:167:0) after 1m0s
[15:28:42.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:167:0)
[15:28:42.096] Timer tick, asking Buildbucket for the build status
[15:28:42.172] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:42.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:168:0) after 1m0s
[15:29:42.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:168:0)
[15:29:42.272] Timer tick, asking Buildbucket for the build status
[15:29:42.440] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:42.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:169:0) after 1m0s
[15:30:42.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:169:0)
[15:30:42.601] Timer tick, asking Buildbucket for the build status
[15:30:43.320] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:43.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:170:0) after 1m0s
[15:31:43.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:170:0)
[15:31:43.416] Timer tick, asking Buildbucket for the build status
[15:31:45.057] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:45.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:171:0) after 1m0s
[15:32:45.105] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:171:0)
[15:32:45.105] Timer tick, asking Buildbucket for the build status
[15:32:45.261] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:45.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:172:0) after 1m0s
[15:33:45.337] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:172:0)
[15:33:45.337] Timer tick, asking Buildbucket for the build status
[15:33:45.412] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:45.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:173:0) after 1m0s
[15:34:45.572] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:173:0)
[15:34:45.572] Timer tick, asking Buildbucket for the build status
[15:34:45.817] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:45.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:174:0) after 1m0s
[15:35:45.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:174:0)
[15:35:45.989] Timer tick, asking Buildbucket for the build status
[15:35:46.305] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:46.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:175:0) after 1m0s
[15:36:46.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:175:0)
[15:36:46.402] Timer tick, asking Buildbucket for the build status
[15:36:46.512] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:46.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:176:0) after 1m0s
[15:37:46.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:176:0)
[15:37:46.603] Timer tick, asking Buildbucket for the build status
[15:37:46.828] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:46.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:177:0) after 1m0s
[15:38:46.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:177:0)
[15:38:46.974] Timer tick, asking Buildbucket for the build status
[15:38:47.150] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:47.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:178:0) after 1m0s
[15:39:47.226] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:178:0)
[15:39:47.226] Timer tick, asking Buildbucket for the build status
[15:39:47.324] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:47.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:179:0) after 1m0s
[15:40:47.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:179:0)
[15:40:47.348] Timer tick, asking Buildbucket for the build status
[15:40:47.662] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:47.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:180:0) after 1m0s
[15:41:47.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:180:0)
[15:41:47.714] Timer tick, asking Buildbucket for the build status
[15:41:47.783] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:47.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:181:0) after 1m0s
[15:42:47.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:181:0)
[15:42:47.940] Timer tick, asking Buildbucket for the build status
[15:42:48.115] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:48.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:182:0) after 1m0s
[15:43:48.160] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:182:0)
[15:43:48.160] Timer tick, asking Buildbucket for the build status
[15:43:48.252] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:48.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:183:0) after 1m0s
[15:44:48.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:183:0)
[15:44:48.322] Timer tick, asking Buildbucket for the build status
[15:44:49.082] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:49.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:184:0) after 1m0s
[15:45:49.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:184:0)
[15:45:49.128] Timer tick, asking Buildbucket for the build status
[15:45:49.331] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:49.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:185:0) after 1m0s
[15:46:49.363] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:185:0)
[15:46:49.363] Timer tick, asking Buildbucket for the build status
[15:46:49.494] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:49.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:186:0) after 1m0s
[15:47:49.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:186:0)
[15:47:49.536] Timer tick, asking Buildbucket for the build status
[15:47:49.981] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:49.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:187:0) after 1m0s
[15:48:50.012] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:187:0)
[15:48:50.012] Timer tick, asking Buildbucket for the build status
[15:48:50.193] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:50.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:188:0) after 1m0s
[15:49:50.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:188:0)
[15:49:50.223] Timer tick, asking Buildbucket for the build status
[15:49:50.462] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:50.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:189:0) after 1m0s
[15:50:50.648] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:189:0)
[15:50:50.648] Timer tick, asking Buildbucket for the build status
[15:50:50.749] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:50.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:190:0) after 1m0s
[15:51:50.818] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:190:0)
[15:51:50.818] Timer tick, asking Buildbucket for the build status
[15:51:50.887] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:50.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:191:0) after 1m0s
[15:52:50.918] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:191:0)
[15:52:50.918] Timer tick, asking Buildbucket for the build status
[15:52:51.483] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:51.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:192:0) after 1m0s
[15:53:51.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:192:0)
[15:53:51.563] Timer tick, asking Buildbucket for the build status
[15:53:51.639] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:51.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:193:0) after 1m0s
[15:54:51.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:193:0)
[15:54:51.697] Timer tick, asking Buildbucket for the build status
[15:54:51.765] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:51.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:194:0) after 1m0s
[15:55:51.875] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:194:0)
[15:55:51.875] Timer tick, asking Buildbucket for the build status
[15:55:51.971] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:51.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:195:0) after 1m0s
[15:56:52.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:195:0)
[15:56:52.011] Timer tick, asking Buildbucket for the build status
[15:56:52.223] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:52.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:196:0) after 1m0s
[15:57:52.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:196:0)
[15:57:52.333] Timer tick, asking Buildbucket for the build status
[15:57:52.467] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:52.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:197:0) after 1m0s
[15:58:52.641] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:197:0)
[15:58:52.641] Timer tick, asking Buildbucket for the build status
[15:58:52.791] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:52.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:198:0) after 1m0s
[15:59:52.880] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:198:0)
[15:59:52.880] Timer tick, asking Buildbucket for the build status
[15:59:53.195] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:53.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:199:0) after 1m0s
[16:00:53.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:199:0)
[16:00:53.340] Timer tick, asking Buildbucket for the build status
[16:00:53.505] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:53.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:200:0) after 1m0s
[16:01:53.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:200:0)
[16:01:53.744] Timer tick, asking Buildbucket for the build status
[16:01:53.915] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:53.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:201:0) after 1m0s
[16:02:53.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:201:0)
[16:02:53.987] Timer tick, asking Buildbucket for the build status
[16:02:54.202] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:54.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:202:0) after 1m0s
[16:03:54.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:202:0)
[16:03:54.340] Timer tick, asking Buildbucket for the build status
[16:03:54.531] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:54.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:203:0) after 1m0s
[16:04:54.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:203:0)
[16:04:54.699] Timer tick, asking Buildbucket for the build status
[16:04:55.332] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:55.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:204:0) after 1m0s
[16:05:55.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:204:0)
[16:05:55.914] Timer tick, asking Buildbucket for the build status
[16:05:56.298] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:56.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:205:0) after 1m0s
[16:06:56.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:205:0)
[16:06:56.474] Timer tick, asking Buildbucket for the build status
[16:06:56.549] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:56.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:206:0) after 1m0s
[16:07:57.014] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:206:0)
[16:07:57.014] Timer tick, asking Buildbucket for the build status
[16:07:57.229] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:57.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:207:0) after 1m0s
[16:08:57.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:207:0)
[16:08:57.273] Timer tick, asking Buildbucket for the build status
[16:08:57.368] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:57.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:208:0) after 1m0s
[16:09:57.459] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:208:0)
[16:09:57.459] Timer tick, asking Buildbucket for the build status
[16:09:57.697] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:57.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:209:0) after 1m0s
[16:10:57.886] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:209:0)
[16:10:57.886] Timer tick, asking Buildbucket for the build status
[16:10:57.981] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:57.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:210:0) after 1m0s
[16:11:58.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:210:0)
[16:11:58.148] Timer tick, asking Buildbucket for the build status
[16:11:58.230] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:58.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:211:0) after 1m0s
[16:12:58.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:211:0)
[16:12:58.393] Timer tick, asking Buildbucket for the build status
[16:12:58.733] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:58.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:212:0) after 1m0s
[16:13:58.786] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:212:0)
[16:13:58.786] Timer tick, asking Buildbucket for the build status
[16:13:58.937] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:58.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:213:0) after 1m0s
[16:14:59.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:213:0)
[16:14:59.193] Timer tick, asking Buildbucket for the build status
[16:14:59.286] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:59.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:214:0) after 1m0s
[16:15:59.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:214:0)
[16:15:59.356] Timer tick, asking Buildbucket for the build status
[16:15:59.453] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:59.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:215:0) after 1m0s
[16:16:59.514] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:215:0)
[16:16:59.514] Timer tick, asking Buildbucket for the build status
[16:16:59.619] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:59.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:216:0) after 1m0s
[16:17:59.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:216:0)
[16:17:59.772] Timer tick, asking Buildbucket for the build status
[16:17:59.989] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:59.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:217:0) after 1m0s
[16:19:00.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:217:0)
[16:19:00.084] Timer tick, asking Buildbucket for the build status
[16:19:00.314] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:00.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:218:0) after 1m0s
[16:20:00.421] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:218:0)
[16:20:00.421] Timer tick, asking Buildbucket for the build status
[16:20:00.536] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:00.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:219:0) after 1m0s
[16:21:01.842] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:219:0)
[16:21:01.842] Timer tick, asking Buildbucket for the build status
[16:21:01.927] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:01.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:220:0) after 1m0s
[16:22:02.717] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:220:0)
[16:22:02.717] Timer tick, asking Buildbucket for the build status
[16:22:02.807] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:02.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:221:0) after 1m0s
[16:23:02.991] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:221:0)
[16:23:02.991] Timer tick, asking Buildbucket for the build status
[16:23:04.285] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:04.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:222:0) after 1m0s
[16:24:04.374] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:222:0)
[16:24:04.374] Timer tick, asking Buildbucket for the build status
[16:24:04.562] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:04.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:223:0) after 1m0s
[16:25:04.638] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:223:0)
[16:25:04.638] Timer tick, asking Buildbucket for the build status
[16:25:04.803] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:04.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:224:0) after 1m0s
[16:26:05.420] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:224:0)
[16:26:05.420] Timer tick, asking Buildbucket for the build status
[16:26:05.504] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:05.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:225:0) after 1m0s
[16:27:05.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:225:0)
[16:27:05.804] Timer tick, asking Buildbucket for the build status
[16:27:05.891] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:05.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:226:0) after 1m0s
[16:28:06.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:226:0)
[16:28:06.092] Timer tick, asking Buildbucket for the build status
[16:28:06.308] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:06.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:227:0) after 1m0s
[16:29:06.453] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:227:0)
[16:29:06.453] Timer tick, asking Buildbucket for the build status
[16:29:08.768] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:08.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:228:0) after 1m0s
[16:30:08.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:228:0)
[16:30:08.853] Timer tick, asking Buildbucket for the build status
[16:30:09.057] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:09.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:229:0) after 1m0s
[16:31:09.145] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:229:0)
[16:31:09.145] Timer tick, asking Buildbucket for the build status
[16:31:09.738] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:09.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:230:0) after 1m0s
[16:32:09.830] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:230:0)
[16:32:09.830] Timer tick, asking Buildbucket for the build status
[16:32:09.954] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:09.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:231:0) after 1m0s
[16:33:09.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:231:0)
[16:33:09.965] Timer tick, asking Buildbucket for the build status
[16:33:10.298] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:10.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:232:0) after 1m0s
[16:34:10.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:232:0)
[16:34:10.365] Timer tick, asking Buildbucket for the build status
[16:34:10.644] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:10.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:233:0) after 1m0s
[16:35:10.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:233:0)
[16:35:10.862] Timer tick, asking Buildbucket for the build status
[16:35:11.373] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:11.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:234:0) after 1m0s
[16:36:11.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:234:0)
[16:36:11.815] Timer tick, asking Buildbucket for the build status
[16:36:11.931] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:11.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:235:0) after 1m0s
[16:37:11.975] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:235:0)
[16:37:11.975] Timer tick, asking Buildbucket for the build status
[16:37:12.079] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:12.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:236:0) after 1m0s
[16:38:12.263] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:236:0)
[16:38:12.263] Timer tick, asking Buildbucket for the build status
[16:38:12.442] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:12.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:237:0) after 1m0s
[16:39:12.485] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:237:0)
[16:39:12.485] Timer tick, asking Buildbucket for the build status
[16:39:12.598] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:12.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:238:0) after 1m0s
[16:40:12.845] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:238:0)
[16:40:12.845] Timer tick, asking Buildbucket for the build status
[16:40:13.631] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:13.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:239:0) after 1m0s
[16:41:13.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:239:0)
[16:41:13.714] Timer tick, asking Buildbucket for the build status
[16:41:13.854] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:13.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:240:0) after 1m0s
[16:42:13.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:240:0)
[16:42:13.968] Timer tick, asking Buildbucket for the build status
[16:42:14.166] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:14.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:241:0) after 1m0s
[16:43:14.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:241:0)
[16:43:14.223] Timer tick, asking Buildbucket for the build status
[16:43:14.401] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:14.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:242:0) after 1m0s
[16:44:14.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:242:0)
[16:44:14.475] Timer tick, asking Buildbucket for the build status
[16:44:14.543] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:14.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:243:0) after 1m0s
[16:45:14.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:243:0)
[16:45:14.571] Timer tick, asking Buildbucket for the build status
[16:45:14.799] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:14.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:244:0) after 1m0s
[16:46:14.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:244:0)
[16:46:14.836] Timer tick, asking Buildbucket for the build status
[16:46:14.938] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:14.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:245:0) after 1m0s
[16:47:15.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:245:0)
[16:47:15.111] Timer tick, asking Buildbucket for the build status
[16:47:15.233] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:15.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:246:0) after 1m0s
[16:48:15.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:246:0)
[16:48:15.266] Timer tick, asking Buildbucket for the build status
[16:48:15.673] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:15.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:247:0) after 1m0s
[16:49:15.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:247:0)
[16:49:15.663] Timer tick, asking Buildbucket for the build status
[16:49:15.870] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:15.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:248:0) after 1m0s
[16:50:15.972] Handling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:248:0)
[16:50:15.972] Timer tick, asking Buildbucket for the build status
[16:50:16.054] Build 8873438600964454384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:16.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9038868663567134352:249:0) after 1m0s
[16:50:32.226] Received PubSub notification, asking Buildbucket for the build status
[16:50:32.358] Build 8873438600964454384: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:50:32.358] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1596041431372744",
    "created_by": "project:chromium",
    "created_ts": "1596026530260600",
    "id": "8873438600964454384",
    "parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef9bd275e5bf8dad8acad493aeef19cf2d294eb9\"}}",
    "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-9-fe34\", \"branch\": \"refs/heads/master\", \"buildername\": \"win-official\", \"buildnumber\": 196, \"got_angle_revision\": \"592c94cd987f00e71e5d37060a9b1a99468456ca\", \"got_dawn_revision\": \"b88b1a15c7e4cde561cd7e69be452c1be68467e6\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"ef9bd275e5bf8dad8acad493aeef19cf2d294eb9\", \"got_revision_cp\": \"refs/heads/master@{#792662}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"dc8e77f0e52145b7e0c63eb36c1482e66b87fbff\", \"got_v8_revision\": \"0bf57c8ff46ff2259ef2faa2017cf4a017596d0c\", \"got_v8_revision_cp\": \"refs/heads/8.6.268@{#1}\", \"got_webrtc_revision\": \"0bb26390604ec8589a1986f0fbc52749523b38bd\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31796}\", \"mastername\": \"chromium\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ef9bd275e5bf8dad8acad493aeef19cf2d294eb9\"}, \"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-9-fe34\"], \"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\": [\"5436-adf7f8a\"], \"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": "1596026652215771",
    "status": "COMPLETED",
    "status_changed_ts": "1596041431807822",
    "tags": [
      "build_address:luci.chromium.ci/win-official/196",
      "builder:win-official",
      "buildset:commit/git/ef9bd275e5bf8dad8acad493aeef19cf2d294eb9",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef9bd275e5bf8dad8acad493aeef19cf2d294eb9",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9038868663567134352",
      "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/8873438600964454384/+/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:4db369b5b209d710",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1596041431822509",
    "url": "https://ci.chromium.org/b/8873438600964454384",
    "utcnow_ts": "1596041432337805"
  }
}
[16:50:32.358] Invocation finished in 4h8m23.963432405s with status SUCCEEDED