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

• 9f85491d8830fe6f3b8e0efa2e954f71bd9c64af (6 years ago)

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

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

[21:57:28.991] New invocation is queued and will start shortly
[21:57:30.396] Starting the invocation (attempt 1)
[21:57:30.426] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:57:30.427] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:57:30.427] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9100258467623493424",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-x86_64\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"9f85491d8830fe6f3b8e0efa2e954f71bd9c64af\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-pnacl-x86_64-tests-x86_64",
    "scheduler_invocation_id:9100258467623493424",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
    "gitiles_ref:refs/heads/master"
  ]
}
[21:57:32.902] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1537480650544066",
    "experimental": true,
    "id": "8934828405333308400",
    "lease_expiration_ts": "1537599452634525",
    "lease_key": "1686234552",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f85491d8830fe6f3b8e0efa2e954f71bd9c64af\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1537480652787330",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_64/6",
      "builder:linux-pnacl-x86_64-tests-x86_64",
      "buildset:commit/git/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9100258467623493424",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_64",
      "swarming_dimension:caches:builder_b19c502ace169a4787e50af1f7263ca77b2393148a21a94968e2c3ee554fdb58_v2",
      "swarming_dimension:cores:8",
      "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-tests-x86_64/6",
      "swarming_tag:buildbucket_bucket:luci.nacl.toolchain",
      "swarming_tag:buildbucket_build_id:8934828405333308400",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:1630ff158d8d4118027817e4d74c356b46464ed9",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-x86_64",
      "swarming_tag:buildset:commit/git/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
      "swarming_tag:caches:builder_b19c502ace169a4787e50af1f7263ca77b2393148a21a94968e2c3ee554fdb58_v2",
      "swarming_tag:cores:8",
      "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/8934828405333308400/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:60",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9100258467623493424",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-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:a636fa546b9b663cc0d60eefebb84621a4dfa011",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4011ce7d209eaf10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1537480652787424",
    "url": "https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_64/6",
    "utcnow_ts": "1537480652867009"
  }
}
[21:57:32.902] Task URL: https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_64/6
[21:57:32.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:2:0) after 1m0s
[21:58:32.955] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:2:0)
[21:58:32.955] Timer tick, asking Buildbucket for the build status
[21:58:33.143] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:58:33.143] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:3:0) after 1m0s
[21:59:33.161] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:3:0)
[21:59:33.161] Timer tick, asking Buildbucket for the build status
[21:59:33.220] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:59:33.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:4:0) after 1m0s
[22:00:33.252] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:4:0)
[22:00:33.252] Timer tick, asking Buildbucket for the build status
[22:00:33.327] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:00:33.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:5:0) after 1m0s
[22:01:33.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:5:0)
[22:01:33.344] Timer tick, asking Buildbucket for the build status
[22:01:33.521] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:01:33.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:6:0) after 1m0s
[22:02:33.537] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:6:0)
[22:02:33.537] Timer tick, asking Buildbucket for the build status
[22:02:33.592] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:33.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:7:0) after 1m0s
[22:03:33.674] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:7:0)
[22:03:33.674] Timer tick, asking Buildbucket for the build status
[22:03:33.705] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:03:33.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:8:0) after 1m0s
[22:04:33.798] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:8:0)
[22:04:33.798] Timer tick, asking Buildbucket for the build status
[22:04:33.917] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:04:33.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:9:0) after 1m0s
[22:05:33.934] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:9:0)
[22:05:33.934] Timer tick, asking Buildbucket for the build status
[22:05:33.992] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:05:33.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:10:0) after 1m0s
[22:06:34.017] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:10:0)
[22:06:34.017] Timer tick, asking Buildbucket for the build status
[22:06:34.212] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:06:34.212] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:11:0) after 1m0s
[22:07:34.232] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:11:0)
[22:07:34.232] Timer tick, asking Buildbucket for the build status
[22:07:34.291] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:07:34.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:12:0) after 1m0s
[22:08:34.310] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:12:0)
[22:08:34.310] Timer tick, asking Buildbucket for the build status
[22:08:34.346] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:08:34.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:13:0) after 1m0s
[22:09:34.372] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:13:0)
[22:09:34.372] Timer tick, asking Buildbucket for the build status
[22:09:34.689] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:34.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:14:0) after 1m0s
[22:10:34.782] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:14:0)
[22:10:34.782] Timer tick, asking Buildbucket for the build status
[22:10:34.938] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:34.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:15:0) after 1m0s
[22:11:35.047] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:15:0)
[22:11:35.047] Timer tick, asking Buildbucket for the build status
[22:11:35.228] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:11:35.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:16:0) after 1m0s
[22:12:35.265] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:16:0)
[22:12:35.265] Timer tick, asking Buildbucket for the build status
[22:12:35.312] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:12:35.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:17:0) after 1m0s
[22:13:35.347] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:17:0)
[22:13:35.347] Timer tick, asking Buildbucket for the build status
[22:13:35.509] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:13:35.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:18:0) after 1m0s
[22:14:35.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:18:0)
[22:14:35.556] Timer tick, asking Buildbucket for the build status
[22:14:35.661] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:14:35.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:19:0) after 1m0s
[22:15:35.681] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:19:0)
[22:15:35.681] Timer tick, asking Buildbucket for the build status
[22:15:35.732] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:15:35.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:20:0) after 1m0s
[22:16:35.751] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:20:0)
[22:16:35.751] Timer tick, asking Buildbucket for the build status
[22:16:35.864] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:16:35.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:21:0) after 1m0s
[22:17:35.935] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:21:0)
[22:17:35.935] Timer tick, asking Buildbucket for the build status
[22:17:36.053] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:17:36.053] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:22:0) after 1m0s
[22:18:36.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:22:0)
[22:18:36.071] Timer tick, asking Buildbucket for the build status
[22:18:36.151] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:18:36.151] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:23:0) after 1m0s
[22:19:36.166] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:23:0)
[22:19:36.166] Timer tick, asking Buildbucket for the build status
[22:19:36.213] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:19:36.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:24:0) after 1m0s
[22:20:36.232] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:24:0)
[22:20:36.232] Timer tick, asking Buildbucket for the build status
[22:20:36.359] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:20:36.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:25:0) after 1m0s
[22:21:36.400] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:25:0)
[22:21:36.400] Timer tick, asking Buildbucket for the build status
[22:21:36.445] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:21:36.445] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:26:0) after 1m0s
[22:22:36.465] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:26:0)
[22:22:36.465] Timer tick, asking Buildbucket for the build status
[22:22:36.545] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:36.545] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:27:0) after 1m0s
[22:23:36.563] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:27:0)
[22:23:36.563] Timer tick, asking Buildbucket for the build status
[22:23:36.619] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:36.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:28:0) after 1m0s
[22:24:36.638] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:28:0)
[22:24:36.638] Timer tick, asking Buildbucket for the build status
[22:24:36.712] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:36.712] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:29:0) after 1m0s
[22:25:36.730] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:29:0)
[22:25:36.730] Timer tick, asking Buildbucket for the build status
[22:25:36.970] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:36.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:30:0) after 1m0s
[22:26:36.989] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:30:0)
[22:26:36.989] Timer tick, asking Buildbucket for the build status
[22:26:37.043] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:37.043] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:31:0) after 1m0s
[22:27:37.060] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:31:0)
[22:27:37.060] Timer tick, asking Buildbucket for the build status
[22:27:37.129] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:37.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:32:0) after 1m0s
[22:28:37.145] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:32:0)
[22:28:37.145] Timer tick, asking Buildbucket for the build status
[22:28:37.204] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:37.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:33:0) after 1m0s
[22:29:37.222] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:33:0)
[22:29:37.222] Timer tick, asking Buildbucket for the build status
[22:29:37.348] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:37.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:34:0) after 1m0s
[22:30:37.364] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:34:0)
[22:30:37.364] Timer tick, asking Buildbucket for the build status
[22:30:37.425] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:37.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:35:0) after 1m0s
[22:31:37.444] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:35:0)
[22:31:37.444] Timer tick, asking Buildbucket for the build status
[22:31:37.479] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:37.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:36:0) after 1m0s
[22:32:37.498] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:36:0)
[22:32:37.498] Timer tick, asking Buildbucket for the build status
[22:32:37.539] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:37.539] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:37:0) after 1m0s
[22:33:37.560] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:37:0)
[22:33:37.560] Timer tick, asking Buildbucket for the build status
[22:33:37.622] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:37.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:38:0) after 1m0s
[22:34:37.639] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:38:0)
[22:34:37.639] Timer tick, asking Buildbucket for the build status
[22:34:37.701] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:37.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:39:0) after 1m0s
[22:35:37.720] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:39:0)
[22:35:37.720] Timer tick, asking Buildbucket for the build status
[22:35:37.754] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:37.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:40:0) after 1m0s
[22:36:37.771] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:40:0)
[22:36:37.771] Timer tick, asking Buildbucket for the build status
[22:36:37.849] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:37.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:41:0) after 1m0s
[22:37:37.868] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:41:0)
[22:37:37.868] Timer tick, asking Buildbucket for the build status
[22:37:37.900] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:37.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:42:0) after 1m0s
[22:38:37.919] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:42:0)
[22:38:37.919] Timer tick, asking Buildbucket for the build status
[22:38:37.978] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:37.978] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:43:0) after 1m0s
[22:39:37.996] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:43:0)
[22:39:37.996] Timer tick, asking Buildbucket for the build status
[22:39:38.092] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:38.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:44:0) after 1m0s
[22:40:38.109] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:44:0)
[22:40:38.109] Timer tick, asking Buildbucket for the build status
[22:40:38.223] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:38.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:45:0) after 1m0s
[22:41:38.245] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:45:0)
[22:41:38.245] Timer tick, asking Buildbucket for the build status
[22:41:38.293] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:38.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:46:0) after 1m0s
[22:42:38.311] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:46:0)
[22:42:38.311] Timer tick, asking Buildbucket for the build status
[22:42:38.393] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:38.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:47:0) after 1m0s
[22:43:38.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:47:0)
[22:43:38.414] Timer tick, asking Buildbucket for the build status
[22:43:38.460] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:38.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:48:0) after 1m0s
[22:44:38.479] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:48:0)
[22:44:38.479] Timer tick, asking Buildbucket for the build status
[22:44:38.614] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:38.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:49:0) after 1m0s
[22:45:38.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:49:0)
[22:45:38.646] Timer tick, asking Buildbucket for the build status
[22:45:38.711] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:38.711] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:50:0) after 1m0s
[22:46:38.728] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:50:0)
[22:46:38.728] Timer tick, asking Buildbucket for the build status
[22:46:38.804] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:38.804] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:51:0) after 1m0s
[22:47:38.822] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:51:0)
[22:47:38.822] Timer tick, asking Buildbucket for the build status
[22:47:38.877] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:38.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:52:0) after 1m0s
[22:48:38.901] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:52:0)
[22:48:38.901] Timer tick, asking Buildbucket for the build status
[22:48:38.961] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:38.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:53:0) after 1m0s
[22:49:38.983] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:53:0)
[22:49:38.983] Timer tick, asking Buildbucket for the build status
[22:49:39.018] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:39.018] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:54:0) after 1m0s
[22:50:39.056] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:54:0)
[22:50:39.056] Timer tick, asking Buildbucket for the build status
[22:50:39.120] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:39.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:55:0) after 1m0s
[22:51:39.153] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:55:0)
[22:51:39.153] Timer tick, asking Buildbucket for the build status
[22:51:39.193] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:39.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:56:0) after 1m0s
[22:52:39.225] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:56:0)
[22:52:39.225] Timer tick, asking Buildbucket for the build status
[22:52:39.572] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:39.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:57:0) after 1m0s
[22:53:39.589] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:57:0)
[22:53:39.589] Timer tick, asking Buildbucket for the build status
[22:53:39.683] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:39.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:58:0) after 1m0s
[22:54:39.704] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:58:0)
[22:54:39.704] Timer tick, asking Buildbucket for the build status
[22:54:39.782] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:39.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:59:0) after 1m0s
[22:55:39.800] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:59:0)
[22:55:39.800] Timer tick, asking Buildbucket for the build status
[22:55:39.845] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:39.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:60:0) after 1m0s
[22:56:39.863] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:60:0)
[22:56:39.863] Timer tick, asking Buildbucket for the build status
[22:56:40.028] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:40.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:61:0) after 1m0s
[22:57:40.063] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:61:0)
[22:57:40.063] Timer tick, asking Buildbucket for the build status
[22:57:40.116] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:40.116] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:62:0) after 1m0s
[22:58:40.135] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:62:0)
[22:58:40.135] Timer tick, asking Buildbucket for the build status
[22:58:40.406] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:40.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:63:0) after 1m0s
[22:59:40.427] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:63:0)
[22:59:40.427] Timer tick, asking Buildbucket for the build status
[22:59:40.534] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:40.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:64:0) after 1m0s
[23:00:40.570] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:64:0)
[23:00:40.570] Timer tick, asking Buildbucket for the build status
[23:00:40.802] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:40.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:65:0) after 1m0s
[23:01:40.821] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:65:0)
[23:01:40.821] Timer tick, asking Buildbucket for the build status
[23:01:40.857] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:40.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:66:0) after 1m0s
[23:02:40.877] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:66:0)
[23:02:40.877] Timer tick, asking Buildbucket for the build status
[23:02:40.938] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:40.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:67:0) after 1m0s
[23:03:40.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:67:0)
[23:03:40.967] Timer tick, asking Buildbucket for the build status
[23:03:41.077] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:41.077] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:68:0) after 1m0s
[23:04:41.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:68:0)
[23:04:41.149] Timer tick, asking Buildbucket for the build status
[23:04:41.236] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:41.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:69:0) after 1m0s
[23:05:41.299] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:69:0)
[23:05:41.299] Timer tick, asking Buildbucket for the build status
[23:05:41.338] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:41.338] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:70:0) after 1m0s
[23:06:41.358] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:70:0)
[23:06:41.358] Timer tick, asking Buildbucket for the build status
[23:06:41.437] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:41.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:71:0) after 1m0s
[23:07:41.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:71:0)
[23:07:41.455] Timer tick, asking Buildbucket for the build status
[23:07:41.490] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:41.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:72:0) after 1m0s
[23:08:41.530] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:72:0)
[23:08:41.530] Timer tick, asking Buildbucket for the build status
[23:08:41.664] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:41.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:73:0) after 1m0s
[23:09:41.685] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:73:0)
[23:09:41.685] Timer tick, asking Buildbucket for the build status
[23:09:41.753] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:41.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:74:0) after 1m0s
[23:10:41.771] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:74:0)
[23:10:41.771] Timer tick, asking Buildbucket for the build status
[23:10:41.882] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:41.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:75:0) after 1m0s
[23:11:41.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:75:0)
[23:11:41.906] Timer tick, asking Buildbucket for the build status
[23:11:41.942] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:41.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:76:0) after 1m0s
[23:12:41.961] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:76:0)
[23:12:41.961] Timer tick, asking Buildbucket for the build status
[23:12:42.110] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:42.110] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:77:0) after 1m0s
[23:13:42.132] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:77:0)
[23:13:42.132] Timer tick, asking Buildbucket for the build status
[23:13:42.204] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:42.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:78:0) after 1m0s
[23:14:42.225] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:78:0)
[23:14:42.225] Timer tick, asking Buildbucket for the build status
[23:14:42.280] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:42.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:79:0) after 1m0s
[23:15:42.303] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:79:0)
[23:15:42.303] Timer tick, asking Buildbucket for the build status
[23:15:42.355] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:42.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:80:0) after 1m0s
[23:16:42.375] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:80:0)
[23:16:42.375] Timer tick, asking Buildbucket for the build status
[23:16:42.464] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:42.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:81:0) after 1m0s
[23:17:42.534] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:81:0)
[23:17:42.534] Timer tick, asking Buildbucket for the build status
[23:17:42.634] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:42.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:82:0) after 1m0s
[23:18:42.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:82:0)
[23:18:42.652] Timer tick, asking Buildbucket for the build status
[23:18:42.799] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:42.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:83:0) after 1m0s
[23:19:42.825] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:83:0)
[23:19:42.825] Timer tick, asking Buildbucket for the build status
[23:19:42.891] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:42.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:84:0) after 1m0s
[23:20:42.923] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:84:0)
[23:20:42.923] Timer tick, asking Buildbucket for the build status
[23:20:43.103] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:43.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:85:0) after 1m0s
[23:21:43.123] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:85:0)
[23:21:43.123] Timer tick, asking Buildbucket for the build status
[23:21:43.174] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:43.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:86:0) after 1m0s
[23:22:43.193] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:86:0)
[23:22:43.193] Timer tick, asking Buildbucket for the build status
[23:22:43.273] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:43.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:87:0) after 1m0s
[23:23:43.316] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:87:0)
[23:23:43.316] Timer tick, asking Buildbucket for the build status
[23:23:43.363] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:43.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:88:0) after 1m0s
[23:24:43.384] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:88:0)
[23:24:43.384] Timer tick, asking Buildbucket for the build status
[23:24:43.450] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:43.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:89:0) after 1m0s
[23:25:43.470] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:89:0)
[23:25:43.471] Timer tick, asking Buildbucket for the build status
[23:25:43.530] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:43.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:90:0) after 1m0s
[23:26:43.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:90:0)
[23:26:43.553] Timer tick, asking Buildbucket for the build status
[23:26:43.666] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:43.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:91:0) after 1m0s
[23:27:43.704] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:91:0)
[23:27:43.704] Timer tick, asking Buildbucket for the build status
[23:27:43.742] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:43.742] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:92:0) after 1m0s
[23:28:43.762] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:92:0)
[23:28:43.762] Timer tick, asking Buildbucket for the build status
[23:28:43.823] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:43.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:93:0) after 1m0s
[23:29:43.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:93:0)
[23:29:43.844] Timer tick, asking Buildbucket for the build status
[23:29:43.910] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:43.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:94:0) after 1m0s
[23:30:43.944] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:94:0)
[23:30:43.944] Timer tick, asking Buildbucket for the build status
[23:30:44.002] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:44.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:95:0) after 1m0s
[23:31:44.033] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:95:0)
[23:31:44.033] Timer tick, asking Buildbucket for the build status
[23:31:44.088] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:44.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:96:0) after 1m0s
[23:32:44.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:96:0)
[23:32:44.147] Timer tick, asking Buildbucket for the build status
[23:32:44.329] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:44.329] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:97:0) after 1m0s
[23:33:44.360] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:97:0)
[23:33:44.360] Timer tick, asking Buildbucket for the build status
[23:33:44.432] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:44.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:98:0) after 1m0s
[23:34:44.453] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:98:0)
[23:34:44.453] Timer tick, asking Buildbucket for the build status
[23:34:44.660] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:44.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:99:0) after 1m0s
[23:35:44.696] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:99:0)
[23:35:44.696] Timer tick, asking Buildbucket for the build status
[23:35:44.752] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:44.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:100:0) after 1m0s
[23:36:44.772] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:100:0)
[23:36:44.772] Timer tick, asking Buildbucket for the build status
[23:36:44.835] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:44.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:101:0) after 1m0s
[23:37:44.855] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:101:0)
[23:37:44.855] Timer tick, asking Buildbucket for the build status
[23:37:44.894] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:44.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:102:0) after 1m0s
[23:38:44.985] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:102:0)
[23:38:44.985] Timer tick, asking Buildbucket for the build status
[23:38:45.049] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:45.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:103:0) after 1m0s
[23:39:45.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:103:0)
[23:39:45.072] Timer tick, asking Buildbucket for the build status
[23:39:45.412] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:45.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:104:0) after 1m0s
[23:40:45.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:104:0)
[23:40:45.438] Timer tick, asking Buildbucket for the build status
[23:40:45.498] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:45.498] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:105:0) after 1m0s
[23:41:45.520] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:105:0)
[23:41:45.520] Timer tick, asking Buildbucket for the build status
[23:41:45.683] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:45.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:106:0) after 1m0s
[23:42:45.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:106:0)
[23:42:45.715] Timer tick, asking Buildbucket for the build status
[23:42:45.782] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:45.783] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:107:0) after 1m0s
[23:43:45.818] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:107:0)
[23:43:45.818] Timer tick, asking Buildbucket for the build status
[23:43:45.858] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:45.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:108:0) after 1m0s
[23:44:45.880] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:108:0)
[23:44:45.880] Timer tick, asking Buildbucket for the build status
[23:44:45.953] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:45.953] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:109:0) after 1m0s
[23:45:45.972] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:109:0)
[23:45:45.972] Timer tick, asking Buildbucket for the build status
[23:45:46.148] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:46.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:110:0) after 1m0s
[23:46:46.538] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:110:0)
[23:46:46.538] Timer tick, asking Buildbucket for the build status
[23:46:46.635] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:46.635] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:111:0) after 1m0s
[23:47:46.662] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:111:0)
[23:47:46.662] Timer tick, asking Buildbucket for the build status
[23:47:46.702] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:46.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:112:0) after 1m0s
[23:48:46.724] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:112:0)
[23:48:46.724] Timer tick, asking Buildbucket for the build status
[23:48:46.822] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:46.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:113:0) after 1m0s
[23:49:46.857] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:113:0)
[23:49:46.857] Timer tick, asking Buildbucket for the build status
[23:49:46.902] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:46.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:114:0) after 1m0s
[23:50:46.924] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:114:0)
[23:50:46.924] Timer tick, asking Buildbucket for the build status
[23:50:46.964] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:46.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:115:0) after 1m0s
[23:51:47.005] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:115:0)
[23:51:47.005] Timer tick, asking Buildbucket for the build status
[23:51:47.077] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:47.077] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:116:0) after 1m0s
[23:52:47.099] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:116:0)
[23:52:47.099] Timer tick, asking Buildbucket for the build status
[23:52:47.206] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:47.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:117:0) after 1m0s
[23:53:47.226] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:117:0)
[23:53:47.226] Timer tick, asking Buildbucket for the build status
[23:53:47.276] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:47.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:118:0) after 1m0s
[23:54:47.296] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:118:0)
[23:54:47.296] Timer tick, asking Buildbucket for the build status
[23:54:47.363] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:47.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:119:0) after 1m0s
[23:55:47.386] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:119:0)
[23:55:47.386] Timer tick, asking Buildbucket for the build status
[23:55:47.449] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:47.449] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:120:0) after 1m0s
[23:56:47.476] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:120:0)
[23:56:47.476] Timer tick, asking Buildbucket for the build status
[23:56:47.509] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:47.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:121:0) after 1m0s
[23:57:47.529] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:121:0)
[23:57:47.529] Timer tick, asking Buildbucket for the build status
[23:57:47.597] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:47.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:122:0) after 1m0s
[23:58:47.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:122:0)
[23:58:47.616] Timer tick, asking Buildbucket for the build status
[23:58:47.652] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:47.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:123:0) after 1m0s
[23:59:47.853] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:123:0)
[23:59:47.853] Timer tick, asking Buildbucket for the build status
[23:59:47.922] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:47.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:124:0) after 1m0s
[00:00:47.953] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:124:0)
[00:00:47.953] Timer tick, asking Buildbucket for the build status
[00:00:48.011] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:48.011] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:125:0) after 1m0s
[00:01:48.034] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:125:0)
[00:01:48.034] Timer tick, asking Buildbucket for the build status
[00:01:48.089] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:48.089] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:126:0) after 1m0s
[00:02:48.161] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:126:0)
[00:02:48.161] Timer tick, asking Buildbucket for the build status
[00:02:48.340] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:48.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:127:0) after 1m0s
[00:03:48.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:127:0)
[00:03:48.414] Timer tick, asking Buildbucket for the build status
[00:03:48.515] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:48.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:128:0) after 1m0s
[00:04:48.534] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:128:0)
[00:04:48.534] Timer tick, asking Buildbucket for the build status
[00:04:48.573] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:48.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:129:0) after 1m0s
[00:05:48.611] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:129:0)
[00:05:48.611] Timer tick, asking Buildbucket for the build status
[00:05:48.685] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:48.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:130:0) after 1m0s
[00:06:48.706] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:130:0)
[00:06:48.706] Timer tick, asking Buildbucket for the build status
[00:06:48.744] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:48.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:131:0) after 1m0s
[00:07:48.815] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:131:0)
[00:07:48.815] Timer tick, asking Buildbucket for the build status
[00:07:48.894] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:48.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:132:0) after 1m0s
[00:08:48.916] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:132:0)
[00:08:48.916] Timer tick, asking Buildbucket for the build status
[00:08:48.963] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:48.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:133:0) after 1m0s
[00:09:49.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:133:0)
[00:09:49.001] Timer tick, asking Buildbucket for the build status
[00:09:49.068] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:49.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:134:0) after 1m0s
[00:10:49.099] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:134:0)
[00:10:49.099] Timer tick, asking Buildbucket for the build status
[00:10:49.153] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:49.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:135:0) after 1m0s
[00:11:49.178] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:135:0)
[00:11:49.178] Timer tick, asking Buildbucket for the build status
[00:11:49.217] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:49.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:136:0) after 1m0s
[00:12:49.246] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:136:0)
[00:12:49.246] Timer tick, asking Buildbucket for the build status
[00:12:49.304] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:49.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:137:0) after 1m0s
[00:13:49.328] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:137:0)
[00:13:49.328] Timer tick, asking Buildbucket for the build status
[00:13:49.367] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:49.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:138:0) after 1m0s
[00:14:49.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:138:0)
[00:14:49.503] Timer tick, asking Buildbucket for the build status
[00:14:49.581] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:49.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:139:0) after 1m0s
[00:15:49.641] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:139:0)
[00:15:49.641] Timer tick, asking Buildbucket for the build status
[00:15:49.686] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:49.686] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:140:0) after 1m0s
[00:16:49.706] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:140:0)
[00:16:49.706] Timer tick, asking Buildbucket for the build status
[00:16:49.779] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:49.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:141:0) after 1m0s
[00:17:49.897] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:141:0)
[00:17:49.897] Timer tick, asking Buildbucket for the build status
[00:17:50.234] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:50.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:142:0) after 1m0s
[00:18:50.258] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:142:0)
[00:18:50.258] Timer tick, asking Buildbucket for the build status
[00:18:50.292] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:50.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:143:0) after 1m0s
[00:19:50.426] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:143:0)
[00:19:50.426] Timer tick, asking Buildbucket for the build status
[00:19:50.673] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:50.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:144:0) after 1m0s
[00:20:50.698] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:144:0)
[00:20:50.698] Timer tick, asking Buildbucket for the build status
[00:20:50.901] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:50.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:145:0) after 1m0s
[00:21:50.927] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:145:0)
[00:21:50.927] Timer tick, asking Buildbucket for the build status
[00:21:51.029] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:51.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:146:0) after 1m0s
[00:22:51.053] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:146:0)
[00:22:51.053] Timer tick, asking Buildbucket for the build status
[00:22:51.122] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:51.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:147:0) after 1m0s
[00:23:51.144] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:147:0)
[00:23:51.144] Timer tick, asking Buildbucket for the build status
[00:23:51.213] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:51.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:148:0) after 1m0s
[00:24:51.235] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:148:0)
[00:24:51.235] Timer tick, asking Buildbucket for the build status
[00:24:51.275] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:51.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:149:0) after 1m0s
[00:25:51.299] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:149:0)
[00:25:51.299] Timer tick, asking Buildbucket for the build status
[00:25:51.480] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:51.480] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:150:0) after 1m0s
[00:26:51.504] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:150:0)
[00:26:51.504] Timer tick, asking Buildbucket for the build status
[00:26:51.653] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:51.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:151:0) after 1m0s
[00:27:51.677] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:151:0)
[00:27:51.677] Timer tick, asking Buildbucket for the build status
[00:27:51.853] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:51.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:152:0) after 1m0s
[00:28:51.937] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:152:0)
[00:28:51.937] Timer tick, asking Buildbucket for the build status
[00:28:52.000] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:52.000] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:153:0) after 1m0s
[00:29:52.027] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:153:0)
[00:29:52.027] Timer tick, asking Buildbucket for the build status
[00:29:52.091] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:52.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:154:0) after 1m0s
[00:30:52.139] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:154:0)
[00:30:52.140] Timer tick, asking Buildbucket for the build status
[00:30:52.265] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:52.265] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:155:0) after 1m0s
[00:31:52.291] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:155:0)
[00:31:52.291] Timer tick, asking Buildbucket for the build status
[00:31:52.344] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:52.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:156:0) after 1m0s
[00:32:52.377] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:156:0)
[00:32:52.377] Timer tick, asking Buildbucket for the build status
[00:32:52.449] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:52.449] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:157:0) after 1m0s
[00:33:52.474] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:157:0)
[00:33:52.474] Timer tick, asking Buildbucket for the build status
[00:33:52.561] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:52.561] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:158:0) after 1m0s
[00:34:52.588] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:158:0)
[00:34:52.588] Timer tick, asking Buildbucket for the build status
[00:34:52.652] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:52.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:159:0) after 1m0s
[00:35:52.685] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:159:0)
[00:35:52.685] Timer tick, asking Buildbucket for the build status
[00:35:52.819] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:52.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:160:0) after 1m0s
[00:36:52.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:160:0)
[00:36:52.843] Timer tick, asking Buildbucket for the build status
[00:36:52.940] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:52.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:161:0) after 1m0s
[00:37:52.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:161:0)
[00:37:52.967] Timer tick, asking Buildbucket for the build status
[00:37:53.133] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:53.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:162:0) after 1m0s
[00:38:53.159] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:162:0)
[00:38:53.159] Timer tick, asking Buildbucket for the build status
[00:38:53.212] Build 8934828405333308400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:53.212] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:163:0) after 1m0s
[00:39:37.010] Received PubSub notification, asking Buildbucket for the build status
[00:39:37.109] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:53.242] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:163:0)
[00:39:53.242] Timer tick, asking Buildbucket for the build status
[00:39:53.385] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:53.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:165:0) after 1m0s
[00:40:53.407] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:165:0)
[00:40:53.407] Timer tick, asking Buildbucket for the build status
[00:40:53.500] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:53.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:166:0) after 1m0s
[00:41:53.525] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:166:0)
[00:41:53.525] Timer tick, asking Buildbucket for the build status
[00:41:53.680] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:53.680] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:167:0) after 1m0s
[00:42:53.704] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:167:0)
[00:42:53.704] Timer tick, asking Buildbucket for the build status
[00:42:53.819] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:53.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:168:0) after 1m0s
[00:43:53.960] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:168:0)
[00:43:53.960] Timer tick, asking Buildbucket for the build status
[00:43:54.001] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:54.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:169:0) after 1m0s
[00:44:54.199] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:169:0)
[00:44:54.199] Timer tick, asking Buildbucket for the build status
[00:44:54.682] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:54.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:170:0) after 1m0s
[00:45:54.710] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:170:0)
[00:45:54.711] Timer tick, asking Buildbucket for the build status
[00:45:54.785] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:54.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:171:0) after 1m0s
[00:46:54.891] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:171:0)
[00:46:54.891] Timer tick, asking Buildbucket for the build status
[00:46:54.975] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:54.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:172:0) after 1m0s
[00:47:55.000] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:172:0)
[00:47:55.000] Timer tick, asking Buildbucket for the build status
[00:47:55.436] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:55.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:173:0) after 1m0s
[00:48:55.482] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:173:0)
[00:48:55.482] Timer tick, asking Buildbucket for the build status
[00:48:55.551] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:55.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:174:0) after 1m0s
[00:49:55.601] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:174:0)
[00:49:55.601] Timer tick, asking Buildbucket for the build status
[00:49:55.713] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:55.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:175:0) after 1m0s
[00:50:55.741] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:175:0)
[00:50:55.741] Timer tick, asking Buildbucket for the build status
[00:50:55.926] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:55.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:176:0) after 1m0s
[00:51:55.992] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:176:0)
[00:51:55.992] Timer tick, asking Buildbucket for the build status
[00:51:56.211] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:56.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:177:0) after 1m0s
[00:52:56.239] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:177:0)
[00:52:56.239] Timer tick, asking Buildbucket for the build status
[00:52:56.432] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:56.432] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:178:0) after 1m0s
[00:53:56.458] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:178:0)
[00:53:56.458] Timer tick, asking Buildbucket for the build status
[00:53:56.628] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:56.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:179:0) after 1m0s
[00:54:56.918] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:179:0)
[00:54:56.918] Timer tick, asking Buildbucket for the build status
[00:54:57.002] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:57.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:180:0) after 1m0s
[00:55:57.028] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:180:0)
[00:55:57.028] Timer tick, asking Buildbucket for the build status
[00:55:57.103] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:57.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:181:0) after 1m0s
[00:56:57.136] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:181:0)
[00:56:57.136] Timer tick, asking Buildbucket for the build status
[00:56:57.222] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:57.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:182:0) after 1m0s
[00:57:57.244] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:182:0)
[00:57:57.244] Timer tick, asking Buildbucket for the build status
[00:57:57.537] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:57.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:183:0) after 1m0s
[00:58:57.564] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:183:0)
[00:58:57.564] Timer tick, asking Buildbucket for the build status
[00:58:57.619] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:57.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:184:0) after 1m0s
[00:59:57.645] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:184:0)
[00:59:57.645] Timer tick, asking Buildbucket for the build status
[00:59:57.714] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:57.714] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:185:0) after 1m0s
[01:00:57.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:185:0)
[01:00:57.740] Timer tick, asking Buildbucket for the build status
[01:00:57.822] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:57.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:186:0) after 1m0s
[01:01:57.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:186:0)
[01:01:57.906] Timer tick, asking Buildbucket for the build status
[01:01:58.086] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:58.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:187:0) after 1m0s
[01:02:58.114] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:187:0)
[01:02:58.114] Timer tick, asking Buildbucket for the build status
[01:02:58.183] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:58.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:188:0) after 1m0s
[01:03:58.211] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:188:0)
[01:03:58.211] Timer tick, asking Buildbucket for the build status
[01:03:58.463] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:58.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:189:0) after 1m0s
[01:04:58.714] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:189:0)
[01:04:58.714] Timer tick, asking Buildbucket for the build status
[01:04:58.851] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:58.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:190:0) after 1m0s
[01:05:58.875] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:190:0)
[01:05:58.875] Timer tick, asking Buildbucket for the build status
[01:05:58.944] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:58.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:191:0) after 1m0s
[01:06:59.040] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:191:0)
[01:06:59.040] Timer tick, asking Buildbucket for the build status
[01:06:59.122] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:59.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:192:0) after 1m0s
[01:07:59.144] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:192:0)
[01:07:59.144] Timer tick, asking Buildbucket for the build status
[01:07:59.302] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:59.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:193:0) after 1m0s
[01:08:59.365] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:193:0)
[01:08:59.365] Timer tick, asking Buildbucket for the build status
[01:08:59.453] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:59.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:194:0) after 1m0s
[01:09:59.511] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:194:0)
[01:09:59.511] Timer tick, asking Buildbucket for the build status
[01:09:59.558] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:59.558] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:195:0) after 1m0s
[01:10:59.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:195:0)
[01:10:59.608] Timer tick, asking Buildbucket for the build status
[01:10:59.682] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:59.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:196:0) after 1m0s
[01:11:59.711] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:196:0)
[01:11:59.711] Timer tick, asking Buildbucket for the build status
[01:12:00.038] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:00.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:197:0) after 1m0s
[01:13:00.100] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:197:0)
[01:13:00.100] Timer tick, asking Buildbucket for the build status
[01:13:00.428] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:00.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:198:0) after 1m0s
[01:14:00.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:198:0)
[01:14:00.455] Timer tick, asking Buildbucket for the build status
[01:14:00.523] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:00.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:199:0) after 1m0s
[01:15:00.552] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:199:0)
[01:15:00.552] Timer tick, asking Buildbucket for the build status
[01:15:00.769] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:00.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:200:0) after 1m0s
[01:16:00.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:200:0)
[01:16:00.906] Timer tick, asking Buildbucket for the build status
[01:16:01.007] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:01.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:201:0) after 1m0s
[01:17:01.083] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:201:0)
[01:17:01.083] Timer tick, asking Buildbucket for the build status
[01:17:01.271] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:01.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:202:0) after 1m0s
[01:18:01.295] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:202:0)
[01:18:01.295] Timer tick, asking Buildbucket for the build status
[01:18:01.386] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:01.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:203:0) after 1m0s
[01:19:01.415] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:203:0)
[01:19:01.415] Timer tick, asking Buildbucket for the build status
[01:19:01.479] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:01.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:204:0) after 1m0s
[01:20:01.541] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:204:0)
[01:20:01.541] Timer tick, asking Buildbucket for the build status
[01:20:01.737] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:01.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:205:0) after 1m0s
[01:21:01.765] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:205:0)
[01:21:01.765] Timer tick, asking Buildbucket for the build status
[01:21:02.127] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:02.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:206:0) after 1m0s
[01:22:02.191] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:206:0)
[01:22:02.191] Timer tick, asking Buildbucket for the build status
[01:22:02.503] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:02.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:207:0) after 1m0s
[01:23:02.534] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:207:0)
[01:23:02.534] Timer tick, asking Buildbucket for the build status
[01:23:03.207] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:03.207] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:208:0) after 1m0s
[01:24:03.277] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:208:0)
[01:24:03.277] Timer tick, asking Buildbucket for the build status
[01:24:03.462] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:03.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:209:0) after 1m0s
[01:25:03.494] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:209:0)
[01:25:03.494] Timer tick, asking Buildbucket for the build status
[01:25:03.562] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:03.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:210:0) after 1m0s
[01:26:03.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:210:0)
[01:26:03.616] Timer tick, asking Buildbucket for the build status
[01:26:03.903] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:03.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:211:0) after 1m0s
[01:27:03.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:211:0)
[01:27:03.932] Timer tick, asking Buildbucket for the build status
[01:27:03.994] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:03.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:212:0) after 1m0s
[01:28:04.086] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:212:0)
[01:28:04.086] Timer tick, asking Buildbucket for the build status
[01:28:04.134] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:04.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:213:0) after 1m0s
[01:29:04.237] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:213:0)
[01:29:04.237] Timer tick, asking Buildbucket for the build status
[01:29:04.385] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:04.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:214:0) after 1m0s
[01:30:04.437] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:214:0)
[01:30:04.437] Timer tick, asking Buildbucket for the build status
[01:30:04.508] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:04.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:215:0) after 1m0s
[01:31:04.534] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:215:0)
[01:31:04.534] Timer tick, asking Buildbucket for the build status
[01:31:04.578] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:04.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:216:0) after 1m0s
[01:32:04.607] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:216:0)
[01:32:04.607] Timer tick, asking Buildbucket for the build status
[01:32:04.682] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:04.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:217:0) after 1m0s
[01:33:04.710] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:217:0)
[01:33:04.710] Timer tick, asking Buildbucket for the build status
[01:33:04.775] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:04.775] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:218:0) after 1m0s
[01:34:04.823] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:218:0)
[01:34:04.823] Timer tick, asking Buildbucket for the build status
[01:34:06.771] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:06.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:219:0) after 1m0s
[01:35:06.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:219:0)
[01:35:06.843] Timer tick, asking Buildbucket for the build status
[01:35:07.286] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:07.286] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:220:0) after 1m0s
[01:36:07.313] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:220:0)
[01:36:07.313] Timer tick, asking Buildbucket for the build status
[01:36:07.393] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:07.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:221:0) after 1m0s
[01:37:07.419] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:221:0)
[01:37:07.419] Timer tick, asking Buildbucket for the build status
[01:37:07.477] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:07.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:222:0) after 1m0s
[01:38:07.582] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:222:0)
[01:38:07.582] Timer tick, asking Buildbucket for the build status
[01:38:07.629] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:07.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:223:0) after 1m0s
[01:39:07.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:223:0)
[01:39:07.661] Timer tick, asking Buildbucket for the build status
[01:39:07.744] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:07.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:224:0) after 1m0s
[01:40:07.776] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:224:0)
[01:40:07.776] Timer tick, asking Buildbucket for the build status
[01:40:07.834] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:07.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:225:0) after 1m0s
[01:41:07.868] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:225:0)
[01:41:07.868] Timer tick, asking Buildbucket for the build status
[01:41:07.949] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:07.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:226:0) after 1m0s
[01:42:07.976] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:226:0)
[01:42:07.976] Timer tick, asking Buildbucket for the build status
[01:42:08.032] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:08.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:227:0) after 1m0s
[01:43:08.061] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:227:0)
[01:43:08.061] Timer tick, asking Buildbucket for the build status
[01:43:08.123] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:08.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:228:0) after 1m0s
[01:44:08.152] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:228:0)
[01:44:08.152] Timer tick, asking Buildbucket for the build status
[01:44:08.238] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:08.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:229:0) after 1m0s
[01:45:08.269] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:229:0)
[01:45:08.269] Timer tick, asking Buildbucket for the build status
[01:45:08.357] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:08.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:230:0) after 1m0s
[01:46:08.388] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:230:0)
[01:46:08.388] Timer tick, asking Buildbucket for the build status
[01:46:08.451] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:08.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:231:0) after 1m0s
[01:47:08.599] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:231:0)
[01:47:08.599] Timer tick, asking Buildbucket for the build status
[01:47:08.692] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:08.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:232:0) after 1m0s
[01:48:08.752] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:232:0)
[01:48:08.752] Timer tick, asking Buildbucket for the build status
[01:48:08.828] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:08.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:233:0) after 1m0s
[01:49:08.860] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:233:0)
[01:49:08.860] Timer tick, asking Buildbucket for the build status
[01:49:08.963] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:08.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:234:0) after 1m0s
[01:50:08.989] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:234:0)
[01:50:08.989] Timer tick, asking Buildbucket for the build status
[01:50:09.067] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:09.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:235:0) after 1m0s
[01:51:09.121] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:235:0)
[01:51:09.121] Timer tick, asking Buildbucket for the build status
[01:51:09.185] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:09.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:236:0) after 1m0s
[01:52:09.212] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:236:0)
[01:52:09.212] Timer tick, asking Buildbucket for the build status
[01:52:09.292] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:09.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:237:0) after 1m0s
[01:53:09.316] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:237:0)
[01:53:09.316] Timer tick, asking Buildbucket for the build status
[01:53:09.347] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:09.347] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:238:0) after 1m0s
[01:54:09.373] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:238:0)
[01:54:09.373] Timer tick, asking Buildbucket for the build status
[01:54:09.435] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:09.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:239:0) after 1m0s
[01:55:09.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:239:0)
[01:55:09.473] Timer tick, asking Buildbucket for the build status
[01:55:09.538] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:09.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:240:0) after 1m0s
[01:56:09.603] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:240:0)
[01:56:09.603] Timer tick, asking Buildbucket for the build status
[01:56:09.661] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:09.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:241:0) after 1m0s
[01:57:09.684] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:241:0)
[01:57:09.684] Timer tick, asking Buildbucket for the build status
[01:57:09.744] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:09.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:242:0) after 1m0s
[01:58:09.837] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:242:0)
[01:58:09.837] Timer tick, asking Buildbucket for the build status
[01:58:09.866] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:09.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:243:0) after 1m0s
[01:59:09.916] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:243:0)
[01:59:09.916] Timer tick, asking Buildbucket for the build status
[01:59:09.964] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:09.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:244:0) after 1m0s
[02:00:09.995] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:244:0)
[02:00:09.995] Timer tick, asking Buildbucket for the build status
[02:00:10.094] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:10.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:245:0) after 1m0s
[02:01:10.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:245:0)
[02:01:10.147] Timer tick, asking Buildbucket for the build status
[02:01:10.243] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:10.243] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:246:0) after 1m0s
[02:02:10.312] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:246:0)
[02:02:10.312] Timer tick, asking Buildbucket for the build status
[02:02:10.373] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:10.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:247:0) after 1m0s
[02:03:10.399] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:247:0)
[02:03:10.399] Timer tick, asking Buildbucket for the build status
[02:03:10.429] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:10.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:248:0) after 1m0s
[02:04:10.472] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:248:0)
[02:04:10.472] Timer tick, asking Buildbucket for the build status
[02:04:10.543] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:10.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:249:0) after 1m0s
[02:05:10.568] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:249:0)
[02:05:10.568] Timer tick, asking Buildbucket for the build status
[02:05:10.691] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:10.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:250:0) after 1m0s
[02:06:10.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:250:0)
[02:06:10.740] Timer tick, asking Buildbucket for the build status
[02:06:10.788] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:10.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:251:0) after 1m0s
[02:07:10.821] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:251:0)
[02:07:10.821] Timer tick, asking Buildbucket for the build status
[02:07:10.971] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:10.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:252:0) after 1m0s
[02:08:10.999] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:252:0)
[02:08:10.999] Timer tick, asking Buildbucket for the build status
[02:08:11.102] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:11.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:253:0) after 1m0s
[02:09:11.131] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:253:0)
[02:09:11.131] Timer tick, asking Buildbucket for the build status
[02:09:11.207] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:11.207] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:254:0) after 1m0s
[02:10:11.240] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:254:0)
[02:10:11.240] Timer tick, asking Buildbucket for the build status
[02:10:11.485] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:11.485] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:255:0) after 1m0s
[02:11:11.512] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:255:0)
[02:11:11.512] Timer tick, asking Buildbucket for the build status
[02:11:11.632] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:11.632] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:256:0) after 1m0s
[02:12:11.662] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:256:0)
[02:12:11.662] Timer tick, asking Buildbucket for the build status
[02:12:11.810] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:11.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:257:0) after 1m0s
[02:13:11.874] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:257:0)
[02:13:11.874] Timer tick, asking Buildbucket for the build status
[02:13:12.097] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:12.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:258:0) after 1m0s
[02:14:12.141] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:258:0)
[02:14:12.141] Timer tick, asking Buildbucket for the build status
[02:14:12.327] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:12.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:259:0) after 1m0s
[02:15:12.362] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:259:0)
[02:15:12.362] Timer tick, asking Buildbucket for the build status
[02:15:12.515] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:12.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:260:0) after 1m0s
[02:16:12.544] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:260:0)
[02:16:12.544] Timer tick, asking Buildbucket for the build status
[02:16:12.659] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:12.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:261:0) after 1m0s
[02:17:12.682] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:261:0)
[02:17:12.682] Timer tick, asking Buildbucket for the build status
[02:17:12.740] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:12.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:262:0) after 1m0s
[02:18:12.845] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:262:0)
[02:18:12.845] Timer tick, asking Buildbucket for the build status
[02:18:12.905] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:12.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:263:0) after 1m0s
[02:19:12.937] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:263:0)
[02:19:12.937] Timer tick, asking Buildbucket for the build status
[02:19:13.041] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:13.041] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:264:0) after 1m0s
[02:20:13.066] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:264:0)
[02:20:13.066] Timer tick, asking Buildbucket for the build status
[02:20:13.154] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:13.154] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:265:0) after 1m0s
[02:21:13.181] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:265:0)
[02:21:13.181] Timer tick, asking Buildbucket for the build status
[02:21:13.237] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:13.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:266:0) after 1m0s
[02:22:13.265] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:266:0)
[02:22:13.265] Timer tick, asking Buildbucket for the build status
[02:22:13.389] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:13.389] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:267:0) after 1m0s
[02:23:13.504] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:267:0)
[02:23:13.504] Timer tick, asking Buildbucket for the build status
[02:23:13.693] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:13.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:268:0) after 1m0s
[02:24:13.719] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:268:0)
[02:24:13.719] Timer tick, asking Buildbucket for the build status
[02:24:13.779] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:13.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:269:0) after 1m0s
[02:25:13.814] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:269:0)
[02:25:13.814] Timer tick, asking Buildbucket for the build status
[02:25:13.927] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:13.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:270:0) after 1m0s
[02:26:13.955] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:270:0)
[02:26:13.955] Timer tick, asking Buildbucket for the build status
[02:26:14.008] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:14.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:271:0) after 1m0s
[02:27:14.036] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:271:0)
[02:27:14.036] Timer tick, asking Buildbucket for the build status
[02:27:14.111] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:14.111] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:272:0) after 1m0s
[02:28:14.148] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:272:0)
[02:28:14.148] Timer tick, asking Buildbucket for the build status
[02:28:14.362] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:14.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:273:0) after 1m0s
[02:29:14.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:273:0)
[02:29:14.398] Timer tick, asking Buildbucket for the build status
[02:29:14.471] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:14.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:274:0) after 1m0s
[02:30:14.501] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:274:0)
[02:30:14.501] Timer tick, asking Buildbucket for the build status
[02:30:14.568] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:14.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:275:0) after 1m0s
[02:31:14.598] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:275:0)
[02:31:14.598] Timer tick, asking Buildbucket for the build status
[02:31:14.643] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:14.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:276:0) after 1m0s
[02:32:14.670] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:276:0)
[02:32:14.670] Timer tick, asking Buildbucket for the build status
[02:32:14.769] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:14.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:277:0) after 1m0s
[02:33:14.795] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:277:0)
[02:33:14.795] Timer tick, asking Buildbucket for the build status
[02:33:14.836] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:14.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:278:0) after 1m0s
[02:34:14.862] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:278:0)
[02:34:14.863] Timer tick, asking Buildbucket for the build status
[02:34:14.922] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:14.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:279:0) after 1m0s
[02:35:14.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:279:0)
[02:35:14.950] Timer tick, asking Buildbucket for the build status
[02:35:15.072] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:15.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:280:0) after 1m0s
[02:36:15.104] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:280:0)
[02:36:15.104] Timer tick, asking Buildbucket for the build status
[02:36:15.146] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:15.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:281:0) after 1m0s
[02:37:15.211] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:281:0)
[02:37:15.211] Timer tick, asking Buildbucket for the build status
[02:37:15.534] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:15.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:282:0) after 1m0s
[02:38:15.562] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:282:0)
[02:38:15.562] Timer tick, asking Buildbucket for the build status
[02:38:15.678] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:15.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:283:0) after 1m0s
[02:39:15.705] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:283:0)
[02:39:15.705] Timer tick, asking Buildbucket for the build status
[02:39:15.822] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:15.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:284:0) after 1m0s
[02:40:15.866] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:284:0)
[02:40:15.866] Timer tick, asking Buildbucket for the build status
[02:40:15.933] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:15.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:285:0) after 1m0s
[02:41:16.012] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:285:0)
[02:41:16.012] Timer tick, asking Buildbucket for the build status
[02:41:16.056] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:16.056] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:286:0) after 1m0s
[02:42:16.083] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:286:0)
[02:42:16.083] Timer tick, asking Buildbucket for the build status
[02:42:16.146] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:16.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:287:0) after 1m0s
[02:43:16.247] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:287:0)
[02:43:16.247] Timer tick, asking Buildbucket for the build status
[02:43:16.301] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:16.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:288:0) after 1m0s
[02:44:16.332] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:288:0)
[02:44:16.332] Timer tick, asking Buildbucket for the build status
[02:44:16.406] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:16.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:289:0) after 1m0s
[02:45:16.464] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:289:0)
[02:45:16.464] Timer tick, asking Buildbucket for the build status
[02:45:16.534] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:16.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:290:0) after 1m0s
[02:46:16.639] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:290:0)
[02:46:16.639] Timer tick, asking Buildbucket for the build status
[02:46:16.781] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:16.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:291:0) after 1m0s
[02:47:16.815] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:291:0)
[02:47:16.815] Timer tick, asking Buildbucket for the build status
[02:47:16.856] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:16.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:292:0) after 1m0s
[02:48:16.891] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:292:0)
[02:48:16.891] Timer tick, asking Buildbucket for the build status
[02:48:17.023] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:17.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:293:0) after 1m0s
[02:49:17.049] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:293:0)
[02:49:17.049] Timer tick, asking Buildbucket for the build status
[02:49:17.131] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:17.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:294:0) after 1m0s
[02:50:17.158] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:294:0)
[02:50:17.158] Timer tick, asking Buildbucket for the build status
[02:50:17.212] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:17.212] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:295:0) after 1m0s
[02:51:17.243] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:295:0)
[02:51:17.243] Timer tick, asking Buildbucket for the build status
[02:51:17.292] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:17.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:296:0) after 1m0s
[02:52:17.321] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:296:0)
[02:52:17.321] Timer tick, asking Buildbucket for the build status
[02:52:17.351] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:17.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:297:0) after 1m0s
[02:53:17.460] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:297:0)
[02:53:17.460] Timer tick, asking Buildbucket for the build status
[02:53:17.528] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:17.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:298:0) after 1m0s
[02:54:17.558] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:298:0)
[02:54:17.558] Timer tick, asking Buildbucket for the build status
[02:54:17.621] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:17.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:299:0) after 1m0s
[02:55:17.658] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:299:0)
[02:55:17.659] Timer tick, asking Buildbucket for the build status
[02:55:17.790] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:17.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:300:0) after 1m0s
[02:56:17.819] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:300:0)
[02:56:17.819] Timer tick, asking Buildbucket for the build status
[02:56:17.887] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:17.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:301:0) after 1m0s
[02:57:17.918] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:301:0)
[02:57:17.918] Timer tick, asking Buildbucket for the build status
[02:57:18.105] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:18.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:302:0) after 1m0s
[02:58:18.199] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:302:0)
[02:58:18.199] Timer tick, asking Buildbucket for the build status
[02:58:18.238] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:18.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:303:0) after 1m0s
[02:59:18.287] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:303:0)
[02:59:18.287] Timer tick, asking Buildbucket for the build status
[02:59:18.373] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:18.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:304:0) after 1m0s
[03:00:18.399] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:304:0)
[03:00:18.399] Timer tick, asking Buildbucket for the build status
[03:00:18.466] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:18.466] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:305:0) after 1m0s
[03:01:18.495] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:305:0)
[03:01:18.495] Timer tick, asking Buildbucket for the build status
[03:01:18.567] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:18.567] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:306:0) after 1m0s
[03:02:18.598] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:306:0)
[03:02:18.598] Timer tick, asking Buildbucket for the build status
[03:02:18.671] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:18.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:307:0) after 1m0s
[03:03:18.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:307:0)
[03:03:18.787] Timer tick, asking Buildbucket for the build status
[03:03:18.833] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:18.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:308:0) after 1m0s
[03:04:18.864] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:308:0)
[03:04:18.864] Timer tick, asking Buildbucket for the build status
[03:04:18.921] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:18.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:309:0) after 1m0s
[03:05:18.953] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:309:0)
[03:05:18.953] Timer tick, asking Buildbucket for the build status
[03:05:19.001] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:19.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:310:0) after 1m0s
[03:06:19.094] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:310:0)
[03:06:19.094] Timer tick, asking Buildbucket for the build status
[03:06:19.196] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:19.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:311:0) after 1m0s
[03:07:19.238] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:311:0)
[03:07:19.238] Timer tick, asking Buildbucket for the build status
[03:07:19.384] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:19.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:312:0) after 1m0s
[03:08:19.416] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:312:0)
[03:08:19.416] Timer tick, asking Buildbucket for the build status
[03:08:19.490] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:19.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:313:0) after 1m0s
[03:09:19.525] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:313:0)
[03:09:19.525] Timer tick, asking Buildbucket for the build status
[03:09:19.589] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:19.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:314:0) after 1m0s
[03:10:19.623] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:314:0)
[03:10:19.623] Timer tick, asking Buildbucket for the build status
[03:10:19.664] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:19.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:315:0) after 1m0s
[03:11:19.699] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:315:0)
[03:11:19.699] Timer tick, asking Buildbucket for the build status
[03:11:19.813] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:19.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:316:0) after 1m0s
[03:12:19.851] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:316:0)
[03:12:19.851] Timer tick, asking Buildbucket for the build status
[03:12:19.934] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:19.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:317:0) after 1m0s
[03:13:19.972] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:317:0)
[03:13:19.972] Timer tick, asking Buildbucket for the build status
[03:13:20.064] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:20.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:318:0) after 1m0s
[03:14:20.093] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:318:0)
[03:14:20.093] Timer tick, asking Buildbucket for the build status
[03:14:20.136] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:20.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:319:0) after 1m0s
[03:15:20.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:319:0)
[03:15:20.168] Timer tick, asking Buildbucket for the build status
[03:15:20.253] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:20.253] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:320:0) after 1m0s
[03:16:20.338] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:320:0)
[03:16:20.338] Timer tick, asking Buildbucket for the build status
[03:16:20.629] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:20.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:321:0) after 1m0s
[03:17:20.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:321:0)
[03:17:20.656] Timer tick, asking Buildbucket for the build status
[03:17:20.934] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:20.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:322:0) after 1m0s
[03:18:20.987] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:322:0)
[03:18:20.987] Timer tick, asking Buildbucket for the build status
[03:18:21.228] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:21.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:323:0) after 1m0s
[03:19:21.260] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:323:0)
[03:19:21.260] Timer tick, asking Buildbucket for the build status
[03:19:21.366] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:21.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:324:0) after 1m0s
[03:20:21.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:324:0)
[03:20:21.396] Timer tick, asking Buildbucket for the build status
[03:20:21.441] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:21.441] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:325:0) after 1m0s
[03:21:21.514] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:325:0)
[03:21:21.514] Timer tick, asking Buildbucket for the build status
[03:21:21.560] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:21.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:326:0) after 1m0s
[03:22:21.600] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:326:0)
[03:22:21.600] Timer tick, asking Buildbucket for the build status
[03:22:21.683] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:21.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:327:0) after 1m0s
[03:23:21.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:327:0)
[03:23:21.715] Timer tick, asking Buildbucket for the build status
[03:23:21.863] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:21.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:328:0) after 1m0s
[03:24:21.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:328:0)
[03:24:21.894] Timer tick, asking Buildbucket for the build status
[03:24:21.973] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:21.973] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:329:0) after 1m0s
[03:25:22.005] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:329:0)
[03:25:22.005] Timer tick, asking Buildbucket for the build status
[03:25:22.111] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:22.111] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:330:0) after 1m0s
[03:26:22.215] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:330:0)
[03:26:22.215] Timer tick, asking Buildbucket for the build status
[03:26:22.263] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:22.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:331:0) after 1m0s
[03:27:22.346] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:331:0)
[03:27:22.346] Timer tick, asking Buildbucket for the build status
[03:27:22.403] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:22.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:332:0) after 1m0s
[03:28:22.435] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:332:0)
[03:28:22.435] Timer tick, asking Buildbucket for the build status
[03:28:22.578] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:22.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:333:0) after 1m0s
[03:29:22.612] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:333:0)
[03:29:22.612] Timer tick, asking Buildbucket for the build status
[03:29:22.716] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:22.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:334:0) after 1m0s
[03:30:22.745] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:334:0)
[03:30:22.746] Timer tick, asking Buildbucket for the build status
[03:30:22.922] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:22.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:335:0) after 1m0s
[03:31:22.964] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:335:0)
[03:31:22.964] Timer tick, asking Buildbucket for the build status
[03:31:23.039] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:23.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:336:0) after 1m0s
[03:32:23.120] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:336:0)
[03:32:23.120] Timer tick, asking Buildbucket for the build status
[03:32:23.208] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:23.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:337:0) after 1m0s
[03:33:23.246] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:337:0)
[03:33:23.246] Timer tick, asking Buildbucket for the build status
[03:33:23.313] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:23.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:338:0) after 1m0s
[03:34:23.349] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:338:0)
[03:34:23.349] Timer tick, asking Buildbucket for the build status
[03:34:23.472] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:23.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:339:0) after 1m0s
[03:35:23.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:339:0)
[03:35:23.503] Timer tick, asking Buildbucket for the build status
[03:35:23.694] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:23.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:340:0) after 1m0s
[03:36:23.868] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:340:0)
[03:36:23.868] Timer tick, asking Buildbucket for the build status
[03:36:23.907] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:23.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:341:0) after 1m0s
[03:37:23.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:341:0)
[03:37:23.950] Timer tick, asking Buildbucket for the build status
[03:37:23.986] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:23.986] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:342:0) after 1m0s
[03:38:24.016] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:342:0)
[03:38:24.016] Timer tick, asking Buildbucket for the build status
[03:38:24.068] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:24.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:343:0) after 1m0s
[03:39:24.110] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:343:0)
[03:39:24.110] Timer tick, asking Buildbucket for the build status
[03:39:24.165] Build 8934828405333308400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:24.165] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9100258467623493424:344:0) after 1m0s
[03:39:57.758] Received PubSub notification, asking Buildbucket for the build status
[03:39:57.991] Build 8934828405333308400: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[03:39:57.991] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1537501196502541",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1537480650544066",
    "experimental": true,
    "failure_reason": "INFRA_FAILURE",
    "id": "8934828405333308400",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f85491d8830fe6f3b8e0efa2e954f71bd9c64af\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"kitchen crashed or got killed\", \"bootstrapperCallStack\": [], \"type\": \"BOOTSTRAPPER_ERROR\"}, \"recipeResult\": null, \"recipeExitCode\": null, \"recipe\": null, \"annotationUrl\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3779-c5c026e\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-02248837-us-west1-b-4mfq\"], \"pool\": [\"luci.nacl.toolchain\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1537490370360330",
    "status": "COMPLETED",
    "status_changed_ts": "1537501197314983",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_64/6",
      "builder:linux-pnacl-x86_64-tests-x86_64",
      "buildset:commit/git/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9100258467623493424",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_64",
      "swarming_dimension:caches:builder_b19c502ace169a4787e50af1f7263ca77b2393148a21a94968e2c3ee554fdb58_v2",
      "swarming_dimension:cores:8",
      "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-tests-x86_64/6",
      "swarming_tag:buildbucket_bucket:luci.nacl.toolchain",
      "swarming_tag:buildbucket_build_id:8934828405333308400",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:1630ff158d8d4118027817e4d74c356b46464ed9",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-x86_64",
      "swarming_tag:buildset:commit/git/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f85491d8830fe6f3b8e0efa2e954f71bd9c64af",
      "swarming_tag:caches:builder_b19c502ace169a4787e50af1f7263ca77b2393148a21a94968e2c3ee554fdb58_v2",
      "swarming_tag:cores:8",
      "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/8934828405333308400/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:60",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9100258467623493424",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-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:a636fa546b9b663cc0d60eefebb84621a4dfa011",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4011ce7d209eaf10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1537501197316057",
    "url": "https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_64/6",
    "utcnow_ts": "1537501197964115"
  }
}
[03:39:57.991] Invocation finished in 5h42m29.015702367s with status FAILED