LUCI Scheduler :: chromium :: win32-official

Status: SUCCEEDED

Triggered by: -

Duration: 3 hours

Actions:

Definition (rev 835dd06986af6863f902c628becb4df908d0fc20)

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

Incoming triggers

3ec3336db890c15e78beaa2a4b72286637bcbf3e (5 years ago)
815b885a958c08e53f786786986bba487458259e (5 years ago)
cda0c1c11cea4df5bd5cb51f1ec5b843c9bb6bff (5 years ago)
8a2edb5cae139f52a7ddedd225890f9971ecaae2 (5 years ago)
0084b8f9bea39de209115d2855988c58244d76b5 (5 years ago)
90471f3bb04b956e135ea6fe8b227118d03b2f1c (5 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[14:52:20.501] New invocation is queued and will start shortly
[14:52:21.541] Starting the invocation (attempt 1)
[14:52:21.575] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:52:21.575] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:52:21.575] Buildbucket request:
{
  "bucket": "luci.chromium.ci",
  "client_operation_id": "9021375257480346272",
  "parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"90471f3bb04b956e135ea6fe8b227118d03b2f1c\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:win32-official",
    "scheduler_invocation_id:9021375257480346272",
    "scheduler_job_id:chromium/win32-official",
    "user_agent:luci-scheduler",
    "buildset:commit/git/90471f3bb04b956e135ea6fe8b227118d03b2f1c",
    "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90471f3bb04b956e135ea6fe8b227118d03b2f1c",
    "gitiles_ref:refs/heads/master"
  ]
}
[14:52:22.262] Buildbucket response:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "created_by": "project:chromium",
    "created_ts": "1612709541680328",
    "id": "8855945195581339536",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90471f3bb04b956e135ea6fe8b227118d03b2f1c\"}}",
    "project": "chromium",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1612709542086426",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1508",
      "builder:win32-official",
      "buildset:commit/git/90471f3bb04b956e135ea6fe8b227118d03b2f1c",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90471f3bb04b956e135ea6fe8b227118d03b2f1c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021375257480346272",
      "scheduler_job_id:chromium/win32-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855945195581339536/+/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": "1612709542086816",
    "url": "https://ci.chromium.org/b/8855945195581339536",
    "utcnow_ts": "1612709542253655"
  }
}
[14:52:22.262] Task URL: https://ci.chromium.org/b/8855945195581339536
[14:52:22.262] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:2:0) after 1m0s
[14:53:22.392] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:2:0)
[14:53:22.392] Timer tick, asking Buildbucket for the build status
[14:53:22.615] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:53:22.615] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:3:0) after 1m0s
[14:54:22.653] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:3:0)
[14:54:22.653] Timer tick, asking Buildbucket for the build status
[14:54:22.759] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:54:22.759] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:4:0) after 1m0s
[14:55:22.920] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:4:0)
[14:55:22.920] Timer tick, asking Buildbucket for the build status
[14:55:23.042] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:55:23.042] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:5:0) after 1m0s
[14:56:23.199] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:5:0)
[14:56:23.199] Timer tick, asking Buildbucket for the build status
[14:56:23.353] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:56:23.354] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:6:0) after 1m0s
[14:57:23.336] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:6:0)
[14:57:23.336] Timer tick, asking Buildbucket for the build status
[14:57:23.477] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:57:23.477] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:7:0) after 1m0s
[14:58:23.553] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:7:0)
[14:58:23.553] Timer tick, asking Buildbucket for the build status
[14:58:23.626] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:58:23.626] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:8:0) after 1m0s
[14:59:23.732] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:8:0)
[14:59:23.732] Timer tick, asking Buildbucket for the build status
[14:59:23.899] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:59:23.899] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:9:0) after 1m0s
[15:00:23.990] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:9:0)
[15:00:23.990] Timer tick, asking Buildbucket for the build status
[15:00:24.940] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:00:24.940] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:10:0) after 1m0s
[15:01:25.103] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:10:0)
[15:01:25.103] Timer tick, asking Buildbucket for the build status
[15:01:25.336] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:01:25.336] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:11:0) after 1m0s
[15:02:25.358] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:11:0)
[15:02:25.358] Timer tick, asking Buildbucket for the build status
[15:02:25.465] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:02:25.465] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:12:0) after 1m0s
[15:03:25.605] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:12:0)
[15:03:25.605] Timer tick, asking Buildbucket for the build status
[15:03:25.915] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:03:25.915] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:13:0) after 1m0s
[15:04:25.983] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:13:0)
[15:04:25.983] Timer tick, asking Buildbucket for the build status
[15:04:26.065] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:04:26.065] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:14:0) after 1m0s
[15:05:26.142] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:14:0)
[15:05:26.142] Timer tick, asking Buildbucket for the build status
[15:05:26.499] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:05:26.499] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:15:0) after 1m0s
[15:06:26.587] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:15:0)
[15:06:26.587] Timer tick, asking Buildbucket for the build status
[15:06:26.833] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:06:26.833] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:16:0) after 1m0s
[15:07:27.039] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:16:0)
[15:07:27.039] Timer tick, asking Buildbucket for the build status
[15:07:27.143] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:07:27.143] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:17:0) after 1m0s
[15:08:27.243] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:17:0)
[15:08:27.243] Timer tick, asking Buildbucket for the build status
[15:08:27.324] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:08:27.324] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:18:0) after 1m0s
[15:09:28.743] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:18:0)
[15:09:28.743] Timer tick, asking Buildbucket for the build status
[15:09:29.236] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:09:29.236] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:19:0) after 1m0s
[15:10:29.225] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:19:0)
[15:10:29.225] Timer tick, asking Buildbucket for the build status
[15:10:29.329] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:10:29.329] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:20:0) after 1m0s
[15:11:29.325] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:20:0)
[15:11:29.326] Timer tick, asking Buildbucket for the build status
[15:11:29.528] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:11:29.528] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:21:0) after 1m0s
[15:12:29.586] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:21:0)
[15:12:29.586] Timer tick, asking Buildbucket for the build status
[15:12:30.376] Build 8855945195581339536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:12:30.376] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:22:0) after 1m0s
[15:13:29.876] Received PubSub notification, asking Buildbucket for the build status
[15:13:29.937] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:30.414] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:22:0)
[15:13:30.414] Timer tick, asking Buildbucket for the build status
[15:13:30.480] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:30.480] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:24:0) after 1m0s
[15:14:30.575] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:24:0)
[15:14:30.575] Timer tick, asking Buildbucket for the build status
[15:14:30.778] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:30.778] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:25:0) after 1m0s
[15:15:30.811] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:25:0)
[15:15:30.811] Timer tick, asking Buildbucket for the build status
[15:15:30.962] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:30.962] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:26:0) after 1m0s
[15:16:30.984] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:26:0)
[15:16:30.984] Timer tick, asking Buildbucket for the build status
[15:16:31.336] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:31.336] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:27:0) after 1m0s
[15:17:31.357] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:27:0)
[15:17:31.357] Timer tick, asking Buildbucket for the build status
[15:17:31.729] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:31.729] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:28:0) after 1m0s
[15:18:31.756] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:28:0)
[15:18:31.756] Timer tick, asking Buildbucket for the build status
[15:18:32.062] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:32.062] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:29:0) after 1m0s
[15:19:32.030] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:29:0)
[15:19:32.030] Timer tick, asking Buildbucket for the build status
[15:19:32.227] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:32.227] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:30:0) after 1m0s
[15:20:32.200] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:30:0)
[15:20:32.200] Timer tick, asking Buildbucket for the build status
[15:20:32.269] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:32.269] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:31:0) after 1m0s
[15:21:32.351] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:31:0)
[15:21:32.351] Timer tick, asking Buildbucket for the build status
[15:21:32.408] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:32.408] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:32:0) after 1m0s
[15:22:32.501] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:32:0)
[15:22:32.501] Timer tick, asking Buildbucket for the build status
[15:22:32.845] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:32.845] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:33:0) after 1m0s
[15:23:32.900] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:33:0)
[15:23:32.900] Timer tick, asking Buildbucket for the build status
[15:23:32.973] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:32.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:34:0) after 1m0s
[15:24:33.013] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:34:0)
[15:24:33.013] Timer tick, asking Buildbucket for the build status
[15:24:33.133] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:33.133] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:35:0) after 1m0s
[15:25:33.235] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:35:0)
[15:25:33.235] Timer tick, asking Buildbucket for the build status
[15:25:33.290] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:33.290] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:36:0) after 1m0s
[15:26:33.310] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:36:0)
[15:26:33.310] Timer tick, asking Buildbucket for the build status
[15:26:33.465] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:33.465] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:37:0) after 1m0s
[15:27:33.483] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:37:0)
[15:27:33.483] Timer tick, asking Buildbucket for the build status
[15:27:33.811] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:33.811] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:38:0) after 1m0s
[15:28:33.833] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:38:0)
[15:28:33.833] Timer tick, asking Buildbucket for the build status
[15:28:34.033] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:34.033] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:39:0) after 1m0s
[15:29:34.065] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:39:0)
[15:29:34.065] Timer tick, asking Buildbucket for the build status
[15:29:34.320] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:34.320] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:40:0) after 1m0s
[15:30:34.344] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:40:0)
[15:30:34.344] Timer tick, asking Buildbucket for the build status
[15:30:34.424] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:34.424] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:41:0) after 1m0s
[15:31:34.486] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:41:0)
[15:31:34.486] Timer tick, asking Buildbucket for the build status
[15:31:34.675] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:34.675] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:42:0) after 1m0s
[15:32:34.855] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:42:0)
[15:32:34.855] Timer tick, asking Buildbucket for the build status
[15:32:34.961] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:34.961] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:43:0) after 1m0s
[15:33:35.016] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:43:0)
[15:33:35.016] Timer tick, asking Buildbucket for the build status
[15:33:35.089] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:35.089] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:44:0) after 1m0s
[15:34:35.293] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:44:0)
[15:34:35.293] Timer tick, asking Buildbucket for the build status
[15:34:35.376] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:35.376] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:45:0) after 1m0s
[15:35:36.632] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:45:0)
[15:35:36.632] Timer tick, asking Buildbucket for the build status
[15:35:36.719] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:36.719] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:46:0) after 1m0s
[15:36:36.922] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:46:0)
[15:36:36.922] Timer tick, asking Buildbucket for the build status
[15:36:37.211] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:37.211] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:47:0) after 1m0s
[15:37:37.600] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:47:0)
[15:37:37.600] Timer tick, asking Buildbucket for the build status
[15:37:37.924] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:37.924] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:48:0) after 1m0s
[15:38:38.085] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:48:0)
[15:38:38.085] Timer tick, asking Buildbucket for the build status
[15:38:38.699] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:38.699] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:49:0) after 1m0s
[15:39:38.860] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:49:0)
[15:39:38.860] Timer tick, asking Buildbucket for the build status
[15:39:39.203] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:39.203] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:50:0) after 1m0s
[15:40:39.222] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:50:0)
[15:40:39.222] Timer tick, asking Buildbucket for the build status
[15:40:39.289] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:39.289] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:51:0) after 1m0s
[15:41:39.342] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:51:0)
[15:41:39.342] Timer tick, asking Buildbucket for the build status
[15:41:39.408] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:39.408] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:52:0) after 1m0s
[15:42:39.462] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:52:0)
[15:42:39.462] Timer tick, asking Buildbucket for the build status
[15:42:39.760] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:39.760] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:53:0) after 1m0s
[15:43:39.905] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:53:0)
[15:43:39.905] Timer tick, asking Buildbucket for the build status
[15:43:40.021] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:40.021] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:54:0) after 1m0s
[15:44:40.107] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:54:0)
[15:44:40.107] Timer tick, asking Buildbucket for the build status
[15:44:40.205] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:40.205] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:55:0) after 1m0s
[15:45:40.272] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:55:0)
[15:45:40.272] Timer tick, asking Buildbucket for the build status
[15:45:40.405] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:40.405] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:56:0) after 1m0s
[15:46:40.485] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:56:0)
[15:46:40.485] Timer tick, asking Buildbucket for the build status
[15:46:40.623] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:40.623] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:57:0) after 1m0s
[15:47:40.609] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:57:0)
[15:47:40.609] Timer tick, asking Buildbucket for the build status
[15:47:40.708] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:40.708] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:58:0) after 1m0s
[15:48:40.728] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:58:0)
[15:48:40.728] Timer tick, asking Buildbucket for the build status
[15:48:40.789] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:40.790] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:59:0) after 1m0s
[15:49:40.908] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:59:0)
[15:49:40.908] Timer tick, asking Buildbucket for the build status
[15:49:40.967] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:40.967] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:60:0) after 1m0s
[15:50:41.165] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:60:0)
[15:50:41.165] Timer tick, asking Buildbucket for the build status
[15:50:41.224] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:41.224] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:61:0) after 1m0s
[15:51:41.341] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:61:0)
[15:51:41.341] Timer tick, asking Buildbucket for the build status
[15:51:41.711] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:41.712] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:62:0) after 1m0s
[15:52:41.769] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:62:0)
[15:52:41.769] Timer tick, asking Buildbucket for the build status
[15:52:44.970] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:44.970] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:63:0) after 1m0s
[15:53:45.009] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:63:0)
[15:53:45.009] Timer tick, asking Buildbucket for the build status
[15:53:45.150] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:45.150] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:64:0) after 1m0s
[15:54:45.212] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:64:0)
[15:54:45.212] Timer tick, asking Buildbucket for the build status
[15:54:45.622] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:45.622] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:65:0) after 1m0s
[15:55:45.724] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:65:0)
[15:55:45.724] Timer tick, asking Buildbucket for the build status
[15:55:45.790] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:45.790] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:66:0) after 1m0s
[15:56:45.844] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:66:0)
[15:56:45.844] Timer tick, asking Buildbucket for the build status
[15:56:45.919] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:45.919] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:67:0) after 1m0s
[15:57:45.903] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:67:0)
[15:57:45.903] Timer tick, asking Buildbucket for the build status
[15:57:46.142] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:46.142] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:68:0) after 1m0s
[15:58:46.175] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:68:0)
[15:58:46.175] Timer tick, asking Buildbucket for the build status
[15:58:46.237] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:46.237] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:69:0) after 1m0s
[15:59:46.273] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:69:0)
[15:59:46.273] Timer tick, asking Buildbucket for the build status
[15:59:46.567] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:46.567] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:70:0) after 1m0s
[16:00:46.602] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:70:0)
[16:00:46.602] Timer tick, asking Buildbucket for the build status
[16:00:46.895] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:46.895] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:71:0) after 1m0s
[16:01:46.954] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:71:0)
[16:01:46.954] Timer tick, asking Buildbucket for the build status
[16:01:47.011] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:47.011] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:72:0) after 1m0s
[16:02:47.037] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:72:0)
[16:02:47.037] Timer tick, asking Buildbucket for the build status
[16:02:47.191] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:47.191] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:73:0) after 1m0s
[16:03:47.278] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:73:0)
[16:03:47.278] Timer tick, asking Buildbucket for the build status
[16:03:47.451] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:47.451] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:74:0) after 1m0s
[16:04:47.535] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:74:0)
[16:04:47.535] Timer tick, asking Buildbucket for the build status
[16:04:47.689] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:47.689] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:75:0) after 1m0s
[16:05:47.902] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:75:0)
[16:05:47.903] Timer tick, asking Buildbucket for the build status
[16:05:48.734] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:48.734] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:76:0) after 1m0s
[16:06:49.243] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:76:0)
[16:06:49.243] Timer tick, asking Buildbucket for the build status
[16:06:49.514] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:49.514] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:77:0) after 1m0s
[16:07:50.130] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:77:0)
[16:07:50.130] Timer tick, asking Buildbucket for the build status
[16:07:50.247] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:50.247] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:78:0) after 1m0s
[16:08:50.403] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:78:0)
[16:08:50.403] Timer tick, asking Buildbucket for the build status
[16:08:50.777] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:50.777] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:79:0) after 1m0s
[16:09:51.095] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:79:0)
[16:09:51.096] Timer tick, asking Buildbucket for the build status
[16:09:51.159] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:51.159] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:80:0) after 1m0s
[16:10:51.328] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:80:0)
[16:10:51.328] Timer tick, asking Buildbucket for the build status
[16:10:51.388] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:51.388] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:81:0) after 1m0s
[16:11:51.572] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:81:0)
[16:11:51.572] Timer tick, asking Buildbucket for the build status
[16:11:51.843] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:51.843] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:82:0) after 1m0s
[16:12:52.019] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:82:0)
[16:12:52.019] Timer tick, asking Buildbucket for the build status
[16:12:52.525] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:52.525] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:83:0) after 1m0s
[16:13:52.678] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:83:0)
[16:13:52.678] Timer tick, asking Buildbucket for the build status
[16:13:52.835] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:52.835] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:84:0) after 1m0s
[16:14:52.908] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:84:0)
[16:14:52.908] Timer tick, asking Buildbucket for the build status
[16:14:52.983] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:52.983] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:85:0) after 1m0s
[16:15:53.123] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:85:0)
[16:15:53.123] Timer tick, asking Buildbucket for the build status
[16:15:53.178] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:53.179] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:86:0) after 1m0s
[16:16:53.448] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:86:0)
[16:16:53.448] Timer tick, asking Buildbucket for the build status
[16:16:53.525] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:53.525] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:87:0) after 1m0s
[16:17:53.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:87:0)
[16:17:53.631] Timer tick, asking Buildbucket for the build status
[16:17:54.215] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:54.215] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:88:0) after 1m0s
[16:18:54.352] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:88:0)
[16:18:54.352] Timer tick, asking Buildbucket for the build status
[16:18:54.418] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:54.418] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:89:0) after 1m0s
[16:19:54.557] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:89:0)
[16:19:54.557] Timer tick, asking Buildbucket for the build status
[16:19:54.723] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:54.723] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:90:0) after 1m0s
[16:20:54.822] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:90:0)
[16:20:54.822] Timer tick, asking Buildbucket for the build status
[16:20:54.896] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:54.896] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:91:0) after 1m0s
[16:21:54.982] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:91:0)
[16:21:54.982] Timer tick, asking Buildbucket for the build status
[16:21:55.328] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:55.328] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:92:0) after 1m0s
[16:22:55.350] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:92:0)
[16:22:55.350] Timer tick, asking Buildbucket for the build status
[16:22:55.682] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:55.682] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:93:0) after 1m0s
[16:23:55.761] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:93:0)
[16:23:55.761] Timer tick, asking Buildbucket for the build status
[16:23:56.403] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:56.403] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:94:0) after 1m0s
[16:24:56.449] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:94:0)
[16:24:56.449] Timer tick, asking Buildbucket for the build status
[16:24:56.569] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:56.569] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:95:0) after 1m0s
[16:25:56.591] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:95:0)
[16:25:56.591] Timer tick, asking Buildbucket for the build status
[16:25:56.650] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:56.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:96:0) after 1m0s
[16:26:56.703] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:96:0)
[16:26:56.704] Timer tick, asking Buildbucket for the build status
[16:26:56.773] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:56.773] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:97:0) after 1m0s
[16:27:56.773] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:97:0)
[16:27:56.773] Timer tick, asking Buildbucket for the build status
[16:27:56.871] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:56.871] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:98:0) after 1m0s
[16:28:56.903] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:98:0)
[16:28:56.903] Timer tick, asking Buildbucket for the build status
[16:28:57.232] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:57.232] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:99:0) after 1m0s
[16:29:57.257] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:99:0)
[16:29:57.257] Timer tick, asking Buildbucket for the build status
[16:29:57.395] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:57.395] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:100:0) after 1m0s
[16:30:57.424] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:100:0)
[16:30:57.424] Timer tick, asking Buildbucket for the build status
[16:30:57.496] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:57.496] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:101:0) after 1m0s
[16:31:57.527] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:101:0)
[16:31:57.527] Timer tick, asking Buildbucket for the build status
[16:31:57.984] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:57.984] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:102:0) after 1m0s
[16:32:58.016] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:102:0)
[16:32:58.016] Timer tick, asking Buildbucket for the build status
[16:32:58.457] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:58.458] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:103:0) after 1m0s
[16:33:58.480] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:103:0)
[16:33:58.480] Timer tick, asking Buildbucket for the build status
[16:33:58.551] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:58.551] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:104:0) after 1m0s
[16:34:58.576] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:104:0)
[16:34:58.576] Timer tick, asking Buildbucket for the build status
[16:34:58.648] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:58.649] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:105:0) after 1m0s
[16:35:58.683] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:105:0)
[16:35:58.683] Timer tick, asking Buildbucket for the build status
[16:35:58.814] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:58.814] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:106:0) after 1m0s
[16:36:58.888] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:106:0)
[16:36:58.888] Timer tick, asking Buildbucket for the build status
[16:36:59.236] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:59.236] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:107:0) after 1m0s
[16:37:59.260] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:107:0)
[16:37:59.260] Timer tick, asking Buildbucket for the build status
[16:37:59.354] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:59.354] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:108:0) after 1m0s
[16:38:59.384] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:108:0)
[16:38:59.384] Timer tick, asking Buildbucket for the build status
[16:38:59.462] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:59.462] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:109:0) after 1m0s
[16:39:59.453] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:109:0)
[16:39:59.453] Timer tick, asking Buildbucket for the build status
[16:39:59.561] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:59.561] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:110:0) after 1m0s
[16:40:59.636] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:110:0)
[16:40:59.636] Timer tick, asking Buildbucket for the build status
[16:40:59.763] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:59.763] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:111:0) after 1m0s
[16:41:59.814] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:111:0)
[16:41:59.814] Timer tick, asking Buildbucket for the build status
[16:41:59.872] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:59.872] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:112:0) after 1m0s
[16:42:59.896] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:112:0)
[16:42:59.896] Timer tick, asking Buildbucket for the build status
[16:43:00.001] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:00.001] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:113:0) after 1m0s
[16:44:00.023] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:113:0)
[16:44:00.023] Timer tick, asking Buildbucket for the build status
[16:44:00.393] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:00.393] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:114:0) after 1m0s
[16:45:00.521] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:114:0)
[16:45:00.521] Timer tick, asking Buildbucket for the build status
[16:45:00.593] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:00.593] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:115:0) after 1m0s
[16:46:00.651] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:115:0)
[16:46:00.651] Timer tick, asking Buildbucket for the build status
[16:46:00.791] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:00.791] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:116:0) after 1m0s
[16:47:00.817] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:116:0)
[16:47:00.817] Timer tick, asking Buildbucket for the build status
[16:47:00.985] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:00.985] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:117:0) after 1m0s
[16:48:01.057] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:117:0)
[16:48:01.057] Timer tick, asking Buildbucket for the build status
[16:48:01.323] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:01.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:118:0) after 1m0s
[16:49:01.349] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:118:0)
[16:49:01.349] Timer tick, asking Buildbucket for the build status
[16:49:01.473] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:01.473] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:119:0) after 1m0s
[16:50:01.498] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:119:0)
[16:50:01.498] Timer tick, asking Buildbucket for the build status
[16:50:02.252] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:02.252] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:120:0) after 1m0s
[16:51:02.307] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:120:0)
[16:51:02.307] Timer tick, asking Buildbucket for the build status
[16:51:02.367] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:02.367] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:121:0) after 1m0s
[16:52:02.341] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:121:0)
[16:52:02.341] Timer tick, asking Buildbucket for the build status
[16:52:02.432] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:02.432] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:122:0) after 1m0s
[16:53:02.499] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:122:0)
[16:53:02.499] Timer tick, asking Buildbucket for the build status
[16:53:02.853] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:02.853] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:123:0) after 1m0s
[16:54:02.871] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:123:0)
[16:54:02.871] Timer tick, asking Buildbucket for the build status
[16:54:02.933] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:02.933] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:124:0) after 1m0s
[16:55:02.973] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:124:0)
[16:55:02.973] Timer tick, asking Buildbucket for the build status
[16:55:03.040] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:03.040] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:125:0) after 1m0s
[16:56:03.065] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:125:0)
[16:56:03.065] Timer tick, asking Buildbucket for the build status
[16:56:03.216] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:03.216] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:126:0) after 1m0s
[16:57:03.246] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:126:0)
[16:57:03.246] Timer tick, asking Buildbucket for the build status
[16:57:03.442] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:03.442] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:127:0) after 1m0s
[16:58:03.515] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:127:0)
[16:58:03.515] Timer tick, asking Buildbucket for the build status
[16:58:03.781] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:03.781] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:128:0) after 1m0s
[16:59:03.801] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:128:0)
[16:59:03.801] Timer tick, asking Buildbucket for the build status
[16:59:03.858] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:03.858] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:129:0) after 1m0s
[17:00:03.894] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:129:0)
[17:00:03.894] Timer tick, asking Buildbucket for the build status
[17:00:04.016] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:04.016] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:130:0) after 1m0s
[17:01:04.091] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:130:0)
[17:01:04.091] Timer tick, asking Buildbucket for the build status
[17:01:04.157] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:04.157] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:131:0) after 1m0s
[17:02:04.179] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:131:0)
[17:02:04.179] Timer tick, asking Buildbucket for the build status
[17:02:04.499] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:04.499] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:132:0) after 1m0s
[17:03:04.567] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:132:0)
[17:03:04.567] Timer tick, asking Buildbucket for the build status
[17:03:04.893] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:04.893] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:133:0) after 1m0s
[17:04:06.302] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:133:0)
[17:04:06.302] Timer tick, asking Buildbucket for the build status
[17:04:06.361] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:06.361] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:134:0) after 1m0s
[17:05:06.835] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:134:0)
[17:05:06.835] Timer tick, asking Buildbucket for the build status
[17:05:07.094] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:07.096] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:135:0) after 1m0s
[17:06:07.575] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:135:0)
[17:06:07.575] Timer tick, asking Buildbucket for the build status
[17:06:07.893] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:07.894] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:136:0) after 1m0s
[17:07:08.061] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:136:0)
[17:07:08.061] Timer tick, asking Buildbucket for the build status
[17:07:08.203] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:08.203] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:137:0) after 1m0s
[17:08:08.326] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:137:0)
[17:08:08.326] Timer tick, asking Buildbucket for the build status
[17:08:09.224] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:09.224] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:138:0) after 1m0s
[17:09:09.414] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:138:0)
[17:09:09.414] Timer tick, asking Buildbucket for the build status
[17:09:09.555] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:09.555] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:139:0) after 1m0s
[17:10:09.680] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:139:0)
[17:10:09.680] Timer tick, asking Buildbucket for the build status
[17:10:09.750] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:09.750] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:140:0) after 1m0s
[17:11:10.389] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:140:0)
[17:11:10.389] Timer tick, asking Buildbucket for the build status
[17:11:10.580] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:10.581] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:141:0) after 1m0s
[17:12:10.655] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:141:0)
[17:12:10.655] Timer tick, asking Buildbucket for the build status
[17:12:10.706] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:10.706] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:142:0) after 1m0s
[17:13:10.769] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:142:0)
[17:13:10.769] Timer tick, asking Buildbucket for the build status
[17:13:11.013] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:11.013] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:143:0) after 1m0s
[17:14:11.091] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:143:0)
[17:14:11.091] Timer tick, asking Buildbucket for the build status
[17:14:11.171] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:11.171] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:144:0) after 1m0s
[17:15:11.327] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:144:0)
[17:15:11.327] Timer tick, asking Buildbucket for the build status
[17:15:11.676] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:11.676] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:145:0) after 1m0s
[17:16:11.857] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:145:0)
[17:16:11.857] Timer tick, asking Buildbucket for the build status
[17:16:11.924] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:11.924] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:146:0) after 1m0s
[17:17:12.054] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:146:0)
[17:17:12.054] Timer tick, asking Buildbucket for the build status
[17:17:12.128] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:12.128] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:147:0) after 1m0s
[17:18:12.583] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:147:0)
[17:18:12.583] Timer tick, asking Buildbucket for the build status
[17:18:12.702] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:12.702] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:148:0) after 1m0s
[17:19:12.792] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:148:0)
[17:19:12.792] Timer tick, asking Buildbucket for the build status
[17:19:12.889] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:12.889] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:149:0) after 1m0s
[17:20:12.960] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:149:0)
[17:20:12.960] Timer tick, asking Buildbucket for the build status
[17:20:13.022] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:13.023] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:150:0) after 1m0s
[17:21:13.091] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:150:0)
[17:21:13.091] Timer tick, asking Buildbucket for the build status
[17:21:13.161] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:13.161] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:151:0) after 1m0s
[17:22:13.301] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:151:0)
[17:22:13.301] Timer tick, asking Buildbucket for the build status
[17:22:13.436] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:13.437] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:152:0) after 1m0s
[17:23:13.596] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:152:0)
[17:23:13.596] Timer tick, asking Buildbucket for the build status
[17:23:13.681] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:13.681] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:153:0) after 1m0s
[17:24:13.706] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:153:0)
[17:24:13.706] Timer tick, asking Buildbucket for the build status
[17:24:13.763] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:13.763] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:154:0) after 1m0s
[17:25:13.815] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:154:0)
[17:25:13.815] Timer tick, asking Buildbucket for the build status
[17:25:14.054] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:14.054] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:155:0) after 1m0s
[17:26:14.076] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:155:0)
[17:26:14.076] Timer tick, asking Buildbucket for the build status
[17:26:14.176] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:14.176] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:156:0) after 1m0s
[17:27:14.254] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:156:0)
[17:27:14.254] Timer tick, asking Buildbucket for the build status
[17:27:14.609] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:14.609] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:157:0) after 1m0s
[17:28:14.696] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:157:0)
[17:28:14.696] Timer tick, asking Buildbucket for the build status
[17:28:15.418] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:15.418] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:158:0) after 1m0s
[17:29:15.645] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:158:0)
[17:29:15.645] Timer tick, asking Buildbucket for the build status
[17:29:15.822] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:15.822] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:159:0) after 1m0s
[17:30:15.966] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:159:0)
[17:30:15.966] Timer tick, asking Buildbucket for the build status
[17:30:16.164] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:16.164] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:160:0) after 1m0s
[17:31:16.197] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:160:0)
[17:31:16.197] Timer tick, asking Buildbucket for the build status
[17:31:16.513] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:16.513] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:161:0) after 1m0s
[17:32:16.539] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:161:0)
[17:32:16.539] Timer tick, asking Buildbucket for the build status
[17:32:16.596] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:16.596] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:162:0) after 1m0s
[17:33:16.630] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:162:0)
[17:33:16.631] Timer tick, asking Buildbucket for the build status
[17:33:16.827] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:16.827] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:163:0) after 1m0s
[17:34:16.853] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:163:0)
[17:34:16.853] Timer tick, asking Buildbucket for the build status
[17:34:16.925] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:16.925] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:164:0) after 1m0s
[17:35:16.951] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:164:0)
[17:35:16.951] Timer tick, asking Buildbucket for the build status
[17:35:17.323] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:17.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:165:0) after 1m0s
[17:36:17.406] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:165:0)
[17:36:17.406] Timer tick, asking Buildbucket for the build status
[17:36:17.536] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:17.536] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:166:0) after 1m0s
[17:37:17.634] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:166:0)
[17:37:17.634] Timer tick, asking Buildbucket for the build status
[17:37:17.686] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:17.686] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:167:0) after 1m0s
[17:38:17.707] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:167:0)
[17:38:17.707] Timer tick, asking Buildbucket for the build status
[17:38:17.831] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:17.831] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:168:0) after 1m0s
[17:39:17.962] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:168:0)
[17:39:17.962] Timer tick, asking Buildbucket for the build status
[17:39:18.041] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:18.041] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:169:0) after 1m0s
[17:40:18.215] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:169:0)
[17:40:18.216] Timer tick, asking Buildbucket for the build status
[17:40:18.271] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:18.271] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:170:0) after 1m0s
[17:41:18.391] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:170:0)
[17:41:18.391] Timer tick, asking Buildbucket for the build status
[17:41:18.451] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:18.451] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:171:0) after 1m0s
[17:42:18.599] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:171:0)
[17:42:18.599] Timer tick, asking Buildbucket for the build status
[17:42:18.691] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:18.691] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:172:0) after 1m0s
[17:43:18.803] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:172:0)
[17:43:18.803] Timer tick, asking Buildbucket for the build status
[17:43:18.915] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:18.915] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:173:0) after 1m0s
[17:44:20.055] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:173:0)
[17:44:20.055] Timer tick, asking Buildbucket for the build status
[17:44:20.137] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:20.137] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:174:0) after 1m0s
[17:45:20.141] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:174:0)
[17:45:20.141] Timer tick, asking Buildbucket for the build status
[17:45:22.946] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:22.946] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:175:0) after 1m0s
[17:46:22.981] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:175:0)
[17:46:22.981] Timer tick, asking Buildbucket for the build status
[17:46:23.185] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:23.185] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:176:0) after 1m0s
[17:47:23.212] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:176:0)
[17:47:23.212] Timer tick, asking Buildbucket for the build status
[17:47:23.513] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:23.513] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:177:0) after 1m0s
[17:48:23.538] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:177:0)
[17:48:23.538] Timer tick, asking Buildbucket for the build status
[17:48:23.642] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:23.642] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:178:0) after 1m0s
[17:49:23.667] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:178:0)
[17:49:23.667] Timer tick, asking Buildbucket for the build status
[17:49:23.755] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:23.755] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:179:0) after 1m0s
[17:50:23.782] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:179:0)
[17:50:23.782] Timer tick, asking Buildbucket for the build status
[17:50:23.896] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:23.896] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:180:0) after 1m0s
[17:51:23.874] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:180:0)
[17:51:23.874] Timer tick, asking Buildbucket for the build status
[17:51:24.263] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:24.263] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:181:0) after 1m0s
[17:52:24.253] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:181:0)
[17:52:24.253] Timer tick, asking Buildbucket for the build status
[17:52:25.009] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:25.009] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:182:0) after 1m0s
[17:53:25.033] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:182:0)
[17:53:25.033] Timer tick, asking Buildbucket for the build status
[17:53:25.344] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:25.344] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:183:0) after 1m0s
[17:54:25.404] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:183:0)
[17:54:25.404] Timer tick, asking Buildbucket for the build status
[17:54:25.593] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:25.593] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:184:0) after 1m0s
[17:55:25.621] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:184:0)
[17:55:25.621] Timer tick, asking Buildbucket for the build status
[17:55:25.896] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:25.896] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:185:0) after 1m0s
[17:56:25.921] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:185:0)
[17:56:25.921] Timer tick, asking Buildbucket for the build status
[17:56:26.321] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:26.321] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:186:0) after 1m0s
[17:57:26.346] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:186:0)
[17:57:26.346] Timer tick, asking Buildbucket for the build status
[17:57:26.835] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:26.835] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:187:0) after 1m0s
[17:58:26.836] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:187:0)
[17:58:26.836] Timer tick, asking Buildbucket for the build status
[17:58:26.929] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:26.929] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:188:0) after 1m0s
[17:59:27.004] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:188:0)
[17:59:27.004] Timer tick, asking Buildbucket for the build status
[17:59:27.061] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:27.061] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:189:0) after 1m0s
[18:00:27.100] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:189:0)
[18:00:27.100] Timer tick, asking Buildbucket for the build status
[18:00:27.385] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:27.385] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:190:0) after 1m0s
[18:01:27.504] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:190:0)
[18:01:27.504] Timer tick, asking Buildbucket for the build status
[18:01:27.628] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:27.628] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:191:0) after 1m0s
[18:02:27.758] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:191:0)
[18:02:27.758] Timer tick, asking Buildbucket for the build status
[18:02:27.866] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:27.866] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:192:0) after 1m0s
[18:03:27.933] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:192:0)
[18:03:27.933] Timer tick, asking Buildbucket for the build status
[18:03:28.049] Build 8855945195581339536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:28.049] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021375257480346272:193:0) after 1m0s
[18:03:51.664] Received PubSub notification, asking Buildbucket for the build status
[18:03:51.901] Build 8855945195581339536: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:03:51.901] Buildbucket build:
{
  "build": {
    "bucket": "luci.chromium.ci",
    "canary_preference": "PROD",
    "completed_ts": "1612721030883032",
    "created_by": "project:chromium",
    "created_ts": "1612709541680328",
    "id": "8855945195581339536",
    "parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90471f3bb04b956e135ea6fe8b227118d03b2f1c\"}}",
    "project": "chromium",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"90471f3bb04b956e135ea6fe8b227118d03b2f1c\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-4-lrbu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1508, \"got_angle_revision\": \"580961fbb01984d2d9b2f382609f9fc0c44e6b82\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"90471f3bb04b956e135ea6fe8b227118d03b2f1c\", \"got_revision_cp\": \"refs/heads/master@{#851538}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"462378addab907ab7452d38baccb27fe2ef7289a\", \"got_v8_revision_cp\": \"refs/heads/9.0.138@{#1}\", \"got_webrtc_revision\": \"c3c63c8ceaf4ac3646b1e17bfe8a97e7102f0913\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33185}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90471f3bb04b956e135ea6fe8b227118d03b2f1c\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-lrbu\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5676-c76598c\"], \"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": "1612710808715848",
    "status": "COMPLETED",
    "status_changed_ts": "1612721031323989",
    "tags": [
      "build_address:luci.chromium.ci/win32-official/1508",
      "builder:win32-official",
      "buildset:commit/git/90471f3bb04b956e135ea6fe8b227118d03b2f1c",
      "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90471f3bb04b956e135ea6fe8b227118d03b2f1c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021375257480346272",
      "scheduler_job_id:chromium/win32-official",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855945195581339536/+/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:5195cc41d3822310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612721031353000",
    "url": "https://ci.chromium.org/b/8855945195581339536",
    "utcnow_ts": "1612721031834264"
  }
}
[18:03:51.901] Invocation finished in 3h11m31.414768508s with status SUCCEEDED