LUCI Scheduler :: nacl :: linux-pnacl-x86_64

Status: FAILED

Triggered by: -

Duration: 6 hours

Actions:

Definition (rev 1c82d86159c2071b02a7ddf08ffd2ae0bff92186)

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

Incoming triggers

af5947d13e6794eac489365ff58fd45c0dd4ca2a (6 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[20:59:13.532] New invocation is queued and will start shortly
[20:59:14.979] Starting the invocation (attempt 1)
[20:59:15.024] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:59:15.024] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:59:15.024] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9092561390736000512",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"af5947d13e6794eac489365ff58fd45c0dd4ca2a\"}}",
  "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:9092561390736000512",
    "scheduler_job_id:nacl/linux-pnacl-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
    "gitiles_ref:refs/heads/master"
  ]
}
[20:59:16.520] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1544821155096711",
    "id": "8927131328432830560",
    "lease_expiration_ts": "1544972356060109",
    "lease_key": "294646457",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"af5947d13e6794eac489365ff58fd45c0dd4ca2a\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1544821156338736",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7012",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9092561390736000512",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_dimension:caches:builder_eacc41f1df5d043e03eef0198bc8ddecd24b0492a666afd70585f546f0146c16_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7012",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8927131328432830560",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
      "swarming_tag:builder:linux-pnacl-x86_64",
      "swarming_tag:buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
      "swarming_tag:caches:builder_eacc41f1df5d043e03eef0198bc8ddecd24b0492a666afd70585f546f0146c16_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8927131328432830560/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9092561390736000512",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:ee62e96c73f38e03db7f2d5dd18fea50e0f44727",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:41c755af3800be10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1544821156338845",
    "url": "https://ci.chromium.org/b/8927131328432830560",
    "utcnow_ts": "1544821156509139"
  }
}
[20:59:16.520] Task URL: https://ci.chromium.org/b/8927131328432830560
[20:59:16.520] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:2:0) after 1m0s
[21:00:16.537] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:2:0)
[21:00:16.537] Timer tick, asking Buildbucket for the build status
[21:00:16.643] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:16.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:3:0) after 1m0s
[21:01:16.658] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:3:0)
[21:01:16.658] Timer tick, asking Buildbucket for the build status
[21:01:16.752] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:16.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:4:0) after 1m0s
[21:02:16.770] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:4:0)
[21:02:16.770] Timer tick, asking Buildbucket for the build status
[21:02:16.837] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:16.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:5:0) after 1m0s
[21:03:16.872] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:5:0)
[21:03:16.872] Timer tick, asking Buildbucket for the build status
[21:03:16.928] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:16.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:6:0) after 1m0s
[21:04:16.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:6:0)
[21:04:16.969] Timer tick, asking Buildbucket for the build status
[21:04:17.019] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:17.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:7:0) after 1m0s
[21:05:17.037] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:7:0)
[21:05:17.037] Timer tick, asking Buildbucket for the build status
[21:05:17.136] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:17.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:8:0) after 1m0s
[21:06:17.162] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:8:0)
[21:06:17.162] Timer tick, asking Buildbucket for the build status
[21:06:17.302] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:17.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:9:0) after 1m0s
[21:07:17.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:9:0)
[21:07:17.325] Timer tick, asking Buildbucket for the build status
[21:07:17.475] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:17.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:10:0) after 1m0s
[21:08:17.555] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:10:0)
[21:08:17.555] Timer tick, asking Buildbucket for the build status
[21:08:17.607] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:17.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:11:0) after 1m0s
[21:09:17.628] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:11:0)
[21:09:17.628] Timer tick, asking Buildbucket for the build status
[21:09:17.813] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:17.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:12:0) after 1m0s
[21:10:17.836] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:12:0)
[21:10:17.836] Timer tick, asking Buildbucket for the build status
[21:10:17.871] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:17.871] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:13:0) after 1m0s
[21:11:17.887] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:13:0)
[21:11:17.887] Timer tick, asking Buildbucket for the build status
[21:11:18.023] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:18.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:14:0) after 1m0s
[21:12:18.066] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:14:0)
[21:12:18.066] Timer tick, asking Buildbucket for the build status
[21:12:18.104] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:18.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:15:0) after 1m0s
[21:13:18.121] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:15:0)
[21:13:18.121] Timer tick, asking Buildbucket for the build status
[21:13:18.172] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:18.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:16:0) after 1m0s
[21:14:18.188] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:16:0)
[21:14:18.188] Timer tick, asking Buildbucket for the build status
[21:14:18.336] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:18.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:17:0) after 1m0s
[21:15:18.372] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:17:0)
[21:15:18.372] Timer tick, asking Buildbucket for the build status
[21:15:18.444] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:18.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:18:0) after 1m0s
[21:16:18.460] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:18:0)
[21:16:18.460] Timer tick, asking Buildbucket for the build status
[21:16:18.506] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:18.506] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:19:0) after 1m0s
[21:17:18.526] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:19:0)
[21:17:18.526] Timer tick, asking Buildbucket for the build status
[21:17:18.734] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:18.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:20:0) after 1m0s
[21:18:18.750] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:20:0)
[21:18:18.750] Timer tick, asking Buildbucket for the build status
[21:18:18.781] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:18.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:21:0) after 1m0s
[21:19:18.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:21:0)
[21:19:18.808] Timer tick, asking Buildbucket for the build status
[21:19:18.859] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:18.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:22:0) after 1m0s
[21:20:18.907] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:22:0)
[21:20:18.907] Timer tick, asking Buildbucket for the build status
[21:20:18.942] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:18.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:23:0) after 1m0s
[21:21:18.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:23:0)
[21:21:18.971] Timer tick, asking Buildbucket for the build status
[21:21:19.027] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:19.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:24:0) after 1m0s
[21:22:19.045] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:24:0)
[21:22:19.045] Timer tick, asking Buildbucket for the build status
[21:22:19.109] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:19.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:25:0) after 1m0s
[21:23:19.130] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:25:0)
[21:23:19.130] Timer tick, asking Buildbucket for the build status
[21:23:19.192] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:23:19.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:26:0) after 1m0s
[21:24:19.209] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:26:0)
[21:24:19.209] Timer tick, asking Buildbucket for the build status
[21:24:19.246] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:24:19.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:27:0) after 1m0s
[21:25:19.312] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:27:0)
[21:25:19.312] Timer tick, asking Buildbucket for the build status
[21:25:19.394] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:25:19.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:28:0) after 1m0s
[21:26:19.416] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:28:0)
[21:26:19.416] Timer tick, asking Buildbucket for the build status
[21:26:19.544] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:26:19.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:29:0) after 1m0s
[21:27:19.570] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:29:0)
[21:27:19.570] Timer tick, asking Buildbucket for the build status
[21:27:19.632] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:19.632] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:30:0) after 1m0s
[21:28:19.650] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:30:0)
[21:28:19.650] Timer tick, asking Buildbucket for the build status
[21:28:19.685] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:28:19.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:31:0) after 1m0s
[21:29:19.728] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:31:0)
[21:29:19.728] Timer tick, asking Buildbucket for the build status
[21:29:19.781] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:29:19.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:32:0) after 1m0s
[21:30:19.798] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:32:0)
[21:30:19.798] Timer tick, asking Buildbucket for the build status
[21:30:19.939] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:30:19.939] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:33:0) after 1m0s
[21:31:19.959] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:33:0)
[21:31:19.959] Timer tick, asking Buildbucket for the build status
[21:31:20.058] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:31:20.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:34:0) after 1m0s
[21:32:20.083] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:34:0)
[21:32:20.083] Timer tick, asking Buildbucket for the build status
[21:32:20.338] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:32:20.338] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:35:0) after 1m0s
[21:33:20.395] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:35:0)
[21:33:20.395] Timer tick, asking Buildbucket for the build status
[21:33:20.446] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:33:20.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:36:0) after 1m0s
[21:34:20.492] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:36:0)
[21:34:20.492] Timer tick, asking Buildbucket for the build status
[21:34:20.620] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:34:20.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:37:0) after 1m0s
[21:35:20.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:37:0)
[21:35:20.656] Timer tick, asking Buildbucket for the build status
[21:35:20.717] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:35:20.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:38:0) after 1m0s
[21:36:20.733] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:38:0)
[21:36:20.733] Timer tick, asking Buildbucket for the build status
[21:36:20.829] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:36:20.829] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:39:0) after 1m0s
[21:37:20.846] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:39:0)
[21:37:20.846] Timer tick, asking Buildbucket for the build status
[21:37:20.902] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:37:20.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:40:0) after 1m0s
[21:38:20.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:40:0)
[21:38:20.921] Timer tick, asking Buildbucket for the build status
[21:38:21.003] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:38:21.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:41:0) after 1m0s
[21:39:21.024] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:41:0)
[21:39:21.024] Timer tick, asking Buildbucket for the build status
[21:39:21.213] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:39:21.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:42:0) after 1m0s
[21:40:21.240] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:42:0)
[21:40:21.240] Timer tick, asking Buildbucket for the build status
[21:40:21.279] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:40:21.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:43:0) after 1m0s
[21:41:21.302] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:43:0)
[21:41:21.302] Timer tick, asking Buildbucket for the build status
[21:41:21.368] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:41:21.368] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:44:0) after 1m0s
[21:42:21.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:44:0)
[21:42:21.397] Timer tick, asking Buildbucket for the build status
[21:42:21.440] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:42:21.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:45:0) after 1m0s
[21:43:21.463] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:45:0)
[21:43:21.463] Timer tick, asking Buildbucket for the build status
[21:43:21.530] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:43:21.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:46:0) after 1m0s
[21:44:21.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:46:0)
[21:44:21.569] Timer tick, asking Buildbucket for the build status
[21:44:21.619] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:44:21.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:47:0) after 1m0s
[21:45:21.639] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:47:0)
[21:45:21.640] Timer tick, asking Buildbucket for the build status
[21:45:21.703] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:45:21.703] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:48:0) after 1m0s
[21:46:21.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:48:0)
[21:46:21.722] Timer tick, asking Buildbucket for the build status
[21:46:21.781] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:46:21.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:49:0) after 1m0s
[21:47:21.798] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:49:0)
[21:47:21.798] Timer tick, asking Buildbucket for the build status
[21:47:21.882] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:47:21.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:50:0) after 1m0s
[21:48:21.901] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:50:0)
[21:48:21.901] Timer tick, asking Buildbucket for the build status
[21:48:21.936] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:48:21.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:51:0) after 1m0s
[21:49:21.956] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:51:0)
[21:49:21.956] Timer tick, asking Buildbucket for the build status
[21:49:22.022] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:49:22.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:52:0) after 1m0s
[21:50:22.040] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:52:0)
[21:50:22.040] Timer tick, asking Buildbucket for the build status
[21:50:22.102] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:50:22.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:53:0) after 1m0s
[21:51:22.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:53:0)
[21:51:22.149] Timer tick, asking Buildbucket for the build status
[21:51:22.200] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:51:22.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:54:0) after 1m0s
[21:52:22.236] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:54:0)
[21:52:22.236] Timer tick, asking Buildbucket for the build status
[21:52:22.270] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:52:22.270] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:55:0) after 1m0s
[21:53:22.295] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:55:0)
[21:53:22.295] Timer tick, asking Buildbucket for the build status
[21:53:22.439] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:53:22.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:56:0) after 1m0s
[21:54:22.456] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:56:0)
[21:54:22.456] Timer tick, asking Buildbucket for the build status
[21:54:22.499] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:54:22.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:57:0) after 1m0s
[21:55:22.517] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:57:0)
[21:55:22.517] Timer tick, asking Buildbucket for the build status
[21:55:22.552] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:55:22.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:58:0) after 1m0s
[21:56:22.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:58:0)
[21:56:22.577] Timer tick, asking Buildbucket for the build status
[21:56:22.626] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:56:22.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:59:0) after 1m0s
[21:57:22.670] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:59:0)
[21:57:22.670] Timer tick, asking Buildbucket for the build status
[21:57:22.747] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:57:22.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:60:0) after 1m0s
[21:58:22.767] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:60:0)
[21:58:22.767] Timer tick, asking Buildbucket for the build status
[21:58:22.961] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:58:22.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:61:0) after 1m0s
[21:59:22.986] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:61:0)
[21:59:22.986] Timer tick, asking Buildbucket for the build status
[21:59:23.042] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:59:23.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:62:0) after 1m0s
[22:00:23.082] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:62:0)
[22:00:23.082] Timer tick, asking Buildbucket for the build status
[22:00:23.128] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:00:23.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:63:0) after 1m0s
[22:01:23.154] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:63:0)
[22:01:23.154] Timer tick, asking Buildbucket for the build status
[22:01:23.209] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:01:23.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:64:0) after 1m0s
[22:02:23.232] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:64:0)
[22:02:23.232] Timer tick, asking Buildbucket for the build status
[22:02:23.333] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:23.333] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:65:0) after 1m0s
[22:03:23.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:65:0)
[22:03:23.354] Timer tick, asking Buildbucket for the build status
[22:03:23.614] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:03:23.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:66:0) after 1m0s
[22:04:23.689] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:66:0)
[22:04:23.689] Timer tick, asking Buildbucket for the build status
[22:04:23.746] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:04:23.746] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:67:0) after 1m0s
[22:05:23.784] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:67:0)
[22:05:23.784] Timer tick, asking Buildbucket for the build status
[22:05:23.863] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:05:23.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:68:0) after 1m0s
[22:06:23.882] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:68:0)
[22:06:23.882] Timer tick, asking Buildbucket for the build status
[22:06:23.950] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:06:23.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:69:0) after 1m0s
[22:07:23.985] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:69:0)
[22:07:23.985] Timer tick, asking Buildbucket for the build status
[22:07:24.090] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:07:24.090] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:70:0) after 1m0s
[22:08:24.114] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:70:0)
[22:08:24.114] Timer tick, asking Buildbucket for the build status
[22:08:24.155] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:08:24.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:71:0) after 1m0s
[22:09:24.178] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:71:0)
[22:09:24.178] Timer tick, asking Buildbucket for the build status
[22:09:24.224] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:24.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:72:0) after 1m0s
[22:10:24.303] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:72:0)
[22:10:24.303] Timer tick, asking Buildbucket for the build status
[22:10:24.433] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:24.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:73:0) after 1m0s
[22:11:24.454] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:73:0)
[22:11:24.454] Timer tick, asking Buildbucket for the build status
[22:11:24.488] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:11:24.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:74:0) after 1m0s
[22:12:24.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:74:0)
[22:12:24.536] Timer tick, asking Buildbucket for the build status
[22:12:24.645] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:12:24.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:75:0) after 1m0s
[22:13:24.682] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:75:0)
[22:13:24.682] Timer tick, asking Buildbucket for the build status
[22:13:24.727] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:13:24.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:76:0) after 1m0s
[22:14:24.747] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:76:0)
[22:14:24.747] Timer tick, asking Buildbucket for the build status
[22:14:24.802] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:14:24.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:77:0) after 1m0s
[22:15:24.826] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:77:0)
[22:15:24.826] Timer tick, asking Buildbucket for the build status
[22:15:24.865] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:15:24.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:78:0) after 1m0s
[22:16:24.885] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:78:0)
[22:16:24.885] Timer tick, asking Buildbucket for the build status
[22:16:24.950] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:16:24.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:79:0) after 1m0s
[22:17:24.976] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:79:0)
[22:17:24.976] Timer tick, asking Buildbucket for the build status
[22:17:25.116] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:17:25.116] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:80:0) after 1m0s
[22:18:25.136] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:80:0)
[22:18:25.136] Timer tick, asking Buildbucket for the build status
[22:18:25.367] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:18:25.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:81:0) after 1m0s
[22:19:25.388] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:81:0)
[22:19:25.388] Timer tick, asking Buildbucket for the build status
[22:19:25.426] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:19:25.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:82:0) after 1m0s
[22:20:25.445] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:82:0)
[22:20:25.445] Timer tick, asking Buildbucket for the build status
[22:20:25.573] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:20:25.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:83:0) after 1m0s
[22:21:25.594] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:83:0)
[22:21:25.594] Timer tick, asking Buildbucket for the build status
[22:21:25.628] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:21:25.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:84:0) after 1m0s
[22:22:25.649] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:84:0)
[22:22:25.649] Timer tick, asking Buildbucket for the build status
[22:22:25.688] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:25.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:85:0) after 1m0s
[22:23:25.741] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:85:0)
[22:23:25.741] Timer tick, asking Buildbucket for the build status
[22:23:25.839] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:25.839] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:86:0) after 1m0s
[22:24:25.862] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:86:0)
[22:24:25.862] Timer tick, asking Buildbucket for the build status
[22:24:26.025] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:26.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:87:0) after 1m0s
[22:25:26.077] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:87:0)
[22:25:26.077] Timer tick, asking Buildbucket for the build status
[22:25:26.110] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:26.110] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:88:0) after 1m0s
[22:26:26.128] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:88:0)
[22:26:26.128] Timer tick, asking Buildbucket for the build status
[22:26:26.215] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:26.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:89:0) after 1m0s
[22:27:26.240] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:89:0)
[22:27:26.240] Timer tick, asking Buildbucket for the build status
[22:27:26.272] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:26.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:90:0) after 1m0s
[22:28:26.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:90:0)
[22:28:26.300] Timer tick, asking Buildbucket for the build status
[22:28:26.341] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:26.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:91:0) after 1m0s
[22:29:26.369] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:91:0)
[22:29:26.369] Timer tick, asking Buildbucket for the build status
[22:29:26.463] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:26.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:92:0) after 1m0s
[22:30:26.487] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:92:0)
[22:30:26.487] Timer tick, asking Buildbucket for the build status
[22:30:26.554] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:26.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:93:0) after 1m0s
[22:31:26.581] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:93:0)
[22:31:26.581] Timer tick, asking Buildbucket for the build status
[22:31:26.639] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:26.639] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:94:0) after 1m0s
[22:32:26.659] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:94:0)
[22:32:26.659] Timer tick, asking Buildbucket for the build status
[22:32:26.690] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:26.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:95:0) after 1m0s
[22:33:26.709] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:95:0)
[22:33:26.709] Timer tick, asking Buildbucket for the build status
[22:33:26.756] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:26.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:96:0) after 1m0s
[22:34:26.777] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:96:0)
[22:34:26.777] Timer tick, asking Buildbucket for the build status
[22:34:26.930] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:26.930] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:97:0) after 1m0s
[22:35:26.993] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:97:0)
[22:35:26.993] Timer tick, asking Buildbucket for the build status
[22:35:27.067] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:27.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:98:0) after 1m0s
[22:36:27.089] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:98:0)
[22:36:27.089] Timer tick, asking Buildbucket for the build status
[22:36:27.148] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:27.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:99:0) after 1m0s
[22:37:27.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:99:0)
[22:37:27.168] Timer tick, asking Buildbucket for the build status
[22:37:27.226] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:27.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:100:0) after 1m0s
[22:38:27.250] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:100:0)
[22:38:27.250] Timer tick, asking Buildbucket for the build status
[22:38:27.352] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:27.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:101:0) after 1m0s
[22:39:27.378] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:101:0)
[22:39:27.378] Timer tick, asking Buildbucket for the build status
[22:39:27.434] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:27.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:102:0) after 1m0s
[22:40:27.462] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:102:0)
[22:40:27.462] Timer tick, asking Buildbucket for the build status
[22:40:27.501] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:27.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:103:0) after 1m0s
[22:41:27.550] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:103:0)
[22:41:27.550] Timer tick, asking Buildbucket for the build status
[22:41:27.645] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:27.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:104:0) after 1m0s
[22:42:27.669] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:104:0)
[22:42:27.669] Timer tick, asking Buildbucket for the build status
[22:42:27.732] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:27.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:105:0) after 1m0s
[22:43:27.751] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:105:0)
[22:43:27.752] Timer tick, asking Buildbucket for the build status
[22:43:27.838] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:27.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:106:0) after 1m0s
[22:44:27.861] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:106:0)
[22:44:27.861] Timer tick, asking Buildbucket for the build status
[22:44:27.941] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:27.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:107:0) after 1m0s
[22:45:27.960] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:107:0)
[22:45:27.960] Timer tick, asking Buildbucket for the build status
[22:45:28.000] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:28.000] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:108:0) after 1m0s
[22:46:28.031] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:108:0)
[22:46:28.031] Timer tick, asking Buildbucket for the build status
[22:46:28.139] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:28.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:109:0) after 1m0s
[22:47:28.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:109:0)
[22:47:28.168] Timer tick, asking Buildbucket for the build status
[22:47:28.242] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:28.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:110:0) after 1m0s
[22:48:28.264] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:110:0)
[22:48:28.264] Timer tick, asking Buildbucket for the build status
[22:48:28.370] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:28.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:111:0) after 1m0s
[22:49:28.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:111:0)
[22:49:28.396] Timer tick, asking Buildbucket for the build status
[22:49:28.549] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:28.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:112:0) after 1m0s
[22:50:28.572] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:112:0)
[22:50:28.572] Timer tick, asking Buildbucket for the build status
[22:50:28.651] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:28.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:113:0) after 1m0s
[22:51:28.698] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:113:0)
[22:51:28.698] Timer tick, asking Buildbucket for the build status
[22:51:28.783] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:28.783] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:114:0) after 1m0s
[22:52:28.804] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:114:0)
[22:52:28.804] Timer tick, asking Buildbucket for the build status
[22:52:28.929] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:28.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:115:0) after 1m0s
[22:53:29.008] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:115:0)
[22:53:29.008] Timer tick, asking Buildbucket for the build status
[22:53:29.063] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:29.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:116:0) after 1m0s
[22:54:29.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:116:0)
[22:54:29.149] Timer tick, asking Buildbucket for the build status
[22:54:29.251] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:29.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:117:0) after 1m0s
[22:55:29.271] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:117:0)
[22:55:29.271] Timer tick, asking Buildbucket for the build status
[22:55:29.306] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:29.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:118:0) after 1m0s
[22:56:29.327] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:118:0)
[22:56:29.327] Timer tick, asking Buildbucket for the build status
[22:56:29.392] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:29.392] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:119:0) after 1m0s
[22:57:29.418] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:119:0)
[22:57:29.418] Timer tick, asking Buildbucket for the build status
[22:57:29.615] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:29.615] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:120:0) after 1m0s
[22:58:29.641] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:120:0)
[22:58:29.641] Timer tick, asking Buildbucket for the build status
[22:58:29.682] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:29.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:121:0) after 1m0s
[22:59:29.702] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:121:0)
[22:59:29.702] Timer tick, asking Buildbucket for the build status
[22:59:29.778] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:29.778] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:122:0) after 1m0s
[23:00:29.801] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:122:0)
[23:00:29.801] Timer tick, asking Buildbucket for the build status
[23:00:29.953] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:29.953] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:123:0) after 1m0s
[23:01:29.972] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:123:0)
[23:01:29.972] Timer tick, asking Buildbucket for the build status
[23:01:30.044] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:30.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:124:0) after 1m0s
[23:02:30.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:124:0)
[23:02:30.072] Timer tick, asking Buildbucket for the build status
[23:02:30.145] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:30.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:125:0) after 1m0s
[23:03:30.182] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:125:0)
[23:03:30.182] Timer tick, asking Buildbucket for the build status
[23:03:30.263] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:30.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:126:0) after 1m0s
[23:04:30.292] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:126:0)
[23:04:30.292] Timer tick, asking Buildbucket for the build status
[23:04:30.365] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:30.365] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:127:0) after 1m0s
[23:05:30.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:127:0)
[23:05:30.396] Timer tick, asking Buildbucket for the build status
[23:05:30.466] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:30.466] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:128:0) after 1m0s
[23:06:30.484] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:128:0)
[23:06:30.484] Timer tick, asking Buildbucket for the build status
[23:06:30.619] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:30.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:129:0) after 1m0s
[23:07:30.643] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:129:0)
[23:07:30.643] Timer tick, asking Buildbucket for the build status
[23:07:31.307] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:31.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:130:0) after 1m0s
[23:08:31.328] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:130:0)
[23:08:31.328] Timer tick, asking Buildbucket for the build status
[23:08:31.402] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:31.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:131:0) after 1m0s
[23:09:31.421] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:131:0)
[23:09:31.421] Timer tick, asking Buildbucket for the build status
[23:09:31.547] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:31.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:132:0) after 1m0s
[23:10:31.572] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:132:0)
[23:10:31.572] Timer tick, asking Buildbucket for the build status
[23:10:31.604] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:31.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:133:0) after 1m0s
[23:11:31.626] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:133:0)
[23:11:31.626] Timer tick, asking Buildbucket for the build status
[23:11:31.683] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:31.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:134:0) after 1m0s
[23:12:31.720] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:134:0)
[23:12:31.720] Timer tick, asking Buildbucket for the build status
[23:12:31.818] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:31.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:135:0) after 1m0s
[23:13:31.890] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:135:0)
[23:13:31.890] Timer tick, asking Buildbucket for the build status
[23:13:33.213] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:33.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:136:0) after 1m0s
[23:14:33.234] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:136:0)
[23:14:33.234] Timer tick, asking Buildbucket for the build status
[23:14:33.304] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:33.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:137:0) after 1m0s
[23:15:33.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:137:0)
[23:15:33.325] Timer tick, asking Buildbucket for the build status
[23:15:34.060] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:34.060] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:138:0) after 1m0s
[23:16:34.081] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:138:0)
[23:16:34.081] Timer tick, asking Buildbucket for the build status
[23:16:34.168] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:34.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:139:0) after 1m0s
[23:17:34.228] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:139:0)
[23:17:34.228] Timer tick, asking Buildbucket for the build status
[23:17:34.275] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:34.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:140:0) after 1m0s
[23:18:34.299] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:140:0)
[23:18:34.299] Timer tick, asking Buildbucket for the build status
[23:18:34.366] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:34.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:141:0) after 1m0s
[23:19:34.395] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:141:0)
[23:19:34.395] Timer tick, asking Buildbucket for the build status
[23:19:34.452] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:34.452] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:142:0) after 1m0s
[23:20:34.476] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:142:0)
[23:20:34.476] Timer tick, asking Buildbucket for the build status
[23:20:34.543] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:34.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:143:0) after 1m0s
[23:21:34.563] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:143:0)
[23:21:34.563] Timer tick, asking Buildbucket for the build status
[23:21:34.632] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:34.632] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:144:0) after 1m0s
[23:22:34.670] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:144:0)
[23:22:34.670] Timer tick, asking Buildbucket for the build status
[23:22:34.990] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:34.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:145:0) after 1m0s
[23:23:35.008] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:145:0)
[23:23:35.008] Timer tick, asking Buildbucket for the build status
[23:23:35.122] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:35.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:146:0) after 1m0s
[23:24:35.145] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:146:0)
[23:24:35.145] Timer tick, asking Buildbucket for the build status
[23:24:35.207] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:35.207] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:147:0) after 1m0s
[23:25:35.610] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:147:0)
[23:25:35.610] Timer tick, asking Buildbucket for the build status
[23:25:35.653] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:35.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:148:0) after 1m0s
[23:26:35.675] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:148:0)
[23:26:35.675] Timer tick, asking Buildbucket for the build status
[23:26:35.734] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:35.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:149:0) after 1m0s
[23:27:35.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:149:0)
[23:27:35.755] Timer tick, asking Buildbucket for the build status
[23:27:35.850] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:35.850] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:150:0) after 1m0s
[23:28:35.872] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:150:0)
[23:28:35.872] Timer tick, asking Buildbucket for the build status
[23:28:35.905] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:35.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:151:0) after 1m0s
[23:29:35.929] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:151:0)
[23:29:35.929] Timer tick, asking Buildbucket for the build status
[23:29:35.958] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:35.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:152:0) after 1m0s
[23:30:35.979] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:152:0)
[23:30:35.979] Timer tick, asking Buildbucket for the build status
[23:30:36.098] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:36.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:153:0) after 1m0s
[23:31:36.134] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:153:0)
[23:31:36.134] Timer tick, asking Buildbucket for the build status
[23:31:36.172] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:36.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:154:0) after 1m0s
[23:32:36.199] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:154:0)
[23:32:36.199] Timer tick, asking Buildbucket for the build status
[23:32:36.323] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:36.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:155:0) after 1m0s
[23:33:36.350] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:155:0)
[23:33:36.350] Timer tick, asking Buildbucket for the build status
[23:33:36.426] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:36.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:156:0) after 1m0s
[23:34:36.451] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:156:0)
[23:34:36.451] Timer tick, asking Buildbucket for the build status
[23:34:36.511] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:36.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:157:0) after 1m0s
[23:35:36.537] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:157:0)
[23:35:36.537] Timer tick, asking Buildbucket for the build status
[23:35:36.573] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:36.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:158:0) after 1m0s
[23:36:36.596] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:158:0)
[23:36:36.596] Timer tick, asking Buildbucket for the build status
[23:36:36.801] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:36.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:159:0) after 1m0s
[23:37:36.839] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:159:0)
[23:37:36.839] Timer tick, asking Buildbucket for the build status
[23:37:37.059] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:37.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:160:0) after 1m0s
[23:38:37.077] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:160:0)
[23:38:37.077] Timer tick, asking Buildbucket for the build status
[23:38:37.166] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:37.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:161:0) after 1m0s
[23:39:37.186] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:161:0)
[23:39:37.186] Timer tick, asking Buildbucket for the build status
[23:39:37.311] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:37.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:162:0) after 1m0s
[23:40:37.336] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:162:0)
[23:40:37.336] Timer tick, asking Buildbucket for the build status
[23:40:37.386] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:37.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:163:0) after 1m0s
[23:41:37.408] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:163:0)
[23:41:37.408] Timer tick, asking Buildbucket for the build status
[23:41:37.471] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:37.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:164:0) after 1m0s
[23:42:37.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:164:0)
[23:42:37.491] Timer tick, asking Buildbucket for the build status
[23:42:37.538] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:37.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:165:0) after 1m0s
[23:43:37.562] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:165:0)
[23:43:37.562] Timer tick, asking Buildbucket for the build status
[23:43:37.621] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:37.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:166:0) after 1m0s
[23:44:37.640] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:166:0)
[23:44:37.640] Timer tick, asking Buildbucket for the build status
[23:44:37.708] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:37.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:167:0) after 1m0s
[23:45:37.752] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:167:0)
[23:45:37.752] Timer tick, asking Buildbucket for the build status
[23:45:37.827] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:37.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:168:0) after 1m0s
[23:46:37.897] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:168:0)
[23:46:37.897] Timer tick, asking Buildbucket for the build status
[23:46:37.956] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:37.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:169:0) after 1m0s
[23:47:37.978] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:169:0)
[23:47:37.978] Timer tick, asking Buildbucket for the build status
[23:47:38.086] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:38.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:170:0) after 1m0s
[23:48:38.144] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:170:0)
[23:48:38.144] Timer tick, asking Buildbucket for the build status
[23:48:38.189] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:38.189] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:171:0) after 1m0s
[23:49:38.210] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:171:0)
[23:49:38.210] Timer tick, asking Buildbucket for the build status
[23:49:38.276] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:38.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:172:0) after 1m0s
[23:50:38.317] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:172:0)
[23:50:38.317] Timer tick, asking Buildbucket for the build status
[23:50:38.358] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:38.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:173:0) after 1m0s
[23:51:38.383] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:173:0)
[23:51:38.383] Timer tick, asking Buildbucket for the build status
[23:51:38.433] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:38.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:174:0) after 1m0s
[23:52:38.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:174:0)
[23:52:38.459] Timer tick, asking Buildbucket for the build status
[23:52:38.495] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:38.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:175:0) after 1m0s
[23:53:38.524] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:175:0)
[23:53:38.524] Timer tick, asking Buildbucket for the build status
[23:53:38.593] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:38.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:176:0) after 1m0s
[23:54:38.621] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:176:0)
[23:54:38.621] Timer tick, asking Buildbucket for the build status
[23:54:38.689] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:38.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:177:0) after 1m0s
[23:55:38.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:177:0)
[23:55:38.715] Timer tick, asking Buildbucket for the build status
[23:55:39.021] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:39.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:178:0) after 1m0s
[23:56:39.045] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:178:0)
[23:56:39.045] Timer tick, asking Buildbucket for the build status
[23:56:39.113] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:39.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:179:0) after 1m0s
[23:57:39.277] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:179:0)
[23:57:39.277] Timer tick, asking Buildbucket for the build status
[23:57:39.341] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:39.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:180:0) after 1m0s
[23:58:39.374] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:180:0)
[23:58:39.374] Timer tick, asking Buildbucket for the build status
[23:58:39.450] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:39.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:181:0) after 1m0s
[23:59:39.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:181:0)
[23:59:39.473] Timer tick, asking Buildbucket for the build status
[23:59:39.631] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:39.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:182:0) after 1m0s
[00:00:39.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:182:0)
[00:00:39.652] Timer tick, asking Buildbucket for the build status
[00:00:39.767] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:39.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:183:0) after 1m0s
[00:01:39.788] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:183:0)
[00:01:39.788] Timer tick, asking Buildbucket for the build status
[00:01:39.855] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:39.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:184:0) after 1m0s
[00:02:39.884] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:184:0)
[00:02:39.884] Timer tick, asking Buildbucket for the build status
[00:02:39.941] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:39.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:185:0) after 1m0s
[00:03:39.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:185:0)
[00:03:39.971] Timer tick, asking Buildbucket for the build status
[00:03:40.210] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:40.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:186:0) after 1m0s
[00:04:40.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:186:0)
[00:04:40.233] Timer tick, asking Buildbucket for the build status
[00:04:40.283] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:40.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:187:0) after 1m0s
[00:05:40.313] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:187:0)
[00:05:40.313] Timer tick, asking Buildbucket for the build status
[00:05:40.369] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:40.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:188:0) after 1m0s
[00:06:40.441] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:188:0)
[00:06:40.441] Timer tick, asking Buildbucket for the build status
[00:06:40.484] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:40.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:189:0) after 1m0s
[00:07:40.505] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:189:0)
[00:07:40.505] Timer tick, asking Buildbucket for the build status
[00:07:40.606] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:40.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:190:0) after 1m0s
[00:08:40.635] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:190:0)
[00:08:40.635] Timer tick, asking Buildbucket for the build status
[00:08:40.750] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:40.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:191:0) after 1m0s
[00:09:40.811] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:191:0)
[00:09:40.811] Timer tick, asking Buildbucket for the build status
[00:09:40.865] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:40.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:192:0) after 1m0s
[00:10:40.889] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:192:0)
[00:10:40.889] Timer tick, asking Buildbucket for the build status
[00:10:40.953] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:40.953] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:193:0) after 1m0s
[00:11:40.980] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:193:0)
[00:11:40.980] Timer tick, asking Buildbucket for the build status
[00:11:41.046] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:41.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:194:0) after 1m0s
[00:12:41.070] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:194:0)
[00:12:41.070] Timer tick, asking Buildbucket for the build status
[00:12:41.144] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:41.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:195:0) after 1m0s
[00:13:41.189] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:195:0)
[00:13:41.189] Timer tick, asking Buildbucket for the build status
[00:13:41.255] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:41.255] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:196:0) after 1m0s
[00:14:41.283] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:196:0)
[00:14:41.283] Timer tick, asking Buildbucket for the build status
[00:14:41.340] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:41.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:197:0) after 1m0s
[00:15:41.362] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:197:0)
[00:15:41.362] Timer tick, asking Buildbucket for the build status
[00:15:41.421] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:41.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:198:0) after 1m0s
[00:16:41.444] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:198:0)
[00:16:41.444] Timer tick, asking Buildbucket for the build status
[00:16:41.718] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:41.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:199:0) after 1m0s
[00:17:41.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:199:0)
[00:17:41.749] Timer tick, asking Buildbucket for the build status
[00:17:41.821] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:41.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:200:0) after 1m0s
[00:18:41.851] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:200:0)
[00:18:41.851] Timer tick, asking Buildbucket for the build status
[00:18:41.898] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:41.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:201:0) after 1m0s
[00:19:41.943] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:201:0)
[00:19:41.943] Timer tick, asking Buildbucket for the build status
[00:19:42.039] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:42.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:202:0) after 1m0s
[00:20:42.063] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:202:0)
[00:20:42.063] Timer tick, asking Buildbucket for the build status
[00:20:42.134] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:42.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:203:0) after 1m0s
[00:21:42.157] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:203:0)
[00:21:42.157] Timer tick, asking Buildbucket for the build status
[00:21:42.226] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:42.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:204:0) after 1m0s
[00:22:42.251] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:204:0)
[00:22:42.251] Timer tick, asking Buildbucket for the build status
[00:22:42.805] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:42.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:205:0) after 1m0s
[00:23:42.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:205:0)
[00:23:42.832] Timer tick, asking Buildbucket for the build status
[00:23:42.919] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:42.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:206:0) after 1m0s
[00:24:42.941] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:206:0)
[00:24:42.941] Timer tick, asking Buildbucket for the build status
[00:24:43.150] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:43.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:207:0) after 1m0s
[00:25:43.174] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:207:0)
[00:25:43.174] Timer tick, asking Buildbucket for the build status
[00:25:43.233] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:43.233] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:208:0) after 1m0s
[00:26:43.261] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:208:0)
[00:26:43.261] Timer tick, asking Buildbucket for the build status
[00:26:43.296] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:43.296] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:209:0) after 1m0s
[00:27:43.320] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:209:0)
[00:27:43.320] Timer tick, asking Buildbucket for the build status
[00:27:43.414] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:43.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:210:0) after 1m0s
[00:28:43.437] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:210:0)
[00:28:43.437] Timer tick, asking Buildbucket for the build status
[00:28:43.479] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:43.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:211:0) after 1m0s
[00:29:43.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:211:0)
[00:29:43.503] Timer tick, asking Buildbucket for the build status
[00:29:43.540] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:43.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:212:0) after 1m0s
[00:30:43.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:212:0)
[00:30:43.569] Timer tick, asking Buildbucket for the build status
[00:30:43.607] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:43.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:213:0) after 1m0s
[00:31:43.629] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:213:0)
[00:31:43.629] Timer tick, asking Buildbucket for the build status
[00:31:43.680] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:43.680] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:214:0) after 1m0s
[00:32:43.703] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:214:0)
[00:32:43.703] Timer tick, asking Buildbucket for the build status
[00:32:43.744] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:43.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:215:0) after 1m0s
[00:33:43.766] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:215:0)
[00:33:43.766] Timer tick, asking Buildbucket for the build status
[00:33:43.834] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:43.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:216:0) after 1m0s
[00:34:43.857] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:216:0)
[00:34:43.857] Timer tick, asking Buildbucket for the build status
[00:34:44.007] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:44.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:217:0) after 1m0s
[00:35:44.042] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:217:0)
[00:35:44.042] Timer tick, asking Buildbucket for the build status
[00:35:44.138] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:44.138] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:218:0) after 1m0s
[00:36:44.170] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:218:0)
[00:36:44.170] Timer tick, asking Buildbucket for the build status
[00:36:44.293] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:44.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:219:0) after 1m0s
[00:37:44.330] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:219:0)
[00:37:44.330] Timer tick, asking Buildbucket for the build status
[00:37:44.382] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:44.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:220:0) after 1m0s
[00:38:44.407] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:220:0)
[00:38:44.407] Timer tick, asking Buildbucket for the build status
[00:38:44.444] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:44.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:221:0) after 1m0s
[00:39:44.472] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:221:0)
[00:39:44.472] Timer tick, asking Buildbucket for the build status
[00:39:44.621] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:44.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:222:0) after 1m0s
[00:40:44.648] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:222:0)
[00:40:44.648] Timer tick, asking Buildbucket for the build status
[00:40:44.702] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:44.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:223:0) after 1m0s
[00:41:44.731] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:223:0)
[00:41:44.731] Timer tick, asking Buildbucket for the build status
[00:41:44.859] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:44.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:224:0) after 1m0s
[00:42:44.889] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:224:0)
[00:42:44.889] Timer tick, asking Buildbucket for the build status
[00:42:45.013] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:45.013] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:225:0) after 1m0s
[00:43:45.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:225:0)
[00:43:45.035] Timer tick, asking Buildbucket for the build status
[00:43:45.178] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:45.178] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:226:0) after 1m0s
[00:44:45.201] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:226:0)
[00:44:45.201] Timer tick, asking Buildbucket for the build status
[00:44:45.236] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:45.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:227:0) after 1m0s
[00:45:45.258] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:227:0)
[00:45:45.258] Timer tick, asking Buildbucket for the build status
[00:45:45.465] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:45.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:228:0) after 1m0s
[00:46:45.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:228:0)
[00:46:45.491] Timer tick, asking Buildbucket for the build status
[00:46:45.548] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:45.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:229:0) after 1m0s
[00:47:45.573] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:229:0)
[00:47:45.573] Timer tick, asking Buildbucket for the build status
[00:47:45.644] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:45.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:230:0) after 1m0s
[00:48:45.668] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:230:0)
[00:48:45.668] Timer tick, asking Buildbucket for the build status
[00:48:45.707] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:45.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:231:0) after 1m0s
[00:49:45.744] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:231:0)
[00:49:45.744] Timer tick, asking Buildbucket for the build status
[00:49:45.835] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:45.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:232:0) after 1m0s
[00:50:45.866] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:232:0)
[00:50:45.866] Timer tick, asking Buildbucket for the build status
[00:50:45.903] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:45.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:233:0) after 1m0s
[00:51:45.936] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:233:0)
[00:51:45.936] Timer tick, asking Buildbucket for the build status
[00:51:45.988] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:45.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:234:0) after 1m0s
[00:52:46.011] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:234:0)
[00:52:46.011] Timer tick, asking Buildbucket for the build status
[00:52:46.047] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:46.047] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:235:0) after 1m0s
[00:53:46.121] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:235:0)
[00:53:46.121] Timer tick, asking Buildbucket for the build status
[00:53:46.222] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:46.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:236:0) after 1m0s
[00:54:46.247] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:236:0)
[00:54:46.247] Timer tick, asking Buildbucket for the build status
[00:54:46.334] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:46.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:237:0) after 1m0s
[00:55:46.386] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:237:0)
[00:55:46.386] Timer tick, asking Buildbucket for the build status
[00:55:46.631] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:46.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:238:0) after 1m0s
[00:56:46.688] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:238:0)
[00:56:46.688] Timer tick, asking Buildbucket for the build status
[00:56:46.740] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:46.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:239:0) after 1m0s
[00:57:46.768] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:239:0)
[00:57:46.768] Timer tick, asking Buildbucket for the build status
[00:57:46.838] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:46.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:240:0) after 1m0s
[00:58:46.866] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:240:0)
[00:58:46.866] Timer tick, asking Buildbucket for the build status
[00:58:47.033] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:47.033] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:241:0) after 1m0s
[00:59:47.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:241:0)
[00:59:47.071] Timer tick, asking Buildbucket for the build status
[00:59:47.206] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:47.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:242:0) after 1m0s
[01:00:47.231] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:242:0)
[01:00:47.231] Timer tick, asking Buildbucket for the build status
[01:00:47.270] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:47.270] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:243:0) after 1m0s
[01:01:47.301] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:243:0)
[01:01:47.301] Timer tick, asking Buildbucket for the build status
[01:01:47.368] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:47.368] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:244:0) after 1m0s
[01:02:47.389] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:244:0)
[01:02:47.389] Timer tick, asking Buildbucket for the build status
[01:02:47.454] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:47.454] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:245:0) after 1m0s
[01:03:47.479] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:245:0)
[01:03:47.479] Timer tick, asking Buildbucket for the build status
[01:03:47.556] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:47.556] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:246:0) after 1m0s
[01:04:47.580] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:246:0)
[01:04:47.580] Timer tick, asking Buildbucket for the build status
[01:04:48.415] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:48.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:247:0) after 1m0s
[01:05:48.440] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:247:0)
[01:05:48.440] Timer tick, asking Buildbucket for the build status
[01:05:48.489] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:48.489] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:248:0) after 1m0s
[01:06:48.515] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:248:0)
[01:06:48.515] Timer tick, asking Buildbucket for the build status
[01:06:48.617] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:48.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:249:0) after 1m0s
[01:07:48.641] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:249:0)
[01:07:48.641] Timer tick, asking Buildbucket for the build status
[01:07:48.688] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:48.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:250:0) after 1m0s
[01:08:48.724] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:250:0)
[01:08:48.724] Timer tick, asking Buildbucket for the build status
[01:08:48.842] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:48.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:251:0) after 1m0s
[01:09:48.866] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:251:0)
[01:09:48.866] Timer tick, asking Buildbucket for the build status
[01:09:48.917] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:48.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:252:0) after 1m0s
[01:10:48.942] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:252:0)
[01:10:48.942] Timer tick, asking Buildbucket for the build status
[01:10:48.995] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:48.996] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:253:0) after 1m0s
[01:11:49.023] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:253:0)
[01:11:49.023] Timer tick, asking Buildbucket for the build status
[01:11:49.093] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:49.093] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:254:0) after 1m0s
[01:12:49.141] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:254:0)
[01:12:49.141] Timer tick, asking Buildbucket for the build status
[01:12:49.183] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:49.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:255:0) after 1m0s
[01:13:49.206] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:255:0)
[01:13:49.206] Timer tick, asking Buildbucket for the build status
[01:13:49.358] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:49.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:256:0) after 1m0s
[01:14:49.386] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:256:0)
[01:14:49.386] Timer tick, asking Buildbucket for the build status
[01:14:49.481] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:49.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:257:0) after 1m0s
[01:15:49.613] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:257:0)
[01:15:49.613] Timer tick, asking Buildbucket for the build status
[01:15:49.681] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:49.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:258:0) after 1m0s
[01:16:49.725] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:258:0)
[01:16:49.725] Timer tick, asking Buildbucket for the build status
[01:16:49.758] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:49.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:259:0) after 1m0s
[01:17:49.803] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:259:0)
[01:17:49.803] Timer tick, asking Buildbucket for the build status
[01:17:49.848] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:49.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:260:0) after 1m0s
[01:18:49.893] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:260:0)
[01:18:49.893] Timer tick, asking Buildbucket for the build status
[01:18:49.964] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:49.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:261:0) after 1m0s
[01:19:50.076] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:261:0)
[01:19:50.076] Timer tick, asking Buildbucket for the build status
[01:19:50.123] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:50.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:262:0) after 1m0s
[01:20:50.144] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:262:0)
[01:20:50.144] Timer tick, asking Buildbucket for the build status
[01:20:50.564] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:50.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:263:0) after 1m0s
[01:21:50.590] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:263:0)
[01:21:50.591] Timer tick, asking Buildbucket for the build status
[01:21:50.712] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:50.712] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:264:0) after 1m0s
[01:22:50.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:264:0)
[01:22:50.740] Timer tick, asking Buildbucket for the build status
[01:22:50.810] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:50.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:265:0) after 1m0s
[01:23:50.835] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:265:0)
[01:23:50.835] Timer tick, asking Buildbucket for the build status
[01:23:51.306] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:51.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:266:0) after 1m0s
[01:24:51.333] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:266:0)
[01:24:51.333] Timer tick, asking Buildbucket for the build status
[01:24:51.464] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:51.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:267:0) after 1m0s
[01:25:51.510] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:267:0)
[01:25:51.510] Timer tick, asking Buildbucket for the build status
[01:25:51.559] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:51.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:268:0) after 1m0s
[01:26:51.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:268:0)
[01:26:51.646] Timer tick, asking Buildbucket for the build status
[01:26:51.727] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:51.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:269:0) after 1m0s
[01:27:51.854] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:269:0)
[01:27:51.854] Timer tick, asking Buildbucket for the build status
[01:27:51.898] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:51.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:270:0) after 1m0s
[01:28:51.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:270:0)
[01:28:51.921] Timer tick, asking Buildbucket for the build status
[01:28:51.977] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:51.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:271:0) after 1m0s
[01:29:52.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:271:0)
[01:29:52.001] Timer tick, asking Buildbucket for the build status
[01:29:52.107] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:52.107] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:272:0) after 1m0s
[01:30:52.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:272:0)
[01:30:52.147] Timer tick, asking Buildbucket for the build status
[01:30:52.226] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:52.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:273:0) after 1m0s
[01:31:52.248] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:273:0)
[01:31:52.248] Timer tick, asking Buildbucket for the build status
[01:31:52.329] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:52.329] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:274:0) after 1m0s
[01:32:52.355] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:274:0)
[01:32:52.355] Timer tick, asking Buildbucket for the build status
[01:32:52.445] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:52.445] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:275:0) after 1m0s
[01:33:52.480] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:275:0)
[01:33:52.480] Timer tick, asking Buildbucket for the build status
[01:33:52.566] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:52.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:276:0) after 1m0s
[01:34:52.594] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:276:0)
[01:34:52.594] Timer tick, asking Buildbucket for the build status
[01:34:52.663] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:52.663] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:277:0) after 1m0s
[01:35:52.689] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:277:0)
[01:35:52.689] Timer tick, asking Buildbucket for the build status
[01:35:52.797] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:52.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:278:0) after 1m0s
[01:36:52.823] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:278:0)
[01:36:52.823] Timer tick, asking Buildbucket for the build status
[01:36:53.009] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:53.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:279:0) after 1m0s
[01:37:53.046] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:279:0)
[01:37:53.046] Timer tick, asking Buildbucket for the build status
[01:37:53.105] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:53.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:280:0) after 1m0s
[01:38:53.153] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:280:0)
[01:38:53.153] Timer tick, asking Buildbucket for the build status
[01:38:53.326] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:53.326] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:281:0) after 1m0s
[01:39:53.362] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:281:0)
[01:39:53.362] Timer tick, asking Buildbucket for the build status
[01:39:53.478] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:53.478] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:282:0) after 1m0s
[01:40:53.502] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:282:0)
[01:40:53.502] Timer tick, asking Buildbucket for the build status
[01:40:53.643] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:53.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:283:0) after 1m0s
[01:41:53.680] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:283:0)
[01:41:53.680] Timer tick, asking Buildbucket for the build status
[01:41:53.763] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:53.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:284:0) after 1m0s
[01:42:53.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:284:0)
[01:42:53.787] Timer tick, asking Buildbucket for the build status
[01:42:53.857] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:53.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:285:0) after 1m0s
[01:43:53.886] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:285:0)
[01:43:53.886] Timer tick, asking Buildbucket for the build status
[01:43:54.294] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:54.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:286:0) after 1m0s
[01:44:54.328] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:286:0)
[01:44:54.328] Timer tick, asking Buildbucket for the build status
[01:44:54.388] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:54.388] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:287:0) after 1m0s
[01:45:54.419] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:287:0)
[01:45:54.419] Timer tick, asking Buildbucket for the build status
[01:45:54.548] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:54.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:288:0) after 1m0s
[01:46:54.576] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:288:0)
[01:46:54.576] Timer tick, asking Buildbucket for the build status
[01:46:54.631] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:54.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:289:0) after 1m0s
[01:47:54.655] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:289:0)
[01:47:54.655] Timer tick, asking Buildbucket for the build status
[01:47:54.700] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:54.700] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:290:0) after 1m0s
[01:48:54.819] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:290:0)
[01:48:54.819] Timer tick, asking Buildbucket for the build status
[01:48:54.964] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:54.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:291:0) after 1m0s
[01:49:54.989] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:291:0)
[01:49:54.989] Timer tick, asking Buildbucket for the build status
[01:49:55.064] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:55.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:292:0) after 1m0s
[01:50:55.132] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:292:0)
[01:50:55.132] Timer tick, asking Buildbucket for the build status
[01:50:55.168] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:55.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:293:0) after 1m0s
[01:51:55.194] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:293:0)
[01:51:55.194] Timer tick, asking Buildbucket for the build status
[01:51:55.283] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:55.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:294:0) after 1m0s
[01:52:55.307] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:294:0)
[01:52:55.307] Timer tick, asking Buildbucket for the build status
[01:52:55.370] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:55.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:295:0) after 1m0s
[01:53:55.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:295:0)
[01:53:55.398] Timer tick, asking Buildbucket for the build status
[01:53:55.474] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:55.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:296:0) after 1m0s
[01:54:55.508] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:296:0)
[01:54:55.508] Timer tick, asking Buildbucket for the build status
[01:54:55.600] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:55.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:297:0) after 1m0s
[01:55:55.625] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:297:0)
[01:55:55.625] Timer tick, asking Buildbucket for the build status
[01:55:55.883] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:55.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:298:0) after 1m0s
[01:56:55.907] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:298:0)
[01:56:55.907] Timer tick, asking Buildbucket for the build status
[01:56:55.965] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:55.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:299:0) after 1m0s
[01:57:55.992] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:299:0)
[01:57:55.992] Timer tick, asking Buildbucket for the build status
[01:57:56.234] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:56.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:300:0) after 1m0s
[01:58:56.268] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:300:0)
[01:58:56.268] Timer tick, asking Buildbucket for the build status
[01:58:56.447] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:56.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:301:0) after 1m0s
[01:59:56.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:301:0)
[01:59:56.473] Timer tick, asking Buildbucket for the build status
[01:59:56.515] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:56.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:302:0) after 1m0s
[02:00:56.550] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:302:0)
[02:00:56.550] Timer tick, asking Buildbucket for the build status
[02:00:56.737] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:56.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:303:0) after 1m0s
[02:01:56.764] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:303:0)
[02:01:56.764] Timer tick, asking Buildbucket for the build status
[02:01:56.842] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:56.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:304:0) after 1m0s
[02:02:56.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:304:0)
[02:02:56.871] Timer tick, asking Buildbucket for the build status
[02:02:56.955] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:56.955] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:305:0) after 1m0s
[02:03:56.979] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:305:0)
[02:03:56.979] Timer tick, asking Buildbucket for the build status
[02:03:57.030] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:57.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:306:0) after 1m0s
[02:04:57.059] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:306:0)
[02:04:57.059] Timer tick, asking Buildbucket for the build status
[02:04:57.197] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:57.197] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:307:0) after 1m0s
[02:05:57.301] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:307:0)
[02:05:57.301] Timer tick, asking Buildbucket for the build status
[02:05:57.354] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:57.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:308:0) after 1m0s
[02:06:57.381] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:308:0)
[02:06:57.381] Timer tick, asking Buildbucket for the build status
[02:06:57.556] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:57.556] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:309:0) after 1m0s
[02:07:57.583] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:309:0)
[02:07:57.583] Timer tick, asking Buildbucket for the build status
[02:07:57.666] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:57.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:310:0) after 1m0s
[02:08:57.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:310:0)
[02:08:57.701] Timer tick, asking Buildbucket for the build status
[02:08:57.777] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:57.778] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:311:0) after 1m0s
[02:09:57.801] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:311:0)
[02:09:57.801] Timer tick, asking Buildbucket for the build status
[02:09:57.862] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:57.862] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:312:0) after 1m0s
[02:10:57.887] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:312:0)
[02:10:57.887] Timer tick, asking Buildbucket for the build status
[02:10:57.998] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:57.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:313:0) after 1m0s
[02:11:58.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:313:0)
[02:11:58.035] Timer tick, asking Buildbucket for the build status
[02:11:58.221] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:58.221] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:314:0) after 1m0s
[02:12:58.270] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:314:0)
[02:12:58.270] Timer tick, asking Buildbucket for the build status
[02:12:58.366] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:58.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:315:0) after 1m0s
[02:13:58.393] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:315:0)
[02:13:58.393] Timer tick, asking Buildbucket for the build status
[02:13:58.515] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:58.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:316:0) after 1m0s
[02:14:58.544] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:316:0)
[02:14:58.544] Timer tick, asking Buildbucket for the build status
[02:14:58.610] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:58.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:317:0) after 1m0s
[02:15:58.653] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:317:0)
[02:15:58.653] Timer tick, asking Buildbucket for the build status
[02:15:58.817] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:58.817] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:318:0) after 1m0s
[02:16:58.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:318:0)
[02:16:58.844] Timer tick, asking Buildbucket for the build status
[02:16:59.049] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:59.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:319:0) after 1m0s
[02:17:59.079] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:319:0)
[02:17:59.079] Timer tick, asking Buildbucket for the build status
[02:17:59.129] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:59.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:320:0) after 1m0s
[02:18:59.156] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:320:0)
[02:18:59.156] Timer tick, asking Buildbucket for the build status
[02:18:59.342] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:59.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:321:0) after 1m0s
[02:19:59.420] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:321:0)
[02:19:59.420] Timer tick, asking Buildbucket for the build status
[02:19:59.492] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:59.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:322:0) after 1m0s
[02:20:59.534] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:322:0)
[02:20:59.534] Timer tick, asking Buildbucket for the build status
[02:20:59.631] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:59.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:323:0) after 1m0s
[02:21:59.658] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:323:0)
[02:21:59.658] Timer tick, asking Buildbucket for the build status
[02:21:59.721] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:59.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:324:0) after 1m0s
[02:22:59.747] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:324:0)
[02:22:59.747] Timer tick, asking Buildbucket for the build status
[02:22:59.865] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:59.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:325:0) after 1m0s
[02:23:59.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:325:0)
[02:23:59.921] Timer tick, asking Buildbucket for the build status
[02:23:59.960] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:59.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:326:0) after 1m0s
[02:25:00.045] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:326:0)
[02:25:00.045] Timer tick, asking Buildbucket for the build status
[02:25:00.222] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:00.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:327:0) after 1m0s
[02:26:00.251] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:327:0)
[02:26:00.251] Timer tick, asking Buildbucket for the build status
[02:26:00.367] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:00.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:328:0) after 1m0s
[02:27:00.409] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:328:0)
[02:27:00.409] Timer tick, asking Buildbucket for the build status
[02:27:00.653] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:00.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:329:0) after 1m0s
[02:28:00.703] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:329:0)
[02:28:00.703] Timer tick, asking Buildbucket for the build status
[02:28:00.780] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:00.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:330:0) after 1m0s
[02:29:00.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:330:0)
[02:29:00.808] Timer tick, asking Buildbucket for the build status
[02:29:01.001] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:01.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:331:0) after 1m0s
[02:30:01.031] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:331:0)
[02:30:01.031] Timer tick, asking Buildbucket for the build status
[02:30:01.078] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:01.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:332:0) after 1m0s
[02:31:01.104] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:332:0)
[02:31:01.104] Timer tick, asking Buildbucket for the build status
[02:31:01.208] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:01.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:333:0) after 1m0s
[02:32:01.237] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:333:0)
[02:32:01.237] Timer tick, asking Buildbucket for the build status
[02:32:01.364] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:01.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:334:0) after 1m0s
[02:33:01.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:334:0)
[02:33:01.397] Timer tick, asking Buildbucket for the build status
[02:33:01.682] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:01.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:335:0) after 1m0s
[02:34:01.711] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:335:0)
[02:34:01.711] Timer tick, asking Buildbucket for the build status
[02:34:01.763] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:01.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:336:0) after 1m0s
[02:35:01.854] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:336:0)
[02:35:01.854] Timer tick, asking Buildbucket for the build status
[02:35:02.164] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:02.164] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:337:0) after 1m0s
[02:36:02.192] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:337:0)
[02:36:02.192] Timer tick, asking Buildbucket for the build status
[02:36:02.309] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:02.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:338:0) after 1m0s
[02:37:02.341] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:338:0)
[02:37:02.341] Timer tick, asking Buildbucket for the build status
[02:37:02.639] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:02.639] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:339:0) after 1m0s
[02:38:02.683] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:339:0)
[02:38:02.683] Timer tick, asking Buildbucket for the build status
[02:38:04.111] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:04.111] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:340:0) after 1m0s
[02:39:04.167] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:340:0)
[02:39:04.167] Timer tick, asking Buildbucket for the build status
[02:39:04.292] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:04.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:341:0) after 1m0s
[02:40:04.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:341:0)
[02:40:04.344] Timer tick, asking Buildbucket for the build status
[02:40:04.407] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:04.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:342:0) after 1m0s
[02:41:04.700] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:342:0)
[02:41:04.700] Timer tick, asking Buildbucket for the build status
[02:41:04.853] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:04.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:343:0) after 1m0s
[02:42:04.885] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:343:0)
[02:42:04.885] Timer tick, asking Buildbucket for the build status
[02:42:04.941] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:04.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:344:0) after 1m0s
[02:43:04.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:344:0)
[02:43:04.969] Timer tick, asking Buildbucket for the build status
[02:43:05.041] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:05.041] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:345:0) after 1m0s
[02:44:05.067] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:345:0)
[02:44:05.067] Timer tick, asking Buildbucket for the build status
[02:44:05.148] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:05.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:346:0) after 1m0s
[02:45:05.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:346:0)
[02:45:05.185] Timer tick, asking Buildbucket for the build status
[02:45:05.238] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:05.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:347:0) after 1m0s
[02:46:05.271] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:347:0)
[02:46:05.271] Timer tick, asking Buildbucket for the build status
[02:46:05.326] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:05.326] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:348:0) after 1m0s
[02:47:05.363] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:348:0)
[02:47:05.363] Timer tick, asking Buildbucket for the build status
[02:47:05.456] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:05.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:349:0) after 1m0s
[02:48:05.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:349:0)
[02:48:05.496] Timer tick, asking Buildbucket for the build status
[02:48:05.532] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:05.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:350:0) after 1m0s
[02:49:05.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:350:0)
[02:49:05.597] Timer tick, asking Buildbucket for the build status
[02:49:05.726] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:05.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:351:0) after 1m0s
[02:50:05.781] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:351:0)
[02:50:05.781] Timer tick, asking Buildbucket for the build status
[02:50:05.868] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:05.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:352:0) after 1m0s
[02:51:05.916] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:352:0)
[02:51:05.916] Timer tick, asking Buildbucket for the build status
[02:51:05.953] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:05.953] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:353:0) after 1m0s
[02:52:06.002] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:353:0)
[02:52:06.002] Timer tick, asking Buildbucket for the build status
[02:52:06.164] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:06.165] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:354:0) after 1m0s
[02:53:06.266] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:354:0)
[02:53:06.267] Timer tick, asking Buildbucket for the build status
[02:53:06.321] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:06.321] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:355:0) after 1m0s
[02:54:06.369] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:355:0)
[02:54:06.369] Timer tick, asking Buildbucket for the build status
[02:54:06.419] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:06.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:356:0) after 1m0s
[02:55:06.472] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:356:0)
[02:55:06.472] Timer tick, asking Buildbucket for the build status
[02:55:06.573] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:06.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:357:0) after 1m0s
[02:56:06.665] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:357:0)
[02:56:06.665] Timer tick, asking Buildbucket for the build status
[02:56:06.729] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:06.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:358:0) after 1m0s
[02:57:06.759] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:358:0)
[02:57:06.759] Timer tick, asking Buildbucket for the build status
[02:57:06.823] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:06.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:359:0) after 1m0s
[02:58:06.851] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:359:0)
[02:58:06.851] Timer tick, asking Buildbucket for the build status
[02:58:07.003] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:07.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:360:0) after 1m0s
[02:59:07.027] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:360:0)
[02:59:07.027] Timer tick, asking Buildbucket for the build status
[02:59:07.115] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:07.115] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:361:0) after 1m0s
[03:00:07.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:361:0)
[03:00:07.147] Timer tick, asking Buildbucket for the build status
[03:00:07.224] Build 8927131328432830560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:07.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9092561390736000512:362:0) after 1m0s
[03:00:09.188] Received PubSub notification, asking Buildbucket for the build status
[03:00:09.334] Build 8927131328432830560: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[03:00:09.335] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "cancelation_reason": "TIMEOUT",
    "completed_ts": "1544842807797688",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1544821155096711",
    "id": "8927131328432830560",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"af5947d13e6794eac489365ff58fd45c0dd4ca2a\"}}",
    "project": "nacl",
    "result": "CANCELED",
    "result_details_json": "{\"swarming\": {\"bot_dimensions\": {}}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "COMPLETED",
    "status_changed_ts": "1544842808566721",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7012",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9092561390736000512",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_dimension:caches:builder_eacc41f1df5d043e03eef0198bc8ddecd24b0492a666afd70585f546f0146c16_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7012",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8927131328432830560",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
      "swarming_tag:builder:linux-pnacl-x86_64",
      "swarming_tag:buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
      "swarming_tag:caches:builder_eacc41f1df5d043e03eef0198bc8ddecd24b0492a666afd70585f546f0146c16_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8927131328432830560/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9092561390736000512",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:ee62e96c73f38e03db7f2d5dd18fea50e0f44727",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:41c755af3800be10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1544842808567471",
    "url": "https://ci.chromium.org/b/8927131328432830560",
    "utcnow_ts": "1544842809263117"
  }
}
[03:00:09.335] Invocation finished in 6h0m55.819419275s with status FAILED