buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.nacl.toolchain"
  builder: "linux-pnacl-x86_64"
>

• 058a26f57015051953a727add26e7e26348b9558 (5 years ago)

{
  "branch": "refs/heads/master",
  "repository": "https://chromium.googlesource.com/native_client/src/native_client.git",
  "revision": "058a26f57015051953a727add26e7e26348b9558"
}

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

[23:47:59.017] New invocation is queued and will start shortly
[23:48:01.616] Starting the invocation (attempt 1)
[23:48:01.661] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:48:01.661] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:48:01.662] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9073887798318113200",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"058a26f57015051953a727add26e7e26348b9558\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@058a26f57015051953a727add26e7e26348b9558\",\"title\":\"058a26f57015051953a727add26e7e26348b9558\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/058a26f57015051953a727add26e7e26348b9558\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"058a26f57015051953a727add26e7e26348b9558\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-pnacl-x86_64",
    "scheduler_invocation_id:9073887798318113200",
    "scheduler_job_id:nacl/linux-pnacl-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/058a26f57015051953a727add26e7e26348b9558",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/058a26f57015051953a727add26e7e26348b9558",
    "gitiles_ref:refs/heads/master"
  ]
}
[23:48:02.437] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1562629681773615",
    "id": "8908457734763280400",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"058a26f57015051953a727add26e7e26348b9558\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@058a26f57015051953a727add26e7e26348b9558\", \"title\": \"058a26f57015051953a727add26e7e26348b9558\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/058a26f57015051953a727add26e7e26348b9558\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"058a26f57015051953a727add26e7e26348b9558\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1562629682215962",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7039",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/058a26f57015051953a727add26e7e26348b9558",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/058a26f57015051953a727add26e7e26348b9558",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9073887798318113200",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8908457734763280400/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1562629682216063",
    "url": "https://ci.chromium.org/b/8908457734763280400",
    "utcnow_ts": "1562629682427082"
  }
}
[23:48:02.437] Task URL: https://ci.chromium.org/b/8908457734763280400
[23:48:02.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:2:0) after 1m0s
[23:49:02.433] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:2:0)
[23:49:02.433] Timer tick, asking Buildbucket for the build status
[23:49:02.904] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:02.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:3:0) after 1m0s
[23:50:02.925] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:3:0)
[23:50:02.925] Timer tick, asking Buildbucket for the build status
[23:50:03.096] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:03.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:4:0) after 1m0s
[23:51:03.140] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:4:0)
[23:51:03.140] Timer tick, asking Buildbucket for the build status
[23:51:03.540] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:03.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:5:0) after 1m0s
[23:52:03.607] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:5:0)
[23:52:03.607] Timer tick, asking Buildbucket for the build status
[23:52:04.612] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:04.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:6:0) after 1m0s
[23:53:04.732] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:6:0)
[23:53:04.732] Timer tick, asking Buildbucket for the build status
[23:53:04.825] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:04.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:7:0) after 1m0s
[23:54:04.987] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:7:0)
[23:54:04.987] Timer tick, asking Buildbucket for the build status
[23:54:07.122] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:07.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:8:0) after 1m0s
[23:55:07.211] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:8:0)
[23:55:07.211] Timer tick, asking Buildbucket for the build status
[23:55:07.316] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:07.316] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:9:0) after 1m0s
[23:56:07.514] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:9:0)
[23:56:07.514] Timer tick, asking Buildbucket for the build status
[23:56:07.605] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:07.605] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:10:0) after 1m0s
[23:57:07.642] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:10:0)
[23:57:07.642] Timer tick, asking Buildbucket for the build status
[23:57:07.751] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:07.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:11:0) after 1m0s
[23:58:07.807] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:11:0)
[23:58:07.807] Timer tick, asking Buildbucket for the build status
[23:58:08.213] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:08.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:12:0) after 1m0s
[23:59:08.243] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:12:0)
[23:59:08.243] Timer tick, asking Buildbucket for the build status
[23:59:08.379] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:08.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:13:0) after 1m0s
[00:00:08.669] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:13:0)
[00:00:08.669] Timer tick, asking Buildbucket for the build status
[00:00:09.250] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:09.250] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:14:0) after 1m0s
[00:01:09.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:14:0)
[00:01:09.491] Timer tick, asking Buildbucket for the build status
[00:01:09.773] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:09.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:15:0) after 1m0s
[00:02:09.874] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:15:0)
[00:02:09.874] Timer tick, asking Buildbucket for the build status
[00:02:09.985] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:09.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:16:0) after 1m0s
[00:03:10.014] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:16:0)
[00:03:10.014] Timer tick, asking Buildbucket for the build status
[00:03:10.980] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:10.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:17:0) after 1m0s
[00:04:11.069] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:17:0)
[00:04:11.069] Timer tick, asking Buildbucket for the build status
[00:04:11.256] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:11.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:18:0) after 1m0s
[00:05:11.285] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:18:0)
[00:05:11.285] Timer tick, asking Buildbucket for the build status
[00:05:12.065] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:12.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:19:0) after 1m0s
[00:06:12.196] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:19:0)
[00:06:12.196] Timer tick, asking Buildbucket for the build status
[00:06:12.309] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:12.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:20:0) after 1m0s
[00:07:12.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:20:0)
[00:07:12.354] Timer tick, asking Buildbucket for the build status
[00:07:12.492] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:12.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:21:0) after 1m0s
[00:08:12.524] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:21:0)
[00:08:12.524] Timer tick, asking Buildbucket for the build status
[00:08:12.717] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:12.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:22:0) after 1m0s
[00:09:12.746] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:22:0)
[00:09:12.746] Timer tick, asking Buildbucket for the build status
[00:09:13.750] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:13.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:23:0) after 1m0s
[00:10:13.757] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:23:0)
[00:10:13.758] Timer tick, asking Buildbucket for the build status
[00:10:14.532] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:14.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:24:0) after 1m0s
[00:11:14.665] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:24:0)
[00:11:14.665] Timer tick, asking Buildbucket for the build status
[00:11:15.373] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:15.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:25:0) after 1m0s
[00:12:15.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:25:0)
[00:12:15.597] Timer tick, asking Buildbucket for the build status
[00:12:15.936] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:15.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:26:0) after 1m0s
[00:13:16.037] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:26:0)
[00:13:16.037] Timer tick, asking Buildbucket for the build status
[00:13:17.008] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:17.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:27:0) after 1m0s
[00:14:17.269] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:27:0)
[00:14:17.269] Timer tick, asking Buildbucket for the build status
[00:14:17.421] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:17.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:28:0) after 1m0s
[00:15:17.483] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:28:0)
[00:15:17.483] Timer tick, asking Buildbucket for the build status
[00:15:17.623] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:17.623] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:29:0) after 1m0s
[00:16:17.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:29:0)
[00:16:17.646] Timer tick, asking Buildbucket for the build status
[00:16:18.285] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:18.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:30:0) after 1m0s
[00:17:18.322] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:30:0)
[00:17:18.322] Timer tick, asking Buildbucket for the build status
[00:17:18.518] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:18.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:31:0) after 1m0s
[00:18:18.620] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:31:0)
[00:18:18.620] Timer tick, asking Buildbucket for the build status
[00:18:19.349] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:19.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:32:0) after 1m0s
[00:19:19.421] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:32:0)
[00:19:19.421] Timer tick, asking Buildbucket for the build status
[00:19:19.821] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:19.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:33:0) after 1m0s
[00:20:19.914] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:33:0)
[00:20:19.914] Timer tick, asking Buildbucket for the build status
[00:20:20.950] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:20.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:34:0) after 1m0s
[00:21:21.051] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:34:0)
[00:21:21.051] Timer tick, asking Buildbucket for the build status
[00:21:21.324] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:21.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:35:0) after 1m0s
[00:22:21.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:35:0)
[00:22:21.721] Timer tick, asking Buildbucket for the build status
[00:22:22.113] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:22.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:36:0) after 1m0s
[00:23:22.214] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:36:0)
[00:23:22.214] Timer tick, asking Buildbucket for the build status
[00:23:22.898] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:22.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:37:0) after 1m0s
[00:24:23.022] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:37:0)
[00:24:23.022] Timer tick, asking Buildbucket for the build status
[00:24:23.329] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:23.329] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:38:0) after 1m0s
[00:25:23.478] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:38:0)
[00:25:23.478] Timer tick, asking Buildbucket for the build status
[00:25:23.966] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:23.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:39:0) after 1m0s
[00:26:23.970] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:39:0)
[00:26:23.970] Timer tick, asking Buildbucket for the build status
[00:26:24.142] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:24.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:40:0) after 1m0s
[00:27:24.224] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:40:0)
[00:27:24.224] Timer tick, asking Buildbucket for the build status
[00:27:24.285] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:24.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:41:0) after 1m0s
[00:28:24.346] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:41:0)
[00:28:24.346] Timer tick, asking Buildbucket for the build status
[00:28:24.552] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:24.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:42:0) after 1m0s
[00:29:24.662] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:42:0)
[00:29:24.662] Timer tick, asking Buildbucket for the build status
[00:29:24.798] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:24.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:43:0) after 1m0s
[00:30:24.869] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:43:0)
[00:30:24.869] Timer tick, asking Buildbucket for the build status
[00:30:25.540] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:25.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:44:0) after 1m0s
[00:31:25.602] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:44:0)
[00:31:25.602] Timer tick, asking Buildbucket for the build status
[00:31:26.341] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:26.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:45:0) after 1m0s
[00:32:26.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:45:0)
[00:32:26.396] Timer tick, asking Buildbucket for the build status
[00:32:26.528] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:26.529] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:46:0) after 1m0s
[00:33:26.550] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:46:0)
[00:33:26.550] Timer tick, asking Buildbucket for the build status
[00:33:27.055] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:27.055] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:47:0) after 1m0s
[00:34:27.087] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:47:0)
[00:34:27.087] Timer tick, asking Buildbucket for the build status
[00:34:27.237] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:27.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:48:0) after 1m0s
[00:35:27.213] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:48:0)
[00:35:27.213] Timer tick, asking Buildbucket for the build status
[00:35:27.394] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:27.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:49:0) after 1m0s
[00:36:27.458] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:49:0)
[00:36:27.458] Timer tick, asking Buildbucket for the build status
[00:36:27.554] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:27.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:50:0) after 1m0s
[00:37:27.579] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:50:0)
[00:37:27.579] Timer tick, asking Buildbucket for the build status
[00:37:28.001] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:28.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:51:0) after 1m0s
[00:38:28.062] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:51:0)
[00:38:28.062] Timer tick, asking Buildbucket for the build status
[00:38:28.323] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:28.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:52:0) after 1m0s
[00:39:28.411] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:52:0)
[00:39:28.411] Timer tick, asking Buildbucket for the build status
[00:39:28.599] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:28.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:53:0) after 1m0s
[00:40:28.694] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:53:0)
[00:40:28.694] Timer tick, asking Buildbucket for the build status
[00:40:28.850] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:28.850] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:54:0) after 1m0s
[00:41:28.944] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:54:0)
[00:41:28.944] Timer tick, asking Buildbucket for the build status
[00:41:29.305] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:29.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:55:0) after 1m0s
[00:42:29.348] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:55:0)
[00:42:29.348] Timer tick, asking Buildbucket for the build status
[00:42:29.526] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:29.526] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:56:0) after 1m0s
[00:43:29.567] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:56:0)
[00:43:29.567] Timer tick, asking Buildbucket for the build status
[00:43:29.995] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:29.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:57:0) after 1m0s
[00:44:30.058] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:57:0)
[00:44:30.058] Timer tick, asking Buildbucket for the build status
[00:44:30.688] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:30.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:58:0) after 1m0s
[00:45:30.770] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:58:0)
[00:45:30.770] Timer tick, asking Buildbucket for the build status
[00:45:30.859] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:30.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:59:0) after 1m0s
[00:46:30.927] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:59:0)
[00:46:30.927] Timer tick, asking Buildbucket for the build status
[00:46:31.252] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:31.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:60:0) after 1m0s
[00:47:31.283] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:60:0)
[00:47:31.283] Timer tick, asking Buildbucket for the build status
[00:47:32.256] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:32.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:61:0) after 1m0s
[00:48:32.296] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:61:0)
[00:48:32.296] Timer tick, asking Buildbucket for the build status
[00:48:32.786] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:32.786] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:62:0) after 1m0s
[00:49:32.814] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:62:0)
[00:49:32.814] Timer tick, asking Buildbucket for the build status
[00:49:32.960] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:32.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:63:0) after 1m0s
[00:50:33.037] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:63:0)
[00:50:33.037] Timer tick, asking Buildbucket for the build status
[00:50:33.293] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:33.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:64:0) after 1m0s
[00:51:33.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:64:0)
[00:51:33.325] Timer tick, asking Buildbucket for the build status
[00:51:33.456] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:33.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:65:0) after 1m0s
[00:52:33.484] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:65:0)
[00:52:33.484] Timer tick, asking Buildbucket for the build status
[00:52:33.612] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:33.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:66:0) after 1m0s
[00:53:33.658] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:66:0)
[00:53:33.658] Timer tick, asking Buildbucket for the build status
[00:53:33.828] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:33.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:67:0) after 1m0s
[00:54:33.881] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:67:0)
[00:54:33.881] Timer tick, asking Buildbucket for the build status
[00:54:33.980] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:33.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:68:0) after 1m0s
[00:55:34.026] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:68:0)
[00:55:34.026] Timer tick, asking Buildbucket for the build status
[00:55:34.241] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:34.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:69:0) after 1m0s
[00:56:34.265] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:69:0)
[00:56:34.265] Timer tick, asking Buildbucket for the build status
[00:56:34.372] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:34.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:70:0) after 1m0s
[00:57:34.410] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:70:0)
[00:57:34.410] Timer tick, asking Buildbucket for the build status
[00:57:34.514] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:34.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:71:0) after 1m0s
[00:58:34.523] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:71:0)
[00:58:34.523] Timer tick, asking Buildbucket for the build status
[00:58:34.648] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:34.648] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:72:0) after 1m0s
[00:59:34.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:72:0)
[00:59:34.671] Timer tick, asking Buildbucket for the build status
[00:59:34.815] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:34.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:73:0) after 1m0s
[01:00:34.895] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:73:0)
[01:00:34.895] Timer tick, asking Buildbucket for the build status
[01:00:34.994] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:34.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:74:0) after 1m0s
[01:01:35.082] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:74:0)
[01:01:35.082] Timer tick, asking Buildbucket for the build status
[01:01:36.196] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:36.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:75:0) after 1m0s
[01:02:36.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:75:0)
[01:02:36.202] Timer tick, asking Buildbucket for the build status
[01:02:36.309] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:36.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:76:0) after 1m0s
[01:03:36.366] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:76:0)
[01:03:36.366] Timer tick, asking Buildbucket for the build status
[01:03:36.457] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:36.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:77:0) after 1m0s
[01:04:36.550] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:77:0)
[01:04:36.550] Timer tick, asking Buildbucket for the build status
[01:04:37.241] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:37.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:78:0) after 1m0s
[01:05:37.312] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:78:0)
[01:05:37.312] Timer tick, asking Buildbucket for the build status
[01:05:37.683] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:37.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:79:0) after 1m0s
[01:06:37.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:79:0)
[01:06:37.749] Timer tick, asking Buildbucket for the build status
[01:06:37.922] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:37.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:80:0) after 1m0s
[01:07:38.017] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:80:0)
[01:07:38.017] Timer tick, asking Buildbucket for the build status
[01:07:38.413] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:38.413] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:81:0) after 1m0s
[01:08:38.462] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:81:0)
[01:08:38.462] Timer tick, asking Buildbucket for the build status
[01:08:38.622] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:38.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:82:0) after 1m0s
[01:09:38.725] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:82:0)
[01:09:38.725] Timer tick, asking Buildbucket for the build status
[01:09:38.831] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:38.832] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:83:0) after 1m0s
[01:10:38.929] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:83:0)
[01:10:38.929] Timer tick, asking Buildbucket for the build status
[01:10:39.430] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:39.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:84:0) after 1m0s
[01:11:39.461] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:84:0)
[01:11:39.461] Timer tick, asking Buildbucket for the build status
[01:11:39.709] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:39.709] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:85:0) after 1m0s
[01:12:39.685] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:85:0)
[01:12:39.685] Timer tick, asking Buildbucket for the build status
[01:12:39.813] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:39.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:86:0) after 1m0s
[01:13:39.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:86:0)
[01:13:39.843] Timer tick, asking Buildbucket for the build status
[01:13:40.123] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:40.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:87:0) after 1m0s
[01:14:40.188] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:87:0)
[01:14:40.188] Timer tick, asking Buildbucket for the build status
[01:14:40.308] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:40.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:88:0) after 1m0s
[01:15:40.360] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:88:0)
[01:15:40.360] Timer tick, asking Buildbucket for the build status
[01:15:40.533] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:40.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:89:0) after 1m0s
[01:16:40.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:89:0)
[01:16:40.740] Timer tick, asking Buildbucket for the build status
[01:16:40.897] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:40.897] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:90:0) after 1m0s
[01:17:40.919] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:90:0)
[01:17:40.919] Timer tick, asking Buildbucket for the build status
[01:17:41.397] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:41.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:91:0) after 1m0s
[01:18:41.490] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:91:0)
[01:18:41.490] Timer tick, asking Buildbucket for the build status
[01:18:41.654] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:41.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:92:0) after 1m0s
[01:19:41.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:92:0)
[01:19:41.773] Timer tick, asking Buildbucket for the build status
[01:19:42.050] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:42.050] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:93:0) after 1m0s
[01:20:42.104] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:93:0)
[01:20:42.104] Timer tick, asking Buildbucket for the build status
[01:20:42.271] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:42.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:94:0) after 1m0s
[01:21:42.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:94:0)
[01:21:42.300] Timer tick, asking Buildbucket for the build status
[01:21:42.633] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:42.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:95:0) after 1m0s
[01:22:42.661] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:95:0)
[01:22:42.661] Timer tick, asking Buildbucket for the build status
[01:22:42.934] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:42.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:96:0) after 1m0s
[01:23:42.964] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:96:0)
[01:23:42.964] Timer tick, asking Buildbucket for the build status
[01:23:43.073] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:43.073] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:97:0) after 1m0s
[01:24:43.064] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:97:0)
[01:24:43.064] Timer tick, asking Buildbucket for the build status
[01:24:43.241] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:43.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:98:0) after 1m0s
[01:25:43.332] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:98:0)
[01:25:43.332] Timer tick, asking Buildbucket for the build status
[01:25:43.672] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:43.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:99:0) after 1m0s
[01:26:43.883] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:99:0)
[01:26:43.883] Timer tick, asking Buildbucket for the build status
[01:26:44.028] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:44.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:100:0) after 1m0s
[01:27:44.136] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:100:0)
[01:27:44.136] Timer tick, asking Buildbucket for the build status
[01:27:44.397] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:44.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:101:0) after 1m0s
[01:28:44.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:101:0)
[01:28:44.554] Timer tick, asking Buildbucket for the build status
[01:28:44.696] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:44.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:102:0) after 1m0s
[01:29:44.714] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:102:0)
[01:29:44.714] Timer tick, asking Buildbucket for the build status
[01:29:44.853] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:44.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:103:0) after 1m0s
[01:30:45.016] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:103:0)
[01:30:45.016] Timer tick, asking Buildbucket for the build status
[01:30:45.401] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:45.401] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:104:0) after 1m0s
[01:31:45.462] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:104:0)
[01:31:45.462] Timer tick, asking Buildbucket for the build status
[01:31:45.556] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:45.556] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:105:0) after 1m0s
[01:32:45.534] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:105:0)
[01:32:45.534] Timer tick, asking Buildbucket for the build status
[01:32:45.643] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:45.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:106:0) after 1m0s
[01:33:45.748] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:106:0)
[01:33:45.748] Timer tick, asking Buildbucket for the build status
[01:33:45.987] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:45.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:107:0) after 1m0s
[01:34:46.069] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:107:0)
[01:34:46.069] Timer tick, asking Buildbucket for the build status
[01:34:46.241] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:46.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:108:0) after 1m0s
[01:35:46.282] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:108:0)
[01:35:46.282] Timer tick, asking Buildbucket for the build status
[01:35:46.397] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:46.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:109:0) after 1m0s
[01:36:46.505] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:109:0)
[01:36:46.505] Timer tick, asking Buildbucket for the build status
[01:36:47.499] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:47.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:110:0) after 1m0s
[01:37:47.618] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:110:0)
[01:37:47.618] Timer tick, asking Buildbucket for the build status
[01:37:47.873] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:47.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:111:0) after 1m0s
[01:38:47.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:111:0)
[01:38:47.932] Timer tick, asking Buildbucket for the build status
[01:38:48.024] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:48.024] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:112:0) after 1m0s
[01:39:48.098] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:112:0)
[01:39:48.098] Timer tick, asking Buildbucket for the build status
[01:39:48.255] Build 8908457734763280400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:48.255] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:113:0) after 1m0s
[01:40:37.387] Received PubSub notification, asking Buildbucket for the build status
[01:40:37.731] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:48.288] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:113:0)
[01:40:48.288] Timer tick, asking Buildbucket for the build status
[01:40:48.386] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:48.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:115:0) after 1m0s
[01:41:48.413] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:115:0)
[01:41:48.413] Timer tick, asking Buildbucket for the build status
[01:41:48.500] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:48.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:116:0) after 1m0s
[01:42:48.636] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:116:0)
[01:42:48.636] Timer tick, asking Buildbucket for the build status
[01:42:48.819] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:48.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:117:0) after 1m0s
[01:43:48.863] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:117:0)
[01:43:48.863] Timer tick, asking Buildbucket for the build status
[01:43:49.122] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:49.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:118:0) after 1m0s
[01:44:49.155] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:118:0)
[01:44:49.155] Timer tick, asking Buildbucket for the build status
[01:44:50.116] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:50.116] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:119:0) after 1m0s
[01:45:50.140] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:119:0)
[01:45:50.140] Timer tick, asking Buildbucket for the build status
[01:45:50.477] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:50.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:120:0) after 1m0s
[01:46:50.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:120:0)
[01:46:50.535] Timer tick, asking Buildbucket for the build status
[01:46:50.945] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:50.945] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:121:0) after 1m0s
[01:47:50.978] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:121:0)
[01:47:50.978] Timer tick, asking Buildbucket for the build status
[01:47:51.293] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:51.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:122:0) after 1m0s
[01:48:51.356] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:122:0)
[01:48:51.356] Timer tick, asking Buildbucket for the build status
[01:48:51.725] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:51.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:123:0) after 1m0s
[01:49:51.756] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:123:0)
[01:49:51.756] Timer tick, asking Buildbucket for the build status
[01:49:52.152] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:52.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:124:0) after 1m0s
[01:50:52.215] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:124:0)
[01:50:52.215] Timer tick, asking Buildbucket for the build status
[01:50:52.324] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:52.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:125:0) after 1m0s
[01:51:52.384] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:125:0)
[01:51:52.384] Timer tick, asking Buildbucket for the build status
[01:51:52.481] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:52.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:126:0) after 1m0s
[01:52:52.599] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:126:0)
[01:52:52.599] Timer tick, asking Buildbucket for the build status
[01:52:52.832] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:52.832] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:127:0) after 1m0s
[01:53:52.818] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:127:0)
[01:53:52.818] Timer tick, asking Buildbucket for the build status
[01:53:52.889] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:52.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:128:0) after 1m0s
[01:54:52.936] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:128:0)
[01:54:52.936] Timer tick, asking Buildbucket for the build status
[01:54:53.022] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:53.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:129:0) after 1m0s
[01:55:53.067] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:129:0)
[01:55:53.067] Timer tick, asking Buildbucket for the build status
[01:55:53.147] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:53.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:130:0) after 1m0s
[01:56:53.211] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:130:0)
[01:56:53.211] Timer tick, asking Buildbucket for the build status
[01:56:54.430] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:54.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:131:0) after 1m0s
[01:57:54.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:131:0)
[01:57:54.496] Timer tick, asking Buildbucket for the build status
[01:57:55.690] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:55.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:132:0) after 1m0s
[01:58:55.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:132:0)
[01:58:55.787] Timer tick, asking Buildbucket for the build status
[01:58:55.946] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:55.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:133:0) after 1m0s
[01:59:56.056] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:133:0)
[01:59:56.056] Timer tick, asking Buildbucket for the build status
[01:59:56.136] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:56.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:134:0) after 1m0s
[02:00:56.225] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:134:0)
[02:00:56.225] Timer tick, asking Buildbucket for the build status
[02:00:56.537] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:56.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:135:0) after 1m0s
[02:01:56.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:135:0)
[02:01:56.702] Timer tick, asking Buildbucket for the build status
[02:01:56.891] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:56.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:136:0) after 1m0s
[02:02:56.919] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:136:0)
[02:02:56.919] Timer tick, asking Buildbucket for the build status
[02:02:57.203] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:57.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:137:0) after 1m0s
[02:03:57.292] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:137:0)
[02:03:57.292] Timer tick, asking Buildbucket for the build status
[02:03:57.363] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:57.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:138:0) after 1m0s
[02:04:57.436] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:138:0)
[02:04:57.436] Timer tick, asking Buildbucket for the build status
[02:04:58.678] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:58.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:139:0) after 1m0s
[02:05:58.708] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:139:0)
[02:05:58.708] Timer tick, asking Buildbucket for the build status
[02:05:58.774] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:58.774] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:140:0) after 1m0s
[02:06:58.955] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:140:0)
[02:06:58.955] Timer tick, asking Buildbucket for the build status
[02:06:59.236] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:59.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:141:0) after 1m0s
[02:07:59.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:141:0)
[02:07:59.318] Timer tick, asking Buildbucket for the build status
[02:07:59.425] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:59.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:142:0) after 1m0s
[02:08:59.648] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:142:0)
[02:08:59.648] Timer tick, asking Buildbucket for the build status
[02:08:59.894] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:59.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:143:0) after 1m0s
[02:10:00.004] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:143:0)
[02:10:00.004] Timer tick, asking Buildbucket for the build status
[02:10:00.185] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:00.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:144:0) after 1m0s
[02:11:00.277] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:144:0)
[02:11:00.277] Timer tick, asking Buildbucket for the build status
[02:11:00.551] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:00.551] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:145:0) after 1m0s
[02:12:00.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:145:0)
[02:12:00.663] Timer tick, asking Buildbucket for the build status
[02:12:00.763] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:00.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:146:0) after 1m0s
[02:13:00.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:146:0)
[02:13:00.808] Timer tick, asking Buildbucket for the build status
[02:13:01.595] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:01.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:147:0) after 1m0s
[02:14:01.647] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:147:0)
[02:14:01.647] Timer tick, asking Buildbucket for the build status
[02:14:01.837] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:01.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:148:0) after 1m0s
[02:15:01.912] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:148:0)
[02:15:01.912] Timer tick, asking Buildbucket for the build status
[02:15:02.192] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:02.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:149:0) after 1m0s
[02:16:02.253] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:149:0)
[02:16:02.253] Timer tick, asking Buildbucket for the build status
[02:16:02.352] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:02.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:150:0) after 1m0s
[02:17:02.382] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:150:0)
[02:17:02.382] Timer tick, asking Buildbucket for the build status
[02:17:02.458] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:02.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:151:0) after 1m0s
[02:18:02.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:151:0)
[02:18:02.497] Timer tick, asking Buildbucket for the build status
[02:18:02.783] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:02.783] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:152:0) after 1m0s
[02:19:02.813] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:152:0)
[02:19:02.813] Timer tick, asking Buildbucket for the build status
[02:19:03.068] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:03.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:153:0) after 1m0s
[02:20:03.110] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:153:0)
[02:20:03.110] Timer tick, asking Buildbucket for the build status
[02:20:03.688] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:03.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:154:0) after 1m0s
[02:21:03.717] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:154:0)
[02:21:03.717] Timer tick, asking Buildbucket for the build status
[02:21:03.787] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:03.787] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:155:0) after 1m0s
[02:22:03.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:155:0)
[02:22:03.787] Timer tick, asking Buildbucket for the build status
[02:22:04.117] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:04.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:156:0) after 1m0s
[02:23:04.196] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:156:0)
[02:23:04.196] Timer tick, asking Buildbucket for the build status
[02:23:04.314] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:04.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:157:0) after 1m0s
[02:24:04.384] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:157:0)
[02:24:04.384] Timer tick, asking Buildbucket for the build status
[02:24:04.500] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:04.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:158:0) after 1m0s
[02:25:04.529] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:158:0)
[02:25:04.529] Timer tick, asking Buildbucket for the build status
[02:25:04.741] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:04.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:159:0) after 1m0s
[02:26:04.788] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:159:0)
[02:26:04.788] Timer tick, asking Buildbucket for the build status
[02:26:05.023] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:05.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:160:0) after 1m0s
[02:27:05.052] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:160:0)
[02:27:05.052] Timer tick, asking Buildbucket for the build status
[02:27:05.262] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:05.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:161:0) after 1m0s
[02:28:05.313] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:161:0)
[02:28:05.313] Timer tick, asking Buildbucket for the build status
[02:28:05.500] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:05.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:162:0) after 1m0s
[02:29:05.557] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:162:0)
[02:29:05.557] Timer tick, asking Buildbucket for the build status
[02:29:06.039] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:06.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:163:0) after 1m0s
[02:30:06.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:163:0)
[02:30:06.088] Timer tick, asking Buildbucket for the build status
[02:30:06.210] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:06.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:164:0) after 1m0s
[02:31:06.266] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:164:0)
[02:31:06.266] Timer tick, asking Buildbucket for the build status
[02:31:06.373] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:06.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:165:0) after 1m0s
[02:32:06.478] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:165:0)
[02:32:06.478] Timer tick, asking Buildbucket for the build status
[02:32:06.985] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:06.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:166:0) after 1m0s
[02:33:07.044] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:166:0)
[02:33:07.044] Timer tick, asking Buildbucket for the build status
[02:33:07.219] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:07.219] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:167:0) after 1m0s
[02:34:07.341] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:167:0)
[02:34:07.341] Timer tick, asking Buildbucket for the build status
[02:34:07.487] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:07.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:168:0) after 1m0s
[02:35:07.518] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:168:0)
[02:35:07.518] Timer tick, asking Buildbucket for the build status
[02:35:08.305] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:08.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:169:0) after 1m0s
[02:36:08.364] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:169:0)
[02:36:08.364] Timer tick, asking Buildbucket for the build status
[02:36:08.554] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:08.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:170:0) after 1m0s
[02:37:08.593] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:170:0)
[02:37:08.593] Timer tick, asking Buildbucket for the build status
[02:37:08.692] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:08.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:171:0) after 1m0s
[02:38:08.727] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:171:0)
[02:38:08.727] Timer tick, asking Buildbucket for the build status
[02:38:09.355] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:09.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:172:0) after 1m0s
[02:39:09.355] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:172:0)
[02:39:09.355] Timer tick, asking Buildbucket for the build status
[02:39:09.924] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:09.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:173:0) after 1m0s
[02:40:10.017] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:173:0)
[02:40:10.018] Timer tick, asking Buildbucket for the build status
[02:40:10.286] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:10.286] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:174:0) after 1m0s
[02:41:10.422] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:174:0)
[02:41:10.422] Timer tick, asking Buildbucket for the build status
[02:41:10.705] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:10.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:175:0) after 1m0s
[02:42:10.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:175:0)
[02:42:10.740] Timer tick, asking Buildbucket for the build status
[02:42:11.527] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:11.527] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:176:0) after 1m0s
[02:43:11.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:176:0)
[02:43:11.587] Timer tick, asking Buildbucket for the build status
[02:43:11.909] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:11.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:177:0) after 1m0s
[02:44:12.002] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:177:0)
[02:44:12.002] Timer tick, asking Buildbucket for the build status
[02:44:12.559] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:12.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:178:0) after 1m0s
[02:45:12.621] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:178:0)
[02:45:12.621] Timer tick, asking Buildbucket for the build status
[02:45:12.857] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:12.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:179:0) after 1m0s
[02:46:12.905] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:179:0)
[02:46:12.905] Timer tick, asking Buildbucket for the build status
[02:46:13.371] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:13.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:180:0) after 1m0s
[02:47:13.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:180:0)
[02:47:13.398] Timer tick, asking Buildbucket for the build status
[02:47:13.544] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:13.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:181:0) after 1m0s
[02:48:13.593] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:181:0)
[02:48:13.593] Timer tick, asking Buildbucket for the build status
[02:48:13.912] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:13.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:182:0) after 1m0s
[02:49:13.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:182:0)
[02:49:13.968] Timer tick, asking Buildbucket for the build status
[02:49:14.097] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:14.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:183:0) after 1m0s
[02:50:14.164] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:183:0)
[02:50:14.164] Timer tick, asking Buildbucket for the build status
[02:50:14.459] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:14.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:184:0) after 1m0s
[02:51:14.550] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:184:0)
[02:51:14.550] Timer tick, asking Buildbucket for the build status
[02:51:14.740] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:14.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:185:0) after 1m0s
[02:52:14.803] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:185:0)
[02:52:14.803] Timer tick, asking Buildbucket for the build status
[02:52:16.471] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:16.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:186:0) after 1m0s
[02:53:16.585] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:186:0)
[02:53:16.585] Timer tick, asking Buildbucket for the build status
[02:53:16.710] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:16.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:187:0) after 1m0s
[02:54:16.719] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:187:0)
[02:54:16.719] Timer tick, asking Buildbucket for the build status
[02:54:16.820] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:16.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:188:0) after 1m0s
[02:55:16.856] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:188:0)
[02:55:16.856] Timer tick, asking Buildbucket for the build status
[02:55:16.964] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:16.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:189:0) after 1m0s
[02:56:17.057] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:189:0)
[02:56:17.057] Timer tick, asking Buildbucket for the build status
[02:56:18.064] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:18.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:190:0) after 1m0s
[02:57:18.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:190:0)
[02:57:18.300] Timer tick, asking Buildbucket for the build status
[02:57:18.417] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:18.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:191:0) after 1m0s
[02:58:18.512] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:191:0)
[02:58:18.512] Timer tick, asking Buildbucket for the build status
[02:58:18.621] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:18.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:192:0) after 1m0s
[02:59:18.644] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:192:0)
[02:59:18.644] Timer tick, asking Buildbucket for the build status
[02:59:18.949] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:18.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:193:0) after 1m0s
[03:00:18.994] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:193:0)
[03:00:18.994] Timer tick, asking Buildbucket for the build status
[03:00:19.143] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:19.143] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:194:0) after 1m0s
[03:01:19.293] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:194:0)
[03:01:19.293] Timer tick, asking Buildbucket for the build status
[03:01:19.587] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:19.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:195:0) after 1m0s
[03:02:19.624] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:195:0)
[03:02:19.624] Timer tick, asking Buildbucket for the build status
[03:02:19.950] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:19.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:196:0) after 1m0s
[03:03:20.405] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:196:0)
[03:03:20.405] Timer tick, asking Buildbucket for the build status
[03:03:20.768] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:20.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:197:0) after 1m0s
[03:04:20.963] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:197:0)
[03:04:20.963] Timer tick, asking Buildbucket for the build status
[03:04:21.163] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:21.163] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:198:0) after 1m0s
[03:05:21.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:198:0)
[03:05:21.325] Timer tick, asking Buildbucket for the build status
[03:05:22.320] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:22.320] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:199:0) after 1m0s
[03:06:22.370] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:199:0)
[03:06:22.370] Timer tick, asking Buildbucket for the build status
[03:06:22.513] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:22.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:200:0) after 1m0s
[03:07:22.601] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:200:0)
[03:07:22.601] Timer tick, asking Buildbucket for the build status
[03:07:22.784] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:22.784] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:201:0) after 1m0s
[03:08:22.942] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:201:0)
[03:08:22.942] Timer tick, asking Buildbucket for the build status
[03:08:23.350] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:23.350] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:202:0) after 1m0s
[03:09:23.460] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:202:0)
[03:09:23.460] Timer tick, asking Buildbucket for the build status
[03:09:23.731] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:23.731] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:203:0) after 1m0s
[03:10:23.811] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:203:0)
[03:10:23.811] Timer tick, asking Buildbucket for the build status
[03:10:23.953] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:23.953] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:204:0) after 1m0s
[03:11:24.053] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:204:0)
[03:11:24.053] Timer tick, asking Buildbucket for the build status
[03:11:24.217] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:24.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:205:0) after 1m0s
[03:12:24.234] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:205:0)
[03:12:24.234] Timer tick, asking Buildbucket for the build status
[03:12:24.978] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:24.978] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:206:0) after 1m0s
[03:13:25.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:206:0)
[03:13:25.032] Timer tick, asking Buildbucket for the build status
[03:13:25.418] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:25.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:207:0) after 1m0s
[03:14:25.537] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:207:0)
[03:14:25.537] Timer tick, asking Buildbucket for the build status
[03:14:25.625] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:25.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:208:0) after 1m0s
[03:15:25.783] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:208:0)
[03:15:25.783] Timer tick, asking Buildbucket for the build status
[03:15:25.882] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:25.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:209:0) after 1m0s
[03:16:25.973] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:209:0)
[03:16:25.973] Timer tick, asking Buildbucket for the build status
[03:16:26.127] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:26.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:210:0) after 1m0s
[03:17:26.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:210:0)
[03:17:26.177] Timer tick, asking Buildbucket for the build status
[03:17:26.412] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:26.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:211:0) after 1m0s
[03:18:26.449] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:211:0)
[03:18:26.449] Timer tick, asking Buildbucket for the build status
[03:18:26.599] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:26.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:212:0) after 1m0s
[03:19:26.723] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:212:0)
[03:19:26.723] Timer tick, asking Buildbucket for the build status
[03:19:26.960] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:26.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:213:0) after 1m0s
[03:20:27.004] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:213:0)
[03:20:27.004] Timer tick, asking Buildbucket for the build status
[03:20:27.338] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:27.338] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:214:0) after 1m0s
[03:21:27.421] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:214:0)
[03:21:27.421] Timer tick, asking Buildbucket for the build status
[03:21:28.210] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:28.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:215:0) after 1m0s
[03:22:28.285] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:215:0)
[03:22:28.285] Timer tick, asking Buildbucket for the build status
[03:22:28.461] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:28.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:216:0) after 1m0s
[03:23:28.505] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:216:0)
[03:23:28.505] Timer tick, asking Buildbucket for the build status
[03:23:28.631] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:28.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:217:0) after 1m0s
[03:24:28.665] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:217:0)
[03:24:28.665] Timer tick, asking Buildbucket for the build status
[03:24:29.972] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:29.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:218:0) after 1m0s
[03:25:30.274] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:218:0)
[03:25:30.275] Timer tick, asking Buildbucket for the build status
[03:25:30.360] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:30.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:219:0) after 1m0s
[03:26:30.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:219:0)
[03:26:30.473] Timer tick, asking Buildbucket for the build status
[03:26:30.543] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:30.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:220:0) after 1m0s
[03:27:30.690] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:220:0)
[03:27:30.690] Timer tick, asking Buildbucket for the build status
[03:27:30.821] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:30.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:221:0) after 1m0s
[03:28:30.874] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:221:0)
[03:28:30.874] Timer tick, asking Buildbucket for the build status
[03:28:31.037] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:31.037] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:222:0) after 1m0s
[03:29:31.095] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:222:0)
[03:29:31.095] Timer tick, asking Buildbucket for the build status
[03:29:31.444] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:31.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:223:0) after 1m0s
[03:30:31.537] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:223:0)
[03:30:31.537] Timer tick, asking Buildbucket for the build status
[03:30:31.620] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:31.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:224:0) after 1m0s
[03:31:31.725] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:224:0)
[03:31:31.726] Timer tick, asking Buildbucket for the build status
[03:31:32.097] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:32.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:225:0) after 1m0s
[03:32:32.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:225:0)
[03:32:32.203] Timer tick, asking Buildbucket for the build status
[03:32:32.608] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:32.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:226:0) after 1m0s
[03:33:32.668] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:226:0)
[03:33:32.668] Timer tick, asking Buildbucket for the build status
[03:33:32.813] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:32.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:227:0) after 1m0s
[03:34:32.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:227:0)
[03:34:32.871] Timer tick, asking Buildbucket for the build status
[03:34:33.198] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:33.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:228:0) after 1m0s
[03:35:33.221] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:228:0)
[03:35:33.221] Timer tick, asking Buildbucket for the build status
[03:35:33.304] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:33.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:229:0) after 1m0s
[03:36:33.348] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:229:0)
[03:36:33.348] Timer tick, asking Buildbucket for the build status
[03:36:33.423] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:33.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:230:0) after 1m0s
[03:37:33.557] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:230:0)
[03:37:33.557] Timer tick, asking Buildbucket for the build status
[03:37:33.656] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:33.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:231:0) after 1m0s
[03:38:33.731] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:231:0)
[03:38:33.731] Timer tick, asking Buildbucket for the build status
[03:38:33.861] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:33.861] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:232:0) after 1m0s
[03:39:33.888] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:232:0)
[03:39:33.888] Timer tick, asking Buildbucket for the build status
[03:39:34.402] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:34.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:233:0) after 1m0s
[03:40:34.439] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:233:0)
[03:40:34.439] Timer tick, asking Buildbucket for the build status
[03:40:34.534] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:34.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:234:0) after 1m0s
[03:41:34.631] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:234:0)
[03:41:34.631] Timer tick, asking Buildbucket for the build status
[03:41:34.727] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:34.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:235:0) after 1m0s
[03:42:34.830] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:235:0)
[03:42:34.830] Timer tick, asking Buildbucket for the build status
[03:42:35.064] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:35.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:236:0) after 1m0s
[03:43:35.130] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:236:0)
[03:43:35.130] Timer tick, asking Buildbucket for the build status
[03:43:35.250] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:35.250] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:237:0) after 1m0s
[03:44:35.357] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:237:0)
[03:44:35.357] Timer tick, asking Buildbucket for the build status
[03:44:35.522] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:35.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:238:0) after 1m0s
[03:45:35.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:238:0)
[03:45:35.553] Timer tick, asking Buildbucket for the build status
[03:45:35.850] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:35.850] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:239:0) after 1m0s
[03:46:35.882] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:239:0)
[03:46:35.882] Timer tick, asking Buildbucket for the build status
[03:46:36.049] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:36.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:240:0) after 1m0s
[03:47:36.087] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:240:0)
[03:47:36.087] Timer tick, asking Buildbucket for the build status
[03:47:36.288] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:36.288] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:241:0) after 1m0s
[03:48:36.334] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:241:0)
[03:48:36.334] Timer tick, asking Buildbucket for the build status
[03:48:36.519] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:36.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:242:0) after 1m0s
[03:49:36.549] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:242:0)
[03:49:36.549] Timer tick, asking Buildbucket for the build status
[03:49:36.655] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:36.655] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:243:0) after 1m0s
[03:50:36.690] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:243:0)
[03:50:36.690] Timer tick, asking Buildbucket for the build status
[03:50:36.753] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:36.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:244:0) after 1m0s
[03:51:36.786] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:244:0)
[03:51:36.786] Timer tick, asking Buildbucket for the build status
[03:51:36.888] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:36.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:245:0) after 1m0s
[03:52:36.918] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:245:0)
[03:52:36.918] Timer tick, asking Buildbucket for the build status
[03:52:37.032] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:37.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:246:0) after 1m0s
[03:53:37.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:246:0)
[03:53:37.233] Timer tick, asking Buildbucket for the build status
[03:53:38.947] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:38.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:247:0) after 1m0s
[03:54:39.029] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:247:0)
[03:54:39.029] Timer tick, asking Buildbucket for the build status
[03:54:39.152] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:39.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:248:0) after 1m0s
[03:55:39.191] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:248:0)
[03:55:39.191] Timer tick, asking Buildbucket for the build status
[03:55:39.283] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:39.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:249:0) after 1m0s
[03:56:39.319] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:249:0)
[03:56:39.319] Timer tick, asking Buildbucket for the build status
[03:56:39.462] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:39.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:250:0) after 1m0s
[03:57:39.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:250:0)
[03:57:39.496] Timer tick, asking Buildbucket for the build status
[03:57:39.766] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:39.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:251:0) after 1m0s
[03:58:39.802] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:251:0)
[03:58:39.802] Timer tick, asking Buildbucket for the build status
[03:58:39.909] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:39.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:252:0) after 1m0s
[03:59:39.940] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:252:0)
[03:59:39.940] Timer tick, asking Buildbucket for the build status
[03:59:40.042] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:40.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:253:0) after 1m0s
[04:00:40.090] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:253:0)
[04:00:40.090] Timer tick, asking Buildbucket for the build status
[04:00:40.655] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:40.655] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:254:0) after 1m0s
[04:01:40.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:254:0)
[04:01:40.701] Timer tick, asking Buildbucket for the build status
[04:01:40.835] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:40.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:255:0) after 1m0s
[04:02:40.977] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:255:0)
[04:02:40.977] Timer tick, asking Buildbucket for the build status
[04:02:41.093] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:41.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:256:0) after 1m0s
[04:03:41.570] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:256:0)
[04:03:41.571] Timer tick, asking Buildbucket for the build status
[04:03:41.671] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:41.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:257:0) after 1m0s
[04:04:41.990] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:257:0)
[04:04:41.990] Timer tick, asking Buildbucket for the build status
[04:04:42.162] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:42.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:258:0) after 1m0s
[04:05:42.423] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:258:0)
[04:05:42.423] Timer tick, asking Buildbucket for the build status
[04:05:42.508] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:42.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:259:0) after 1m0s
[04:06:42.754] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:259:0)
[04:06:42.754] Timer tick, asking Buildbucket for the build status
[04:06:43.198] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:43.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:260:0) after 1m0s
[04:07:43.433] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:260:0)
[04:07:43.433] Timer tick, asking Buildbucket for the build status
[04:07:43.603] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:43.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:261:0) after 1m0s
[04:08:43.628] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:261:0)
[04:08:43.628] Timer tick, asking Buildbucket for the build status
[04:08:43.878] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:43.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:262:0) after 1m0s
[04:09:44.095] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:262:0)
[04:09:44.095] Timer tick, asking Buildbucket for the build status
[04:09:45.594] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:45.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:263:0) after 1m0s
[04:10:45.692] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:263:0)
[04:10:45.692] Timer tick, asking Buildbucket for the build status
[04:10:45.792] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:45.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:264:0) after 1m0s
[04:11:45.914] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:264:0)
[04:11:45.914] Timer tick, asking Buildbucket for the build status
[04:11:45.993] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:45.993] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:265:0) after 1m0s
[04:12:46.195] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:265:0)
[04:12:46.195] Timer tick, asking Buildbucket for the build status
[04:12:46.488] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:46.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:266:0) after 1m0s
[04:13:46.779] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:266:0)
[04:13:46.779] Timer tick, asking Buildbucket for the build status
[04:13:47.833] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:47.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:267:0) after 1m0s
[04:14:48.073] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:267:0)
[04:14:48.073] Timer tick, asking Buildbucket for the build status
[04:14:48.274] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:48.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:268:0) after 1m0s
[04:15:48.462] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:268:0)
[04:15:48.462] Timer tick, asking Buildbucket for the build status
[04:15:49.439] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:49.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:269:0) after 1m0s
[04:16:49.563] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:269:0)
[04:16:49.563] Timer tick, asking Buildbucket for the build status
[04:16:49.648] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:49.648] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:270:0) after 1m0s
[04:17:49.910] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:270:0)
[04:17:49.910] Timer tick, asking Buildbucket for the build status
[04:17:49.991] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:49.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:271:0) after 1m0s
[04:18:50.146] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:271:0)
[04:18:50.146] Timer tick, asking Buildbucket for the build status
[04:18:50.279] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:50.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:272:0) after 1m0s
[04:19:50.664] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:272:0)
[04:19:50.664] Timer tick, asking Buildbucket for the build status
[04:19:50.797] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:50.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:273:0) after 1m0s
[04:20:51.462] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:273:0)
[04:20:51.462] Timer tick, asking Buildbucket for the build status
[04:20:51.566] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:51.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:274:0) after 1m0s
[04:21:51.865] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:274:0)
[04:21:51.865] Timer tick, asking Buildbucket for the build status
[04:21:51.936] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:51.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:275:0) after 1m0s
[04:22:52.245] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:275:0)
[04:22:52.245] Timer tick, asking Buildbucket for the build status
[04:22:52.332] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:52.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:276:0) after 1m0s
[04:23:52.482] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:276:0)
[04:23:52.482] Timer tick, asking Buildbucket for the build status
[04:23:52.626] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:52.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:277:0) after 1m0s
[04:24:52.810] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:277:0)
[04:24:52.810] Timer tick, asking Buildbucket for the build status
[04:24:53.150] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:53.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:278:0) after 1m0s
[04:25:53.281] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:278:0)
[04:25:53.281] Timer tick, asking Buildbucket for the build status
[04:25:53.400] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:53.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:279:0) after 1m0s
[04:26:53.513] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:279:0)
[04:26:53.513] Timer tick, asking Buildbucket for the build status
[04:26:53.812] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:53.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:280:0) after 1m0s
[04:27:54.020] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:280:0)
[04:27:54.020] Timer tick, asking Buildbucket for the build status
[04:27:54.145] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:54.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:281:0) after 1m0s
[04:28:55.612] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:281:0)
[04:28:55.612] Timer tick, asking Buildbucket for the build status
[04:28:55.802] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:55.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:282:0) after 1m0s
[04:29:55.937] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:282:0)
[04:29:55.937] Timer tick, asking Buildbucket for the build status
[04:29:56.851] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:56.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:283:0) after 1m0s
[04:30:57.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:283:0)
[04:30:57.018] Timer tick, asking Buildbucket for the build status
[04:30:57.198] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:57.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:284:0) after 1m0s
[04:31:57.419] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:284:0)
[04:31:57.419] Timer tick, asking Buildbucket for the build status
[04:31:57.499] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:57.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:285:0) after 1m0s
[04:32:57.734] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:285:0)
[04:32:57.734] Timer tick, asking Buildbucket for the build status
[04:32:57.803] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:57.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:286:0) after 1m0s
[04:33:58.066] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:286:0)
[04:33:58.066] Timer tick, asking Buildbucket for the build status
[04:33:58.167] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:58.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:287:0) after 1m0s
[04:34:58.483] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:287:0)
[04:34:58.483] Timer tick, asking Buildbucket for the build status
[04:34:58.819] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:58.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:288:0) after 1m0s
[04:35:59.225] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:288:0)
[04:35:59.225] Timer tick, asking Buildbucket for the build status
[04:35:59.472] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:59.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:289:0) after 1m0s
[04:36:59.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:289:0)
[04:36:59.597] Timer tick, asking Buildbucket for the build status
[04:36:59.981] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:59.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:290:0) after 1m0s
[04:38:00.016] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:290:0)
[04:38:00.016] Timer tick, asking Buildbucket for the build status
[04:38:00.116] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:00.116] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:291:0) after 1m0s
[04:39:00.161] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:291:0)
[04:39:00.161] Timer tick, asking Buildbucket for the build status
[04:39:00.229] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:00.229] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:292:0) after 1m0s
[04:40:00.257] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:292:0)
[04:40:00.257] Timer tick, asking Buildbucket for the build status
[04:40:00.363] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:00.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:293:0) after 1m0s
[04:41:00.399] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:293:0)
[04:41:00.399] Timer tick, asking Buildbucket for the build status
[04:41:00.833] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:00.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:294:0) after 1m0s
[04:42:00.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:294:0)
[04:42:00.907] Timer tick, asking Buildbucket for the build status
[04:42:01.049] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:01.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:295:0) after 1m0s
[04:43:01.096] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:295:0)
[04:43:01.097] Timer tick, asking Buildbucket for the build status
[04:43:01.227] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:01.227] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:296:0) after 1m0s
[04:44:01.256] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:296:0)
[04:44:01.256] Timer tick, asking Buildbucket for the build status
[04:44:01.362] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:01.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:297:0) after 1m0s
[04:45:01.393] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:297:0)
[04:45:01.393] Timer tick, asking Buildbucket for the build status
[04:45:01.482] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:01.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:298:0) after 1m0s
[04:46:01.528] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:298:0)
[04:46:01.528] Timer tick, asking Buildbucket for the build status
[04:46:01.613] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:01.613] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:299:0) after 1m0s
[04:47:02.089] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:299:0)
[04:47:02.089] Timer tick, asking Buildbucket for the build status
[04:47:02.527] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:02.527] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:300:0) after 1m0s
[04:48:02.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:300:0)
[04:48:02.773] Timer tick, asking Buildbucket for the build status
[04:48:02.958] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:02.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:301:0) after 1m0s
[04:49:03.002] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:301:0)
[04:49:03.002] Timer tick, asking Buildbucket for the build status
[04:49:03.194] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:03.194] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:302:0) after 1m0s
[04:50:03.392] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:302:0)
[04:50:03.392] Timer tick, asking Buildbucket for the build status
[04:50:03.721] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:03.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:303:0) after 1m0s
[04:51:03.776] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:303:0)
[04:51:03.776] Timer tick, asking Buildbucket for the build status
[04:51:04.002] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:04.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:304:0) after 1m0s
[04:52:04.199] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:304:0)
[04:52:04.199] Timer tick, asking Buildbucket for the build status
[04:52:04.277] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:04.277] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:305:0) after 1m0s
[04:53:04.382] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:305:0)
[04:53:04.382] Timer tick, asking Buildbucket for the build status
[04:53:04.464] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:04.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:306:0) after 1m0s
[04:54:04.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:306:0)
[04:54:04.491] Timer tick, asking Buildbucket for the build status
[04:54:04.766] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:04.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:307:0) after 1m0s
[04:55:04.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:307:0)
[04:55:04.900] Timer tick, asking Buildbucket for the build status
[04:55:05.228] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:05.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:308:0) after 1m0s
[04:56:05.257] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:308:0)
[04:56:05.257] Timer tick, asking Buildbucket for the build status
[04:56:05.366] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:05.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:309:0) after 1m0s
[04:57:05.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:309:0)
[04:57:05.438] Timer tick, asking Buildbucket for the build status
[04:57:05.641] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:05.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:310:0) after 1m0s
[04:58:05.790] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:310:0)
[04:58:05.790] Timer tick, asking Buildbucket for the build status
[04:58:05.877] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:05.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:311:0) after 1m0s
[04:59:05.948] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:311:0)
[04:59:05.948] Timer tick, asking Buildbucket for the build status
[04:59:06.201] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:06.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:312:0) after 1m0s
[05:00:06.210] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:312:0)
[05:00:06.210] Timer tick, asking Buildbucket for the build status
[05:00:06.518] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:06.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:313:0) after 1m0s
[05:01:06.578] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:313:0)
[05:01:06.578] Timer tick, asking Buildbucket for the build status
[05:01:07.599] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:07.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:314:0) after 1m0s
[05:02:07.655] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:314:0)
[05:02:07.655] Timer tick, asking Buildbucket for the build status
[05:02:07.751] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:07.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:315:0) after 1m0s
[05:03:07.810] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:315:0)
[05:03:07.810] Timer tick, asking Buildbucket for the build status
[05:03:08.387] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:08.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:316:0) after 1m0s
[05:04:08.549] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:316:0)
[05:04:08.549] Timer tick, asking Buildbucket for the build status
[05:04:11.122] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:11.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:317:0) after 1m0s
[05:05:11.175] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:317:0)
[05:05:11.175] Timer tick, asking Buildbucket for the build status
[05:05:11.402] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:11.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:318:0) after 1m0s
[05:06:11.478] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:318:0)
[05:06:11.478] Timer tick, asking Buildbucket for the build status
[05:06:11.660] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:11.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:319:0) after 1m0s
[05:07:11.733] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:319:0)
[05:07:11.733] Timer tick, asking Buildbucket for the build status
[05:07:11.901] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:11.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:320:0) after 1m0s
[05:08:12.078] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:320:0)
[05:08:12.078] Timer tick, asking Buildbucket for the build status
[05:08:12.309] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:12.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:321:0) after 1m0s
[05:09:12.332] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:321:0)
[05:09:12.332] Timer tick, asking Buildbucket for the build status
[05:09:12.461] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:12.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:322:0) after 1m0s
[05:10:12.593] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:322:0)
[05:10:12.593] Timer tick, asking Buildbucket for the build status
[05:10:12.659] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:12.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:323:0) after 1m0s
[05:11:12.719] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:323:0)
[05:11:12.719] Timer tick, asking Buildbucket for the build status
[05:11:12.887] Build 8908457734763280400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:12.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9073887798318113200:324:0) after 1m0s
[05:11:53.049] Received PubSub notification, asking Buildbucket for the build status
[05:11:53.112] Build 8908457734763280400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:11:53.113] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "completed_ts": "1562649111986011",
    "created_by": "project:nacl",
    "created_ts": "1562629681773615",
    "id": "8908457734763280400",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"058a26f57015051953a727add26e7e26348b9558\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@058a26f57015051953a727add26e7e26348b9558\", \"title\": \"058a26f57015051953a727add26e7e26348b9558\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/058a26f57015051953a727add26e7e26348b9558\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"058a26f57015051953a727add26e7e26348b9558\"}}",
    "project": "nacl",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"058a26f57015051953a727add26e7e26348b9558\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@058a26f57015051953a727add26e7e26348b9558\", \"title\": \"058a26f57015051953a727add26e7e26348b9558\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/058a26f57015051953a727add26e7e26348b9558\"}]}, \"bot_id\": \"luci-nacl-toolchain-trusty-0-t9o4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-pnacl-x86_64\", \"buildnumber\": 7039, \"got_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"mastername\": \"client.nacl.toolchain\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"16\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-nacl-toolchain-trusty-0-t9o4\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.nacl.toolchain\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4365-1559751\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1562636436276497",
    "status": "COMPLETED",
    "status_changed_ts": "1562649112564025",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7039",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/058a26f57015051953a727add26e7e26348b9558",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/058a26f57015051953a727add26e7e26348b9558",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9073887798318113200",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8908457734763280400/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:45ecce3e86c3a410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1562649112583520",
    "url": "https://ci.chromium.org/b/8908457734763280400",
    "utcnow_ts": "1562649113105990"
  }
}
[05:11:53.113] Invocation finished in 5h23m54.113708375s with status SUCCEEDED