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

• f701a90597fc85979319447c0cd44c3b52201c78 (6 years ago)

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

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

[02:45:08.425] New invocation is queued and will start shortly
[02:45:09.719] Starting the invocation (attempt 1)
[02:45:09.757] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:45:09.757] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:45:09.757] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9094623357883925904",
  "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\":\"f701a90597fc85979319447c0cd44c3b52201c78\"}}",
  "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:9094623357883925904",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/f701a90597fc85979319447c0cd44c3b52201c78",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f701a90597fc85979319447c0cd44c3b52201c78",
    "gitiles_ref:refs/heads/master"
  ]
}
[02:45:12.529] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1542854709945122",
    "experimental": true,
    "id": "8929193295622443648",
    "lease_expiration_ts": "1542973511928467",
    "lease_key": "616755390",
    "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\": \"f701a90597fc85979319447c0cd44c3b52201c78\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1542854712319886",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_64/10",
      "builder:linux-pnacl-x86_64-tests-x86_64",
      "buildset:commit/git/f701a90597fc85979319447c0cd44c3b52201c78",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f701a90597fc85979319447c0cd44c3b52201c78",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9094623357883925904",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_64",
      "swarming_dimension:caches:builder_bf14184df246ade0cf783e61825966ff5c624694bcccef3edd9032289b04d52b_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/10",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8929193295622443648",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:586d78b1df9b356be85f0824ec8364d9ecbabf90",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-x86_64",
      "swarming_tag:buildset:commit/git/f701a90597fc85979319447c0cd44c3b52201c78",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f701a90597fc85979319447c0cd44c3b52201c78",
      "swarming_tag:caches:builder_bf14184df246ade0cf783e61825966ff5c624694bcccef3edd9032289b04d52b_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/8929193295622443648/+/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:9094623357883925904",
      "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:5b53a70aa8482a54ee03de11951e8067cb630a16",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4152201f57e44610",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1542854712320001",
    "url": "https://ci.chromium.org/b/8929193295622443648",
    "utcnow_ts": "1542854712506355"
  }
}
[02:45:12.530] Task URL: https://ci.chromium.org/b/8929193295622443648
[02:45:12.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:2:0) after 1m0s
[02:46:12.549] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:2:0)
[02:46:12.549] Timer tick, asking Buildbucket for the build status
[02:46:12.616] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:12.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:3:0) after 1m0s
[02:47:12.751] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:3:0)
[02:47:12.751] Timer tick, asking Buildbucket for the build status
[02:47:12.847] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:12.847] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:4:0) after 1m0s
[02:48:12.958] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:4:0)
[02:48:12.958] Timer tick, asking Buildbucket for the build status
[02:48:14.730] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:14.730] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:5:0) after 1m0s
[02:49:14.829] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:5:0)
[02:49:14.829] Timer tick, asking Buildbucket for the build status
[02:49:14.919] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:14.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:6:0) after 1m0s
[02:50:14.951] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:6:0)
[02:50:14.951] Timer tick, asking Buildbucket for the build status
[02:50:15.064] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:15.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:7:0) after 1m0s
[02:51:15.126] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:7:0)
[02:51:15.126] Timer tick, asking Buildbucket for the build status
[02:51:15.257] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:15.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:8:0) after 1m0s
[02:52:15.295] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:8:0)
[02:52:15.295] Timer tick, asking Buildbucket for the build status
[02:52:15.407] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:15.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:9:0) after 1m0s
[02:53:15.428] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:9:0)
[02:53:15.428] Timer tick, asking Buildbucket for the build status
[02:53:15.570] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:15.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:10:0) after 1m0s
[02:54:15.590] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:10:0)
[02:54:15.590] Timer tick, asking Buildbucket for the build status
[02:54:15.750] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:15.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:11:0) after 1m0s
[02:55:15.774] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:11:0)
[02:55:15.774] Timer tick, asking Buildbucket for the build status
[02:55:15.834] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:15.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:12:0) after 1m0s
[02:56:15.853] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:12:0)
[02:56:15.853] Timer tick, asking Buildbucket for the build status
[02:56:15.954] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:15.954] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:13:0) after 1m0s
[02:57:15.974] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:13:0)
[02:57:15.974] Timer tick, asking Buildbucket for the build status
[02:57:16.017] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:16.017] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:14:0) after 1m0s
[02:58:16.040] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:14:0)
[02:58:16.040] Timer tick, asking Buildbucket for the build status
[02:58:16.189] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:16.189] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:15:0) after 1m0s
[02:59:16.208] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:15:0)
[02:59:16.208] Timer tick, asking Buildbucket for the build status
[02:59:16.295] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:16.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:16:0) after 1m0s
[03:00:16.313] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:16:0)
[03:00:16.313] Timer tick, asking Buildbucket for the build status
[03:00:16.394] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:16.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:17:0) after 1m0s
[03:01:16.472] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:17:0)
[03:01:16.472] Timer tick, asking Buildbucket for the build status
[03:01:16.533] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:16.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:18:0) after 1m0s
[03:02:16.554] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:18:0)
[03:02:16.554] Timer tick, asking Buildbucket for the build status
[03:02:16.629] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:16.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:19:0) after 1m0s
[03:03:16.667] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:19:0)
[03:03:16.667] Timer tick, asking Buildbucket for the build status
[03:03:16.801] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:16.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:20:0) after 1m0s
[03:04:16.820] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:20:0)
[03:04:16.820] Timer tick, asking Buildbucket for the build status
[03:04:16.869] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:16.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:21:0) after 1m0s
[03:05:16.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:21:0)
[03:05:16.899] Timer tick, asking Buildbucket for the build status
[03:05:17.026] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:17.026] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:22:0) after 1m0s
[03:06:17.044] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:22:0)
[03:06:17.044] Timer tick, asking Buildbucket for the build status
[03:06:17.165] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:17.165] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:23:0) after 1m0s
[03:07:17.187] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:23:0)
[03:07:17.187] Timer tick, asking Buildbucket for the build status
[03:07:17.257] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:17.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:24:0) after 1m0s
[03:08:17.284] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:24:0)
[03:08:17.284] Timer tick, asking Buildbucket for the build status
[03:08:17.324] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:17.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:25:0) after 1m0s
[03:09:17.381] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:25:0)
[03:09:17.381] Timer tick, asking Buildbucket for the build status
[03:09:17.586] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:17.586] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:26:0) after 1m0s
[03:10:17.607] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:26:0)
[03:10:17.607] Timer tick, asking Buildbucket for the build status
[03:10:17.684] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:10:17.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:27:0) after 1m0s
[03:11:17.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:27:0)
[03:11:17.722] Timer tick, asking Buildbucket for the build status
[03:11:17.954] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:17.954] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:28:0) after 1m0s
[03:12:17.978] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:28:0)
[03:12:17.978] Timer tick, asking Buildbucket for the build status
[03:12:18.079] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:18.079] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:29:0) after 1m0s
[03:13:18.101] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:29:0)
[03:13:18.101] Timer tick, asking Buildbucket for the build status
[03:13:18.282] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:18.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:30:0) after 1m0s
[03:14:18.383] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:30:0)
[03:14:18.383] Timer tick, asking Buildbucket for the build status
[03:14:18.437] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:18.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:31:0) after 1m0s
[03:15:18.511] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:31:0)
[03:15:18.511] Timer tick, asking Buildbucket for the build status
[03:15:18.577] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:18.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:32:0) after 1m0s
[03:16:18.605] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:32:0)
[03:16:18.605] Timer tick, asking Buildbucket for the build status
[03:16:18.736] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:18.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:33:0) after 1m0s
[03:17:18.754] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:33:0)
[03:17:18.754] Timer tick, asking Buildbucket for the build status
[03:17:18.922] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:18.923] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:34:0) after 1m0s
[03:18:18.945] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:34:0)
[03:18:18.945] Timer tick, asking Buildbucket for the build status
[03:18:19.193] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:19.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:35:0) after 1m0s
[03:19:19.212] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:35:0)
[03:19:19.212] Timer tick, asking Buildbucket for the build status
[03:19:19.320] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:19.320] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:36:0) after 1m0s
[03:20:19.339] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:36:0)
[03:20:19.339] Timer tick, asking Buildbucket for the build status
[03:20:19.383] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:19.383] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:37:0) after 1m0s
[03:21:19.405] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:37:0)
[03:21:19.405] Timer tick, asking Buildbucket for the build status
[03:21:19.484] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:19.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:38:0) after 1m0s
[03:22:19.501] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:38:0)
[03:22:19.501] Timer tick, asking Buildbucket for the build status
[03:22:19.636] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:19.636] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:39:0) after 1m0s
[03:23:19.659] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:39:0)
[03:23:19.659] Timer tick, asking Buildbucket for the build status
[03:23:19.735] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:23:19.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:40:0) after 1m0s
[03:24:19.759] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:40:0)
[03:24:19.759] Timer tick, asking Buildbucket for the build status
[03:24:19.852] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:24:19.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:41:0) after 1m0s
[03:25:19.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:41:0)
[03:25:19.932] Timer tick, asking Buildbucket for the build status
[03:25:20.063] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:20.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:42:0) after 1m0s
[03:26:20.082] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:42:0)
[03:26:20.082] Timer tick, asking Buildbucket for the build status
[03:26:20.199] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:20.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:43:0) after 1m0s
[03:27:20.291] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:43:0)
[03:27:20.291] Timer tick, asking Buildbucket for the build status
[03:27:20.335] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:27:20.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:44:0) after 1m0s
[03:28:20.355] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:44:0)
[03:28:20.355] Timer tick, asking Buildbucket for the build status
[03:28:20.418] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:28:20.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:45:0) after 1m0s
[03:29:20.448] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:45:0)
[03:29:20.448] Timer tick, asking Buildbucket for the build status
[03:29:20.561] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:20.561] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:46:0) after 1m0s
[03:30:20.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:46:0)
[03:30:20.587] Timer tick, asking Buildbucket for the build status
[03:30:20.769] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:20.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:47:0) after 1m0s
[03:31:20.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:47:0)
[03:31:20.787] Timer tick, asking Buildbucket for the build status
[03:31:20.951] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:20.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:48:0) after 1m0s
[03:32:20.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:48:0)
[03:32:20.969] Timer tick, asking Buildbucket for the build status
[03:32:21.201] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:21.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:49:0) after 1m0s
[03:33:21.219] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:49:0)
[03:33:21.219] Timer tick, asking Buildbucket for the build status
[03:33:21.341] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:33:21.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:50:0) after 1m0s
[03:34:21.362] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:50:0)
[03:34:21.362] Timer tick, asking Buildbucket for the build status
[03:34:21.422] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:21.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:51:0) after 1m0s
[03:35:21.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:51:0)
[03:35:21.459] Timer tick, asking Buildbucket for the build status
[03:35:21.636] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:21.636] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:52:0) after 1m0s
[03:36:21.659] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:52:0)
[03:36:21.659] Timer tick, asking Buildbucket for the build status
[03:36:21.722] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:21.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:53:0) after 1m0s
[03:37:21.753] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:53:0)
[03:37:21.753] Timer tick, asking Buildbucket for the build status
[03:37:21.822] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:21.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:54:0) after 1m0s
[03:38:21.872] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:54:0)
[03:38:21.872] Timer tick, asking Buildbucket for the build status
[03:38:21.957] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:21.957] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:55:0) after 1m0s
[03:39:21.979] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:55:0)
[03:39:21.979] Timer tick, asking Buildbucket for the build status
[03:39:22.099] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:22.099] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:56:0) after 1m0s
[03:40:22.120] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:56:0)
[03:40:22.120] Timer tick, asking Buildbucket for the build status
[03:40:22.200] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:40:22.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:57:0) after 1m0s
[03:41:22.234] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:57:0)
[03:41:22.234] Timer tick, asking Buildbucket for the build status
[03:41:22.491] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:22.491] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:58:0) after 1m0s
[03:42:22.511] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:58:0)
[03:42:22.511] Timer tick, asking Buildbucket for the build status
[03:42:22.549] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:22.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:59:0) after 1m0s
[03:43:22.607] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:59:0)
[03:43:22.607] Timer tick, asking Buildbucket for the build status
[03:43:22.678] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:22.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:60:0) after 1m0s
[03:44:22.703] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:60:0)
[03:44:22.703] Timer tick, asking Buildbucket for the build status
[03:44:22.769] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:22.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:61:0) after 1m0s
[03:45:22.798] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:61:0)
[03:45:22.798] Timer tick, asking Buildbucket for the build status
[03:45:23.028] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:23.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:62:0) after 1m0s
[03:46:23.049] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:62:0)
[03:46:23.049] Timer tick, asking Buildbucket for the build status
[03:46:23.102] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:23.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:63:0) after 1m0s
[03:47:23.125] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:63:0)
[03:47:23.125] Timer tick, asking Buildbucket for the build status
[03:47:23.181] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:23.181] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:64:0) after 1m0s
[03:48:23.204] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:64:0)
[03:48:23.204] Timer tick, asking Buildbucket for the build status
[03:48:23.243] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:23.243] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:65:0) after 1m0s
[03:49:23.348] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:65:0)
[03:49:23.348] Timer tick, asking Buildbucket for the build status
[03:49:23.407] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:23.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:66:0) after 1m0s
[03:50:23.449] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:66:0)
[03:50:23.449] Timer tick, asking Buildbucket for the build status
[03:50:23.527] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:50:23.527] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:67:0) after 1m0s
[03:51:23.548] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:67:0)
[03:51:23.548] Timer tick, asking Buildbucket for the build status
[03:51:23.589] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:51:23.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:68:0) after 1m0s
[03:52:23.614] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:68:0)
[03:52:23.614] Timer tick, asking Buildbucket for the build status
[03:52:23.674] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:23.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:69:0) after 1m0s
[03:53:23.739] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:69:0)
[03:53:23.739] Timer tick, asking Buildbucket for the build status
[03:53:23.801] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:23.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:70:0) after 1m0s
[03:54:23.822] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:70:0)
[03:54:23.822] Timer tick, asking Buildbucket for the build status
[03:54:23.944] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:23.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:71:0) after 1m0s
[03:55:23.963] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:71:0)
[03:55:23.963] Timer tick, asking Buildbucket for the build status
[03:55:24.030] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:24.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:72:0) after 1m0s
[03:56:24.051] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:72:0)
[03:56:24.051] Timer tick, asking Buildbucket for the build status
[03:56:24.101] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:24.101] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:73:0) after 1m0s
[03:57:24.138] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:73:0)
[03:57:24.138] Timer tick, asking Buildbucket for the build status
[03:57:26.313] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:26.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:74:0) after 1m0s
[03:58:26.339] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:74:0)
[03:58:26.339] Timer tick, asking Buildbucket for the build status
[03:58:26.395] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:26.395] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:75:0) after 1m0s
[03:59:26.419] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:75:0)
[03:59:26.419] Timer tick, asking Buildbucket for the build status
[03:59:26.455] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:59:26.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:76:0) after 1m0s
[04:00:26.498] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:76:0)
[04:00:26.498] Timer tick, asking Buildbucket for the build status
[04:00:26.676] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:00:26.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:77:0) after 1m0s
[04:01:26.695] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:77:0)
[04:01:26.695] Timer tick, asking Buildbucket for the build status
[04:01:27.046] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:27.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:78:0) after 1m0s
[04:02:27.063] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:78:0)
[04:02:27.063] Timer tick, asking Buildbucket for the build status
[04:02:27.147] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:27.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:79:0) after 1m0s
[04:03:27.176] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:79:0)
[04:03:27.176] Timer tick, asking Buildbucket for the build status
[04:03:27.247] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:27.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:80:0) after 1m0s
[04:04:27.273] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:80:0)
[04:04:27.273] Timer tick, asking Buildbucket for the build status
[04:04:27.419] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:27.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:81:0) after 1m0s
[04:05:27.439] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:81:0)
[04:05:27.439] Timer tick, asking Buildbucket for the build status
[04:05:27.481] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:27.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:82:0) after 1m0s
[04:06:27.522] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:82:0)
[04:06:27.522] Timer tick, asking Buildbucket for the build status
[04:06:27.565] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:27.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:83:0) after 1m0s
[04:07:27.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:83:0)
[04:07:27.587] Timer tick, asking Buildbucket for the build status
[04:07:27.664] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:27.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:84:0) after 1m0s
[04:08:27.685] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:84:0)
[04:08:27.685] Timer tick, asking Buildbucket for the build status
[04:08:27.747] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:27.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:85:0) after 1m0s
[04:09:27.765] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:85:0)
[04:09:27.765] Timer tick, asking Buildbucket for the build status
[04:09:27.835] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:27.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:86:0) after 1m0s
[04:10:27.859] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:86:0)
[04:10:27.859] Timer tick, asking Buildbucket for the build status
[04:10:27.905] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:27.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:87:0) after 1m0s
[04:11:27.933] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:87:0)
[04:11:27.933] Timer tick, asking Buildbucket for the build status
[04:11:28.038] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:28.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:88:0) after 1m0s
[04:12:28.063] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:88:0)
[04:12:28.063] Timer tick, asking Buildbucket for the build status
[04:12:28.231] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:28.231] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:89:0) after 1m0s
[04:13:28.255] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:89:0)
[04:13:28.255] Timer tick, asking Buildbucket for the build status
[04:13:28.295] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:28.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:90:0) after 1m0s
[04:14:28.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:90:0)
[04:14:28.318] Timer tick, asking Buildbucket for the build status
[04:14:28.399] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:28.399] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:91:0) after 1m0s
[04:15:28.429] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:91:0)
[04:15:28.429] Timer tick, asking Buildbucket for the build status
[04:15:28.475] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:28.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:92:0) after 1m0s
[04:16:28.498] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:92:0)
[04:16:28.498] Timer tick, asking Buildbucket for the build status
[04:16:28.600] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:28.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:93:0) after 1m0s
[04:17:28.621] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:93:0)
[04:17:28.621] Timer tick, asking Buildbucket for the build status
[04:17:28.659] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:28.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:94:0) after 1m0s
[04:18:28.677] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:94:0)
[04:18:28.677] Timer tick, asking Buildbucket for the build status
[04:18:28.716] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:28.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:95:0) after 1m0s
[04:19:28.781] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:95:0)
[04:19:28.781] Timer tick, asking Buildbucket for the build status
[04:19:28.998] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:28.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:96:0) after 1m0s
[04:20:29.024] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:96:0)
[04:20:29.024] Timer tick, asking Buildbucket for the build status
[04:20:29.083] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:29.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:97:0) after 1m0s
[04:21:29.107] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:97:0)
[04:21:29.107] Timer tick, asking Buildbucket for the build status
[04:21:29.228] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:29.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:98:0) after 1m0s
[04:22:29.252] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:98:0)
[04:22:29.252] Timer tick, asking Buildbucket for the build status
[04:22:29.380] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:29.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:99:0) after 1m0s
[04:23:29.409] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:99:0)
[04:23:29.409] Timer tick, asking Buildbucket for the build status
[04:23:29.508] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:29.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:100:0) after 1m0s
[04:24:29.534] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:100:0)
[04:24:29.534] Timer tick, asking Buildbucket for the build status
[04:24:29.588] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:29.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:101:0) after 1m0s
[04:25:29.619] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:101:0)
[04:25:29.619] Timer tick, asking Buildbucket for the build status
[04:25:29.782] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:29.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:102:0) after 1m0s
[04:26:29.805] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:102:0)
[04:26:29.805] Timer tick, asking Buildbucket for the build status
[04:26:29.933] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:29.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:103:0) after 1m0s
[04:27:29.957] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:103:0)
[04:27:29.957] Timer tick, asking Buildbucket for the build status
[04:27:30.049] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:30.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:104:0) after 1m0s
[04:28:30.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:104:0)
[04:28:30.072] Timer tick, asking Buildbucket for the build status
[04:28:30.156] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:30.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:105:0) after 1m0s
[04:29:30.178] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:105:0)
[04:29:30.178] Timer tick, asking Buildbucket for the build status
[04:29:30.249] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:30.249] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:106:0) after 1m0s
[04:30:30.286] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:106:0)
[04:30:30.286] Timer tick, asking Buildbucket for the build status
[04:30:30.344] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:30.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:107:0) after 1m0s
[04:31:30.368] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:107:0)
[04:31:30.368] Timer tick, asking Buildbucket for the build status
[04:31:30.410] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:30.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:108:0) after 1m0s
[04:32:30.510] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:108:0)
[04:32:30.510] Timer tick, asking Buildbucket for the build status
[04:32:30.633] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:30.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:109:0) after 1m0s
[04:33:30.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:109:0)
[04:33:30.656] Timer tick, asking Buildbucket for the build status
[04:33:30.725] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:30.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:110:0) after 1m0s
[04:34:30.751] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:110:0)
[04:34:30.751] Timer tick, asking Buildbucket for the build status
[04:34:30.805] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:30.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:111:0) after 1m0s
[04:35:30.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:111:0)
[04:35:30.832] Timer tick, asking Buildbucket for the build status
[04:35:30.898] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:30.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:112:0) after 1m0s
[04:36:31.182] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:112:0)
[04:36:31.182] Timer tick, asking Buildbucket for the build status
[04:36:31.241] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:31.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:113:0) after 1m0s
[04:37:31.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:113:0)
[04:37:31.577] Timer tick, asking Buildbucket for the build status
[04:37:31.644] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:31.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:114:0) after 1m0s
[04:38:32.480] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:114:0)
[04:38:32.480] Timer tick, asking Buildbucket for the build status
[04:38:32.568] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:32.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:115:0) after 1m0s
[04:39:32.794] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:115:0)
[04:39:32.794] Timer tick, asking Buildbucket for the build status
[04:39:32.944] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:32.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:116:0) after 1m0s
[04:40:33.915] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:116:0)
[04:40:33.915] Timer tick, asking Buildbucket for the build status
[04:40:33.952] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:33.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:117:0) after 1m0s
[04:41:34.201] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:117:0)
[04:41:34.201] Timer tick, asking Buildbucket for the build status
[04:41:34.284] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:34.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:118:0) after 1m0s
[04:42:34.420] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:118:0)
[04:42:34.420] Timer tick, asking Buildbucket for the build status
[04:42:34.511] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:34.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:119:0) after 1m0s
[04:43:35.105] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:119:0)
[04:43:35.105] Timer tick, asking Buildbucket for the build status
[04:43:35.175] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:35.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:120:0) after 1m0s
[04:44:35.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:120:0)
[04:44:35.646] Timer tick, asking Buildbucket for the build status
[04:44:35.806] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:35.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:121:0) after 1m0s
[04:45:36.427] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:121:0)
[04:45:36.427] Timer tick, asking Buildbucket for the build status
[04:45:36.625] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:36.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:122:0) after 1m0s
[04:46:37.060] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:122:0)
[04:46:37.061] Timer tick, asking Buildbucket for the build status
[04:46:37.191] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:37.191] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:123:0) after 1m0s
[04:47:37.321] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:123:0)
[04:47:37.321] Timer tick, asking Buildbucket for the build status
[04:47:37.364] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:37.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:124:0) after 1m0s
[04:48:37.750] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:124:0)
[04:48:37.750] Timer tick, asking Buildbucket for the build status
[04:48:37.811] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:37.811] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:125:0) after 1m0s
[04:49:38.443] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:125:0)
[04:49:38.443] Timer tick, asking Buildbucket for the build status
[04:49:38.511] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:38.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:126:0) after 1m0s
[04:50:39.021] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:126:0)
[04:50:39.021] Timer tick, asking Buildbucket for the build status
[04:50:39.084] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:39.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:127:0) after 1m0s
[04:51:39.297] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:127:0)
[04:51:39.297] Timer tick, asking Buildbucket for the build status
[04:51:39.349] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:39.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:128:0) after 1m0s
[04:52:39.399] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:128:0)
[04:52:39.399] Timer tick, asking Buildbucket for the build status
[04:52:39.459] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:39.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:129:0) after 1m0s
[04:53:39.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:129:0)
[04:53:39.921] Timer tick, asking Buildbucket for the build status
[04:53:39.967] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:39.967] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:130:0) after 1m0s
[04:54:40.687] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:130:0)
[04:54:40.687] Timer tick, asking Buildbucket for the build status
[04:54:40.747] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:40.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:131:0) after 1m0s
[04:55:40.801] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:131:0)
[04:55:40.801] Timer tick, asking Buildbucket for the build status
[04:55:40.882] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:40.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:132:0) after 1m0s
[04:56:41.286] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:132:0)
[04:56:41.286] Timer tick, asking Buildbucket for the build status
[04:56:41.448] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:41.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:133:0) after 1m0s
[04:57:41.985] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:133:0)
[04:57:41.985] Timer tick, asking Buildbucket for the build status
[04:57:42.058] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:42.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:134:0) after 1m0s
[04:58:42.525] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:134:0)
[04:58:42.525] Timer tick, asking Buildbucket for the build status
[04:58:42.577] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:42.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:135:0) after 1m0s
[04:59:42.604] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:135:0)
[04:59:42.604] Timer tick, asking Buildbucket for the build status
[04:59:42.682] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:42.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:136:0) after 1m0s
[05:00:42.708] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:136:0)
[05:00:42.708] Timer tick, asking Buildbucket for the build status
[05:00:42.784] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:42.784] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:137:0) after 1m0s
[05:01:42.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:137:0)
[05:01:42.808] Timer tick, asking Buildbucket for the build status
[05:01:42.863] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:42.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:138:0) after 1m0s
[05:02:43.918] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:138:0)
[05:02:43.918] Timer tick, asking Buildbucket for the build status
[05:02:44.100] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:44.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:139:0) after 1m0s
[05:03:44.499] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:139:0)
[05:03:44.499] Timer tick, asking Buildbucket for the build status
[05:03:44.781] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:44.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:140:0) after 1m0s
[05:04:45.330] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:140:0)
[05:04:45.330] Timer tick, asking Buildbucket for the build status
[05:04:45.413] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:45.413] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:141:0) after 1m0s
[05:05:45.957] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:141:0)
[05:05:45.957] Timer tick, asking Buildbucket for the build status
[05:05:46.066] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:46.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:142:0) after 1m0s
[05:06:46.484] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:142:0)
[05:06:46.484] Timer tick, asking Buildbucket for the build status
[05:06:46.540] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:46.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:143:0) after 1m0s
[05:07:46.601] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:143:0)
[05:07:46.601] Timer tick, asking Buildbucket for the build status
[05:07:46.759] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:46.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:144:0) after 1m0s
[05:08:47.204] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:144:0)
[05:08:47.204] Timer tick, asking Buildbucket for the build status
[05:08:47.264] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:47.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:145:0) after 1m0s
[05:09:47.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:145:0)
[05:09:47.344] Timer tick, asking Buildbucket for the build status
[05:09:47.426] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:47.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:146:0) after 1m0s
[05:10:47.549] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:146:0)
[05:10:47.549] Timer tick, asking Buildbucket for the build status
[05:10:47.730] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:47.730] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:147:0) after 1m0s
[05:11:48.068] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:147:0)
[05:11:48.068] Timer tick, asking Buildbucket for the build status
[05:11:48.157] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:48.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:148:0) after 1m0s
[05:12:49.187] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:148:0)
[05:12:49.187] Timer tick, asking Buildbucket for the build status
[05:12:49.323] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:49.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:149:0) after 1m0s
[05:13:49.386] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:149:0)
[05:13:49.386] Timer tick, asking Buildbucket for the build status
[05:13:49.444] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:49.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:150:0) after 1m0s
[05:14:49.645] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:150:0)
[05:14:49.645] Timer tick, asking Buildbucket for the build status
[05:14:49.721] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:49.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:151:0) after 1m0s
[05:15:49.801] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:151:0)
[05:15:49.801] Timer tick, asking Buildbucket for the build status
[05:15:49.920] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:49.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:152:0) after 1m0s
[05:16:50.115] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:152:0)
[05:16:50.115] Timer tick, asking Buildbucket for the build status
[05:16:50.287] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:50.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:153:0) after 1m0s
[05:17:50.797] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:153:0)
[05:17:50.797] Timer tick, asking Buildbucket for the build status
[05:17:50.868] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:50.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:154:0) after 1m0s
[05:18:51.408] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:154:0)
[05:18:51.408] Timer tick, asking Buildbucket for the build status
[05:18:51.497] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:18:51.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:155:0) after 1m0s
[05:19:51.527] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:155:0)
[05:19:51.527] Timer tick, asking Buildbucket for the build status
[05:19:51.631] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:19:51.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:156:0) after 1m0s
[05:20:51.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:156:0)
[05:20:51.663] Timer tick, asking Buildbucket for the build status
[05:20:51.705] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:20:51.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:157:0) after 1m0s
[05:21:51.730] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:157:0)
[05:21:51.730] Timer tick, asking Buildbucket for the build status
[05:21:51.938] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:51.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:158:0) after 1m0s
[05:22:51.963] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:158:0)
[05:22:51.963] Timer tick, asking Buildbucket for the build status
[05:22:52.084] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:22:52.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:159:0) after 1m0s
[05:23:52.182] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:159:0)
[05:23:52.182] Timer tick, asking Buildbucket for the build status
[05:23:52.261] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:52.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:160:0) after 1m0s
[05:24:52.328] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:160:0)
[05:24:52.328] Timer tick, asking Buildbucket for the build status
[05:24:52.408] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:52.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:161:0) after 1m0s
[05:25:52.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:161:0)
[05:25:52.438] Timer tick, asking Buildbucket for the build status
[05:25:52.628] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:25:52.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:162:0) after 1m0s
[05:26:53.004] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:162:0)
[05:26:53.004] Timer tick, asking Buildbucket for the build status
[05:26:53.080] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:26:53.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:163:0) after 1m0s
[05:27:53.634] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:163:0)
[05:27:53.634] Timer tick, asking Buildbucket for the build status
[05:27:53.728] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:27:53.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:164:0) after 1m0s
[05:28:54.389] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:164:0)
[05:28:54.389] Timer tick, asking Buildbucket for the build status
[05:28:54.709] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:28:54.709] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:165:0) after 1m0s
[05:29:54.732] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:165:0)
[05:29:54.732] Timer tick, asking Buildbucket for the build status
[05:29:54.800] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:29:54.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:166:0) after 1m0s
[05:30:54.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:166:0)
[05:30:54.832] Timer tick, asking Buildbucket for the build status
[05:30:54.916] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:54.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:167:0) after 1m0s
[05:31:54.968] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:167:0)
[05:31:54.969] Timer tick, asking Buildbucket for the build status
[05:31:55.041] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:55.041] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:168:0) after 1m0s
[05:32:55.145] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:168:0)
[05:32:55.145] Timer tick, asking Buildbucket for the build status
[05:32:55.262] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:55.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:169:0) after 1m0s
[05:33:55.286] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:169:0)
[05:33:55.286] Timer tick, asking Buildbucket for the build status
[05:33:55.336] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:55.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:170:0) after 1m0s
[05:34:55.729] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:170:0)
[05:34:55.729] Timer tick, asking Buildbucket for the build status
[05:34:55.836] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:55.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:171:0) after 1m0s
[05:35:55.861] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:171:0)
[05:35:55.861] Timer tick, asking Buildbucket for the build status
[05:35:56.080] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:56.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:172:0) after 1m0s
[05:36:56.501] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:172:0)
[05:36:56.501] Timer tick, asking Buildbucket for the build status
[05:36:56.594] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:56.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:173:0) after 1m0s
[05:37:57.303] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:173:0)
[05:37:57.303] Timer tick, asking Buildbucket for the build status
[05:37:57.430] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:57.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:174:0) after 1m0s
[05:38:58.153] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:174:0)
[05:38:58.153] Timer tick, asking Buildbucket for the build status
[05:38:58.453] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:58.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:175:0) after 1m0s
[05:39:58.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:175:0)
[05:39:58.498] Timer tick, asking Buildbucket for the build status
[05:39:58.582] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:58.582] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:176:0) after 1m0s
[05:40:58.618] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:176:0)
[05:40:58.618] Timer tick, asking Buildbucket for the build status
[05:40:58.677] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:58.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:177:0) after 1m0s
[05:41:58.713] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:177:0)
[05:41:58.713] Timer tick, asking Buildbucket for the build status
[05:41:58.810] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:58.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:178:0) after 1m0s
[05:42:58.835] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:178:0)
[05:42:58.835] Timer tick, asking Buildbucket for the build status
[05:42:58.937] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:58.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:179:0) after 1m0s
[05:43:59.495] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:179:0)
[05:43:59.495] Timer tick, asking Buildbucket for the build status
[05:43:59.715] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:59.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:180:0) after 1m0s
[05:45:00.182] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:180:0)
[05:45:00.182] Timer tick, asking Buildbucket for the build status
[05:45:00.279] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:00.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:181:0) after 1m0s
[05:46:00.395] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:181:0)
[05:46:00.395] Timer tick, asking Buildbucket for the build status
[05:46:00.525] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:00.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:182:0) after 1m0s
[05:47:00.687] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:182:0)
[05:47:00.687] Timer tick, asking Buildbucket for the build status
[05:47:00.762] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:00.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:183:0) after 1m0s
[05:48:00.784] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:183:0)
[05:48:00.784] Timer tick, asking Buildbucket for the build status
[05:48:00.903] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:00.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:184:0) after 1m0s
[05:49:01.372] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:184:0)
[05:49:01.372] Timer tick, asking Buildbucket for the build status
[05:49:01.468] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:49:01.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:185:0) after 1m0s
[05:50:01.673] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:185:0)
[05:50:01.673] Timer tick, asking Buildbucket for the build status
[05:50:01.751] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:01.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:186:0) after 1m0s
[05:51:02.462] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:186:0)
[05:51:02.462] Timer tick, asking Buildbucket for the build status
[05:51:02.675] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:02.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:187:0) after 1m0s
[05:52:03.169] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:187:0)
[05:52:03.169] Timer tick, asking Buildbucket for the build status
[05:52:03.224] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:03.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:188:0) after 1m0s
[05:53:03.251] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:188:0)
[05:53:03.251] Timer tick, asking Buildbucket for the build status
[05:53:03.363] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:03.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:189:0) after 1m0s
[05:54:03.505] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:189:0)
[05:54:03.505] Timer tick, asking Buildbucket for the build status
[05:54:03.573] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:03.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:190:0) after 1m0s
[05:55:03.611] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:190:0)
[05:55:03.611] Timer tick, asking Buildbucket for the build status
[05:55:03.690] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:03.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:191:0) after 1m0s
[05:56:04.285] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:191:0)
[05:56:04.285] Timer tick, asking Buildbucket for the build status
[05:56:04.334] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:04.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:192:0) after 1m0s
[05:57:04.845] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:192:0)
[05:57:04.845] Timer tick, asking Buildbucket for the build status
[05:57:05.021] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:05.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:193:0) after 1m0s
[05:58:05.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:193:0)
[05:58:05.671] Timer tick, asking Buildbucket for the build status
[05:58:05.728] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:05.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:194:0) after 1m0s
[05:59:06.094] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:194:0)
[05:59:06.094] Timer tick, asking Buildbucket for the build status
[05:59:06.280] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:06.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:195:0) after 1m0s
[06:00:06.323] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:195:0)
[06:00:06.323] Timer tick, asking Buildbucket for the build status
[06:00:06.373] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:00:06.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:196:0) after 1m0s
[06:01:07.305] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:196:0)
[06:01:07.305] Timer tick, asking Buildbucket for the build status
[06:01:07.534] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:07.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:197:0) after 1m0s
[06:02:07.560] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:197:0)
[06:02:07.560] Timer tick, asking Buildbucket for the build status
[06:02:07.601] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:02:07.601] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:198:0) after 1m0s
[06:03:07.691] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:198:0)
[06:03:07.691] Timer tick, asking Buildbucket for the build status
[06:03:07.772] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:03:07.772] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:199:0) after 1m0s
[06:04:07.797] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:199:0)
[06:04:07.797] Timer tick, asking Buildbucket for the build status
[06:04:07.870] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:04:07.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:200:0) after 1m0s
[06:05:07.916] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:200:0)
[06:05:07.916] Timer tick, asking Buildbucket for the build status
[06:05:07.998] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:05:07.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:201:0) after 1m0s
[06:06:08.087] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:201:0)
[06:06:08.087] Timer tick, asking Buildbucket for the build status
[06:06:08.157] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:06:08.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:202:0) after 1m0s
[06:07:08.204] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:202:0)
[06:07:08.204] Timer tick, asking Buildbucket for the build status
[06:07:08.294] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:07:08.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:203:0) after 1m0s
[06:08:08.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:203:0)
[06:08:08.344] Timer tick, asking Buildbucket for the build status
[06:08:08.467] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:08:08.467] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:204:0) after 1m0s
[06:09:08.581] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:204:0)
[06:09:08.581] Timer tick, asking Buildbucket for the build status
[06:09:08.647] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:09:08.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:205:0) after 1m0s
[06:10:08.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:205:0)
[06:10:08.773] Timer tick, asking Buildbucket for the build status
[06:10:08.834] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:10:08.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:206:0) after 1m0s
[06:11:09.000] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:206:0)
[06:11:09.000] Timer tick, asking Buildbucket for the build status
[06:11:09.169] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:11:09.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:207:0) after 1m0s
[06:12:09.216] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:207:0)
[06:12:09.216] Timer tick, asking Buildbucket for the build status
[06:12:09.286] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:12:09.286] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:208:0) after 1m0s
[06:13:09.885] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:208:0)
[06:13:09.885] Timer tick, asking Buildbucket for the build status
[06:13:09.940] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:13:09.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:209:0) after 1m0s
[06:14:09.972] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:209:0)
[06:14:09.972] Timer tick, asking Buildbucket for the build status
[06:14:10.091] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:10.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:210:0) after 1m0s
[06:15:10.634] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:210:0)
[06:15:10.634] Timer tick, asking Buildbucket for the build status
[06:15:10.741] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:10.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:211:0) after 1m0s
[06:16:10.798] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:211:0)
[06:16:10.798] Timer tick, asking Buildbucket for the build status
[06:16:10.881] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:10.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:212:0) after 1m0s
[06:17:11.410] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:212:0)
[06:17:11.410] Timer tick, asking Buildbucket for the build status
[06:17:11.612] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:11.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:213:0) after 1m0s
[06:18:12.218] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:213:0)
[06:18:12.218] Timer tick, asking Buildbucket for the build status
[06:18:12.256] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:12.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:214:0) after 1m0s
[06:19:12.826] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:214:0)
[06:19:12.826] Timer tick, asking Buildbucket for the build status
[06:19:12.890] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:12.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:215:0) after 1m0s
[06:20:12.916] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:215:0)
[06:20:12.916] Timer tick, asking Buildbucket for the build status
[06:20:12.975] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:12.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:216:0) after 1m0s
[06:21:13.478] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:216:0)
[06:21:13.479] Timer tick, asking Buildbucket for the build status
[06:21:13.559] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:21:13.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:217:0) after 1m0s
[06:22:13.690] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:217:0)
[06:22:13.690] Timer tick, asking Buildbucket for the build status
[06:22:13.820] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:22:13.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:218:0) after 1m0s
[06:23:13.846] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:218:0)
[06:23:13.846] Timer tick, asking Buildbucket for the build status
[06:23:13.910] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:23:13.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:219:0) after 1m0s
[06:24:13.994] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:219:0)
[06:24:13.994] Timer tick, asking Buildbucket for the build status
[06:24:14.099] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:24:14.099] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:220:0) after 1m0s
[06:25:14.251] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:220:0)
[06:25:14.251] Timer tick, asking Buildbucket for the build status
[06:25:14.489] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:25:14.489] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:221:0) after 1m0s
[06:26:15.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:221:0)
[06:26:15.071] Timer tick, asking Buildbucket for the build status
[06:26:15.188] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:26:15.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:222:0) after 1m0s
[06:27:15.745] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:222:0)
[06:27:15.745] Timer tick, asking Buildbucket for the build status
[06:27:15.797] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:27:15.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:223:0) after 1m0s
[06:28:15.826] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:223:0)
[06:28:15.826] Timer tick, asking Buildbucket for the build status
[06:28:15.972] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:28:15.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:224:0) after 1m0s
[06:29:15.998] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:224:0)
[06:29:15.998] Timer tick, asking Buildbucket for the build status
[06:29:16.223] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:29:16.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:225:0) after 1m0s
[06:30:16.284] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:225:0)
[06:30:16.284] Timer tick, asking Buildbucket for the build status
[06:30:16.374] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:30:16.374] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:226:0) after 1m0s
[06:31:16.411] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:226:0)
[06:31:16.411] Timer tick, asking Buildbucket for the build status
[06:31:16.477] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:31:16.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:227:0) after 1m0s
[06:32:16.940] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:227:0)
[06:32:16.940] Timer tick, asking Buildbucket for the build status
[06:32:17.108] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:32:17.108] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:228:0) after 1m0s
[06:33:17.925] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:228:0)
[06:33:17.925] Timer tick, asking Buildbucket for the build status
[06:33:18.027] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:33:18.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:229:0) after 1m0s
[06:34:18.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:229:0)
[06:34:18.588] Timer tick, asking Buildbucket for the build status
[06:34:18.653] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:34:18.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:230:0) after 1m0s
[06:35:19.468] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:230:0)
[06:35:19.468] Timer tick, asking Buildbucket for the build status
[06:35:19.540] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:35:19.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:231:0) after 1m0s
[06:36:19.568] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:231:0)
[06:36:19.568] Timer tick, asking Buildbucket for the build status
[06:36:19.825] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:36:19.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:232:0) after 1m0s
[06:37:19.855] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:232:0)
[06:37:19.855] Timer tick, asking Buildbucket for the build status
[06:37:19.951] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:37:19.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:233:0) after 1m0s
[06:38:20.279] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:233:0)
[06:38:20.279] Timer tick, asking Buildbucket for the build status
[06:38:20.317] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:38:20.317] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:234:0) after 1m0s
[06:39:20.589] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:234:0)
[06:39:20.589] Timer tick, asking Buildbucket for the build status
[06:39:20.769] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:39:20.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:235:0) after 1m0s
[06:40:20.805] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:235:0)
[06:40:20.805] Timer tick, asking Buildbucket for the build status
[06:40:20.845] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:40:20.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:236:0) after 1m0s
[06:41:21.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:236:0)
[06:41:21.001] Timer tick, asking Buildbucket for the build status
[06:41:21.205] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:41:21.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:237:0) after 1m0s
[06:42:21.240] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:237:0)
[06:42:21.240] Timer tick, asking Buildbucket for the build status
[06:42:21.280] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:42:21.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:238:0) after 1m0s
[06:43:21.311] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:238:0)
[06:43:21.311] Timer tick, asking Buildbucket for the build status
[06:43:21.427] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:43:21.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:239:0) after 1m0s
[06:44:21.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:239:0)
[06:44:21.496] Timer tick, asking Buildbucket for the build status
[06:44:21.548] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:44:21.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:240:0) after 1m0s
[06:45:21.697] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:240:0)
[06:45:21.697] Timer tick, asking Buildbucket for the build status
[06:45:21.781] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:45:21.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:241:0) after 1m0s
[06:46:22.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:241:0)
[06:46:22.300] Timer tick, asking Buildbucket for the build status
[06:46:22.380] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:46:22.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:242:0) after 1m0s
[06:47:23.097] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:242:0)
[06:47:23.097] Timer tick, asking Buildbucket for the build status
[06:47:23.158] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:47:23.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:243:0) after 1m0s
[06:48:23.984] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:243:0)
[06:48:23.984] Timer tick, asking Buildbucket for the build status
[06:48:24.179] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:48:24.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:244:0) after 1m0s
[06:49:24.741] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:244:0)
[06:49:24.741] Timer tick, asking Buildbucket for the build status
[06:49:24.785] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:49:24.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:245:0) after 1m0s
[06:50:25.517] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:245:0)
[06:50:25.517] Timer tick, asking Buildbucket for the build status
[06:50:25.737] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:50:25.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:246:0) after 1m0s
[06:51:25.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:246:0)
[06:51:25.899] Timer tick, asking Buildbucket for the build status
[06:51:25.999] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:51:25.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:247:0) after 1m0s
[06:52:26.096] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:247:0)
[06:52:26.096] Timer tick, asking Buildbucket for the build status
[06:52:26.317] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:52:26.317] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:248:0) after 1m0s
[06:53:26.362] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:248:0)
[06:53:26.362] Timer tick, asking Buildbucket for the build status
[06:53:26.521] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:53:26.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:249:0) after 1m0s
[06:54:26.551] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:249:0)
[06:54:26.551] Timer tick, asking Buildbucket for the build status
[06:54:26.726] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:54:26.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:250:0) after 1m0s
[06:55:26.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:250:0)
[06:55:26.878] Timer tick, asking Buildbucket for the build status
[06:55:26.968] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:55:26.968] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:251:0) after 1m0s
[06:56:27.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:251:0)
[06:56:27.438] Timer tick, asking Buildbucket for the build status
[06:56:27.659] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:56:27.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:252:0) after 1m0s
[06:57:28.223] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:252:0)
[06:57:28.223] Timer tick, asking Buildbucket for the build status
[06:57:28.278] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:57:28.278] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:253:0) after 1m0s
[06:58:28.368] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:253:0)
[06:58:28.368] Timer tick, asking Buildbucket for the build status
[06:58:28.455] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:58:28.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:254:0) after 1m0s
[06:59:28.600] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:254:0)
[06:59:28.600] Timer tick, asking Buildbucket for the build status
[06:59:28.732] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:59:28.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:255:0) after 1m0s
[07:00:28.799] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:255:0)
[07:00:28.799] Timer tick, asking Buildbucket for the build status
[07:00:29.142] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:00:29.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:256:0) after 1m0s
[07:01:29.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:256:0)
[07:01:29.203] Timer tick, asking Buildbucket for the build status
[07:01:29.320] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:01:29.320] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:257:0) after 1m0s
[07:02:29.413] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:257:0)
[07:02:29.413] Timer tick, asking Buildbucket for the build status
[07:02:29.452] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:29.452] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:258:0) after 1m0s
[07:03:29.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:258:0)
[07:03:29.671] Timer tick, asking Buildbucket for the build status
[07:03:29.753] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:03:29.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:259:0) after 1m0s
[07:04:29.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:259:0)
[07:04:29.878] Timer tick, asking Buildbucket for the build status
[07:04:29.951] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:29.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:260:0) after 1m0s
[07:05:30.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:260:0)
[07:05:30.025] Timer tick, asking Buildbucket for the build status
[07:05:30.102] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:30.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:261:0) after 1m0s
[07:06:31.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:261:0)
[07:06:31.035] Timer tick, asking Buildbucket for the build status
[07:06:31.383] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:06:31.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:262:0) after 1m0s
[07:07:31.845] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:262:0)
[07:07:31.845] Timer tick, asking Buildbucket for the build status
[07:07:31.974] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:07:31.974] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:263:0) after 1m0s
[07:08:32.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:263:0)
[07:08:32.006] Timer tick, asking Buildbucket for the build status
[07:08:32.067] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:08:32.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:264:0) after 1m0s
[07:09:32.159] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:264:0)
[07:09:32.159] Timer tick, asking Buildbucket for the build status
[07:09:32.313] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:09:32.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:265:0) after 1m0s
[07:10:32.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:265:0)
[07:10:32.503] Timer tick, asking Buildbucket for the build status
[07:10:32.622] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:10:32.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:266:0) after 1m0s
[07:11:32.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:266:0)
[07:11:32.646] Timer tick, asking Buildbucket for the build status
[07:11:32.778] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:11:32.778] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:267:0) after 1m0s
[07:12:32.824] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:267:0)
[07:12:32.824] Timer tick, asking Buildbucket for the build status
[07:12:32.947] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:12:32.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:268:0) after 1m0s
[07:13:32.975] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:268:0)
[07:13:32.975] Timer tick, asking Buildbucket for the build status
[07:13:33.035] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:13:33.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:269:0) after 1m0s
[07:14:33.062] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:269:0)
[07:14:33.062] Timer tick, asking Buildbucket for the build status
[07:14:33.377] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:14:33.377] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:270:0) after 1m0s
[07:15:33.406] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:270:0)
[07:15:33.406] Timer tick, asking Buildbucket for the build status
[07:15:33.490] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:33.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:271:0) after 1m0s
[07:16:33.516] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:271:0)
[07:16:33.516] Timer tick, asking Buildbucket for the build status
[07:16:33.639] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:16:33.639] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:272:0) after 1m0s
[07:17:33.723] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:272:0)
[07:17:33.723] Timer tick, asking Buildbucket for the build status
[07:17:34.012] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:34.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:273:0) after 1m0s
[07:18:34.393] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:273:0)
[07:18:34.393] Timer tick, asking Buildbucket for the build status
[07:18:34.435] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:34.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:274:0) after 1m0s
[07:19:34.472] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:274:0)
[07:19:34.472] Timer tick, asking Buildbucket for the build status
[07:19:34.577] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:19:34.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:275:0) after 1m0s
[07:20:34.688] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:275:0)
[07:20:34.688] Timer tick, asking Buildbucket for the build status
[07:20:34.787] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:20:34.787] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:276:0) after 1m0s
[07:21:34.823] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:276:0)
[07:21:34.823] Timer tick, asking Buildbucket for the build status
[07:21:34.874] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:21:34.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:277:0) after 1m0s
[07:22:35.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:277:0)
[07:22:35.203] Timer tick, asking Buildbucket for the build status
[07:22:35.383] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:22:35.383] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:278:0) after 1m0s
[07:23:35.859] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:278:0)
[07:23:35.859] Timer tick, asking Buildbucket for the build status
[07:23:35.895] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:23:35.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:279:0) after 1m0s
[07:24:35.982] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:279:0)
[07:24:35.982] Timer tick, asking Buildbucket for the build status
[07:24:36.139] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:24:36.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:280:0) after 1m0s
[07:25:36.494] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:280:0)
[07:25:36.494] Timer tick, asking Buildbucket for the build status
[07:25:36.554] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:25:36.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:281:0) after 1m0s
[07:26:37.299] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:281:0)
[07:26:37.299] Timer tick, asking Buildbucket for the build status
[07:26:37.336] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:26:37.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:282:0) after 1m0s
[07:27:37.364] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:282:0)
[07:27:37.364] Timer tick, asking Buildbucket for the build status
[07:27:37.421] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:27:37.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:283:0) after 1m0s
[07:28:37.449] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:283:0)
[07:28:37.449] Timer tick, asking Buildbucket for the build status
[07:28:37.518] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:28:37.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:284:0) after 1m0s
[07:29:37.586] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:284:0)
[07:29:37.586] Timer tick, asking Buildbucket for the build status
[07:29:37.642] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:29:37.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:285:0) after 1m0s
[07:30:37.670] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:285:0)
[07:30:37.670] Timer tick, asking Buildbucket for the build status
[07:30:37.796] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:30:37.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:286:0) after 1m0s
[07:31:38.487] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:286:0)
[07:31:38.487] Timer tick, asking Buildbucket for the build status
[07:31:38.614] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:31:38.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:287:0) after 1m0s
[07:32:39.320] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:287:0)
[07:32:39.320] Timer tick, asking Buildbucket for the build status
[07:32:39.445] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:32:39.445] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:288:0) after 1m0s
[07:33:39.482] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:288:0)
[07:33:39.482] Timer tick, asking Buildbucket for the build status
[07:33:39.540] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:33:39.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:289:0) after 1m0s
[07:34:39.598] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:289:0)
[07:34:39.599] Timer tick, asking Buildbucket for the build status
[07:34:39.677] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:34:39.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:290:0) after 1m0s
[07:35:39.709] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:290:0)
[07:35:39.709] Timer tick, asking Buildbucket for the build status
[07:35:39.887] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:35:39.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:291:0) after 1m0s
[07:36:40.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:291:0)
[07:36:40.207] Timer tick, asking Buildbucket for the build status
[07:36:40.310] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:36:40.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:292:0) after 1m0s
[07:37:40.872] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:292:0)
[07:37:40.873] Timer tick, asking Buildbucket for the build status
[07:37:40.935] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:37:40.935] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:293:0) after 1m0s
[07:38:41.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:293:0)
[07:38:41.001] Timer tick, asking Buildbucket for the build status
[07:38:41.059] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:38:41.060] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:294:0) after 1m0s
[07:39:41.184] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:294:0)
[07:39:41.184] Timer tick, asking Buildbucket for the build status
[07:39:41.341] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:39:41.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:295:0) after 1m0s
[07:40:41.391] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:295:0)
[07:40:41.391] Timer tick, asking Buildbucket for the build status
[07:40:41.482] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:40:41.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:296:0) after 1m0s
[07:41:41.633] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:296:0)
[07:41:41.633] Timer tick, asking Buildbucket for the build status
[07:41:41.953] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:41:41.953] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:297:0) after 1m0s
[07:42:42.726] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:297:0)
[07:42:42.726] Timer tick, asking Buildbucket for the build status
[07:42:42.794] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:42:42.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:298:0) after 1m0s
[07:43:43.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:298:0)
[07:43:43.071] Timer tick, asking Buildbucket for the build status
[07:43:43.174] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:43:43.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:299:0) after 1m0s
[07:44:43.204] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:299:0)
[07:44:43.204] Timer tick, asking Buildbucket for the build status
[07:44:43.273] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:44:43.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:300:0) after 1m0s
[07:45:43.370] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:300:0)
[07:45:43.370] Timer tick, asking Buildbucket for the build status
[07:45:43.528] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:45:43.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:301:0) after 1m0s
[07:46:43.992] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:301:0)
[07:46:43.992] Timer tick, asking Buildbucket for the build status
[07:46:44.180] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:46:44.180] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:302:0) after 1m0s
[07:47:44.206] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:302:0)
[07:47:44.206] Timer tick, asking Buildbucket for the build status
[07:47:44.285] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:47:44.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:303:0) after 1m0s
[07:48:44.789] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:303:0)
[07:48:44.789] Timer tick, asking Buildbucket for the build status
[07:48:44.868] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:48:44.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:304:0) after 1m0s
[07:49:44.908] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:304:0)
[07:49:44.908] Timer tick, asking Buildbucket for the build status
[07:49:45.022] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:49:45.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:305:0) after 1m0s
[07:50:45.159] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:305:0)
[07:50:45.159] Timer tick, asking Buildbucket for the build status
[07:50:45.296] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:50:45.296] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:306:0) after 1m0s
[07:51:45.375] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:306:0)
[07:51:45.375] Timer tick, asking Buildbucket for the build status
[07:51:45.473] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:51:45.473] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:307:0) after 1m0s
[07:52:45.687] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:307:0)
[07:52:45.687] Timer tick, asking Buildbucket for the build status
[07:52:45.754] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:52:45.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:308:0) after 1m0s
[07:53:46.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:308:0)
[07:53:46.394] Timer tick, asking Buildbucket for the build status
[07:53:46.512] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:53:46.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:309:0) after 1m0s
[07:54:47.047] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:309:0)
[07:54:47.047] Timer tick, asking Buildbucket for the build status
[07:54:47.155] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:54:47.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:310:0) after 1m0s
[07:55:47.214] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:310:0)
[07:55:47.214] Timer tick, asking Buildbucket for the build status
[07:55:47.379] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:55:47.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:311:0) after 1m0s
[07:56:47.416] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:311:0)
[07:56:47.416] Timer tick, asking Buildbucket for the build status
[07:56:47.536] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:56:47.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:312:0) after 1m0s
[07:57:48.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:312:0)
[07:57:48.177] Timer tick, asking Buildbucket for the build status
[07:57:48.275] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:57:48.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:313:0) after 1m0s
[07:58:48.882] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:313:0)
[07:58:48.882] Timer tick, asking Buildbucket for the build status
[07:58:49.043] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:58:49.043] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:314:0) after 1m0s
[07:59:49.578] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:314:0)
[07:59:49.578] Timer tick, asking Buildbucket for the build status
[07:59:49.650] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:59:49.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:315:0) after 1m0s
[08:00:50.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:315:0)
[08:00:50.398] Timer tick, asking Buildbucket for the build status
[08:00:50.534] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:00:50.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:316:0) after 1m0s
[08:01:51.175] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:316:0)
[08:01:51.175] Timer tick, asking Buildbucket for the build status
[08:01:51.272] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:01:51.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:317:0) after 1m0s
[08:02:51.857] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:317:0)
[08:02:51.857] Timer tick, asking Buildbucket for the build status
[08:02:52.211] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:02:52.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:318:0) after 1m0s
[08:03:52.852] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:318:0)
[08:03:52.852] Timer tick, asking Buildbucket for the build status
[08:03:53.054] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:03:53.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:319:0) after 1m0s
[08:04:53.595] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:319:0)
[08:04:53.595] Timer tick, asking Buildbucket for the build status
[08:04:53.688] Build 8929193295622443648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:04:53.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:320:0) after 1m0s
[08:04:55.701] Received PubSub notification, asking Buildbucket for the build status
[08:04:55.755] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:54.425] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:320:0)
[08:05:54.425] Timer tick, asking Buildbucket for the build status
[08:05:54.517] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:54.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:322:0) after 1m0s
[08:06:54.623] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:322:0)
[08:06:54.623] Timer tick, asking Buildbucket for the build status
[08:06:54.717] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:54.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:323:0) after 1m0s
[08:07:54.951] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:323:0)
[08:07:54.951] Timer tick, asking Buildbucket for the build status
[08:07:55.097] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:55.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:324:0) after 1m0s
[08:08:55.785] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:324:0)
[08:08:55.785] Timer tick, asking Buildbucket for the build status
[08:08:55.942] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:55.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:325:0) after 1m0s
[08:09:56.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:325:0)
[08:09:56.608] Timer tick, asking Buildbucket for the build status
[08:09:56.745] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:56.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:326:0) after 1m0s
[08:10:57.289] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:326:0)
[08:10:57.289] Timer tick, asking Buildbucket for the build status
[08:10:57.377] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:57.377] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:327:0) after 1m0s
[08:11:58.086] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:327:0)
[08:11:58.086] Timer tick, asking Buildbucket for the build status
[08:11:58.306] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:58.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:328:0) after 1m0s
[08:12:59.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:328:0)
[08:12:59.001] Timer tick, asking Buildbucket for the build status
[08:12:59.114] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:59.114] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:329:0) after 1m0s
[08:13:59.770] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:329:0)
[08:13:59.770] Timer tick, asking Buildbucket for the build status
[08:13:59.896] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:59.896] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:330:0) after 1m0s
[08:15:00.688] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:330:0)
[08:15:00.688] Timer tick, asking Buildbucket for the build status
[08:15:00.879] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:00.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:331:0) after 1m0s
[08:16:01.495] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:331:0)
[08:16:01.495] Timer tick, asking Buildbucket for the build status
[08:16:01.587] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:01.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:332:0) after 1m0s
[08:17:01.639] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:332:0)
[08:17:01.639] Timer tick, asking Buildbucket for the build status
[08:17:01.920] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:01.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:333:0) after 1m0s
[08:18:02.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:333:0)
[08:18:02.318] Timer tick, asking Buildbucket for the build status
[08:18:02.419] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:02.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:334:0) after 1m0s
[08:19:03.097] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:334:0)
[08:19:03.097] Timer tick, asking Buildbucket for the build status
[08:19:03.297] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:03.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:335:0) after 1m0s
[08:20:04.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:335:0)
[08:20:04.185] Timer tick, asking Buildbucket for the build status
[08:20:04.240] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:04.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:336:0) after 1m0s
[08:21:04.710] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:336:0)
[08:21:04.710] Timer tick, asking Buildbucket for the build status
[08:21:04.976] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:04.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:337:0) after 1m0s
[08:22:05.498] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:337:0)
[08:22:05.498] Timer tick, asking Buildbucket for the build status
[08:22:05.808] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:05.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:338:0) after 1m0s
[08:23:06.505] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:338:0)
[08:23:06.505] Timer tick, asking Buildbucket for the build status
[08:23:06.599] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:06.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:339:0) after 1m0s
[08:24:06.907] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:339:0)
[08:24:06.907] Timer tick, asking Buildbucket for the build status
[08:24:06.976] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:06.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:340:0) after 1m0s
[08:25:07.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:340:0)
[08:25:07.032] Timer tick, asking Buildbucket for the build status
[08:25:07.196] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:07.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:341:0) after 1m0s
[08:26:07.238] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:341:0)
[08:26:07.238] Timer tick, asking Buildbucket for the build status
[08:26:07.291] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:07.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:342:0) after 1m0s
[08:27:07.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:342:0)
[08:27:07.397] Timer tick, asking Buildbucket for the build status
[08:27:07.531] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:07.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:343:0) after 1m0s
[08:28:07.693] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:343:0)
[08:28:07.693] Timer tick, asking Buildbucket for the build status
[08:28:07.778] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:07.778] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:344:0) after 1m0s
[08:29:07.817] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:344:0)
[08:29:07.817] Timer tick, asking Buildbucket for the build status
[08:29:08.013] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:08.013] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:345:0) after 1m0s
[08:30:08.170] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:345:0)
[08:30:08.170] Timer tick, asking Buildbucket for the build status
[08:30:08.522] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:08.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:346:0) after 1m0s
[08:31:08.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:346:0)
[08:31:08.597] Timer tick, asking Buildbucket for the build status
[08:31:08.709] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:08.709] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:347:0) after 1m0s
[08:32:08.780] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:347:0)
[08:32:08.780] Timer tick, asking Buildbucket for the build status
[08:32:08.891] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:08.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:348:0) after 1m0s
[08:33:08.926] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:348:0)
[08:33:08.926] Timer tick, asking Buildbucket for the build status
[08:33:09.007] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:09.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:349:0) after 1m0s
[08:34:09.036] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:349:0)
[08:34:09.036] Timer tick, asking Buildbucket for the build status
[08:34:09.355] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:09.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:350:0) after 1m0s
[08:35:09.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:350:0)
[08:35:09.455] Timer tick, asking Buildbucket for the build status
[08:35:09.553] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:09.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:351:0) after 1m0s
[08:36:09.674] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:351:0)
[08:36:09.674] Timer tick, asking Buildbucket for the build status
[08:36:09.788] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:09.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:352:0) after 1m0s
[08:37:10.522] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:352:0)
[08:37:10.522] Timer tick, asking Buildbucket for the build status
[08:37:10.594] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:10.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:353:0) after 1m0s
[08:38:10.785] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:353:0)
[08:38:10.785] Timer tick, asking Buildbucket for the build status
[08:38:10.931] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:10.931] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:354:0) after 1m0s
[08:39:10.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:354:0)
[08:39:10.969] Timer tick, asking Buildbucket for the build status
[08:39:11.052] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:11.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:355:0) after 1m0s
[08:40:11.429] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:355:0)
[08:40:11.429] Timer tick, asking Buildbucket for the build status
[08:40:11.488] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:11.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:356:0) after 1m0s
[08:41:12.210] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:356:0)
[08:41:12.210] Timer tick, asking Buildbucket for the build status
[08:41:12.348] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:12.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:357:0) after 1m0s
[08:42:13.008] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:357:0)
[08:42:13.008] Timer tick, asking Buildbucket for the build status
[08:42:13.168] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:13.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:358:0) after 1m0s
[08:43:13.993] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:358:0)
[08:43:13.993] Timer tick, asking Buildbucket for the build status
[08:43:14.097] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:14.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:359:0) after 1m0s
[08:44:15.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:359:0)
[08:44:15.721] Timer tick, asking Buildbucket for the build status
[08:44:15.825] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:15.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:360:0) after 1m0s
[08:45:15.940] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:360:0)
[08:45:15.940] Timer tick, asking Buildbucket for the build status
[08:45:16.086] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:16.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:361:0) after 1m0s
[08:46:16.560] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:361:0)
[08:46:16.560] Timer tick, asking Buildbucket for the build status
[08:46:16.717] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:16.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:362:0) after 1m0s
[08:47:16.907] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:362:0)
[08:47:16.907] Timer tick, asking Buildbucket for the build status
[08:47:17.017] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:17.017] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:363:0) after 1m0s
[08:48:17.221] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:363:0)
[08:48:17.221] Timer tick, asking Buildbucket for the build status
[08:48:17.284] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:17.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:364:0) after 1m0s
[08:49:17.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:364:0)
[08:49:17.318] Timer tick, asking Buildbucket for the build status
[08:49:18.137] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:18.137] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:365:0) after 1m0s
[08:50:18.635] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:365:0)
[08:50:18.635] Timer tick, asking Buildbucket for the build status
[08:50:18.785] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:18.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:366:0) after 1m0s
[08:51:19.490] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:366:0)
[08:51:19.490] Timer tick, asking Buildbucket for the build status
[08:51:19.594] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:19.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:367:0) after 1m0s
[08:52:20.516] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:367:0)
[08:52:20.516] Timer tick, asking Buildbucket for the build status
[08:52:20.606] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:20.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:368:0) after 1m0s
[08:53:20.728] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:368:0)
[08:53:20.728] Timer tick, asking Buildbucket for the build status
[08:53:20.788] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:20.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:369:0) after 1m0s
[08:54:20.820] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:369:0)
[08:54:20.820] Timer tick, asking Buildbucket for the build status
[08:54:20.883] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:20.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:370:0) after 1m0s
[08:55:20.919] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:370:0)
[08:55:20.919] Timer tick, asking Buildbucket for the build status
[08:55:20.983] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:20.983] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:371:0) after 1m0s
[08:56:21.014] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:371:0)
[08:56:21.014] Timer tick, asking Buildbucket for the build status
[08:56:21.135] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:21.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:372:0) after 1m0s
[08:57:21.179] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:372:0)
[08:57:21.179] Timer tick, asking Buildbucket for the build status
[08:57:21.301] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:21.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:373:0) after 1m0s
[08:58:21.407] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:373:0)
[08:58:21.407] Timer tick, asking Buildbucket for the build status
[08:58:21.483] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:21.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:374:0) after 1m0s
[08:59:21.526] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:374:0)
[08:59:21.526] Timer tick, asking Buildbucket for the build status
[08:59:21.615] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:21.615] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:375:0) after 1m0s
[09:00:21.979] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:375:0)
[09:00:21.980] Timer tick, asking Buildbucket for the build status
[09:00:22.079] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:22.079] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:376:0) after 1m0s
[09:01:22.196] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:376:0)
[09:01:22.196] Timer tick, asking Buildbucket for the build status
[09:01:22.386] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:22.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:377:0) after 1m0s
[09:02:22.431] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:377:0)
[09:02:22.431] Timer tick, asking Buildbucket for the build status
[09:02:22.519] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:22.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:378:0) after 1m0s
[09:03:23.012] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:378:0)
[09:03:23.012] Timer tick, asking Buildbucket for the build status
[09:03:23.209] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:23.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:379:0) after 1m0s
[09:04:23.250] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:379:0)
[09:04:23.250] Timer tick, asking Buildbucket for the build status
[09:04:23.622] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:23.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:380:0) after 1m0s
[09:05:23.709] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:380:0)
[09:05:23.709] Timer tick, asking Buildbucket for the build status
[09:05:23.802] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:23.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:381:0) after 1m0s
[09:06:24.239] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:381:0)
[09:06:24.239] Timer tick, asking Buildbucket for the build status
[09:06:24.317] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:24.317] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:382:0) after 1m0s
[09:07:24.706] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:382:0)
[09:07:24.706] Timer tick, asking Buildbucket for the build status
[09:07:24.761] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:24.761] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:383:0) after 1m0s
[09:08:25.453] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:383:0)
[09:08:25.453] Timer tick, asking Buildbucket for the build status
[09:08:25.591] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:25.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:384:0) after 1m0s
[09:09:26.204] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:384:0)
[09:09:26.204] Timer tick, asking Buildbucket for the build status
[09:09:26.305] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:26.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:385:0) after 1m0s
[09:10:26.563] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:385:0)
[09:10:26.563] Timer tick, asking Buildbucket for the build status
[09:10:26.746] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:26.746] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:386:0) after 1m0s
[09:11:27.189] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:386:0)
[09:11:27.189] Timer tick, asking Buildbucket for the build status
[09:11:27.338] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:27.338] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:387:0) after 1m0s
[09:12:27.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:387:0)
[09:12:27.491] Timer tick, asking Buildbucket for the build status
[09:12:27.554] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:27.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:388:0) after 1m0s
[09:13:28.033] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:388:0)
[09:13:28.033] Timer tick, asking Buildbucket for the build status
[09:13:28.206] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:28.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:389:0) after 1m0s
[09:14:28.734] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:389:0)
[09:14:28.734] Timer tick, asking Buildbucket for the build status
[09:14:28.800] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:28.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:390:0) after 1m0s
[09:15:28.853] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:390:0)
[09:15:28.853] Timer tick, asking Buildbucket for the build status
[09:15:28.975] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:28.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:391:0) after 1m0s
[09:16:29.009] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:391:0)
[09:16:29.009] Timer tick, asking Buildbucket for the build status
[09:16:29.126] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:29.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:392:0) after 1m0s
[09:17:29.156] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:392:0)
[09:17:29.156] Timer tick, asking Buildbucket for the build status
[09:17:29.251] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:29.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:393:0) after 1m0s
[09:18:29.290] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:393:0)
[09:18:29.290] Timer tick, asking Buildbucket for the build status
[09:18:29.377] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:29.377] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:394:0) after 1m0s
[09:19:29.945] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:394:0)
[09:19:29.945] Timer tick, asking Buildbucket for the build status
[09:19:30.065] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:30.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:395:0) after 1m0s
[09:20:30.401] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:395:0)
[09:20:30.401] Timer tick, asking Buildbucket for the build status
[09:20:30.517] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:30.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:396:0) after 1m0s
[09:21:31.052] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:396:0)
[09:21:31.052] Timer tick, asking Buildbucket for the build status
[09:21:31.112] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:31.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:397:0) after 1m0s
[09:22:31.180] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:397:0)
[09:22:31.180] Timer tick, asking Buildbucket for the build status
[09:22:31.325] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:31.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:398:0) after 1m0s
[09:23:31.404] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:398:0)
[09:23:31.404] Timer tick, asking Buildbucket for the build status
[09:23:31.490] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:31.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:399:0) after 1m0s
[09:24:31.585] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:399:0)
[09:24:31.585] Timer tick, asking Buildbucket for the build status
[09:24:31.681] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:31.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:400:0) after 1m0s
[09:25:31.920] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:400:0)
[09:25:31.920] Timer tick, asking Buildbucket for the build status
[09:25:32.105] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:32.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:401:0) after 1m0s
[09:26:33.084] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:401:0)
[09:26:33.084] Timer tick, asking Buildbucket for the build status
[09:26:33.152] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:33.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:402:0) after 1m0s
[09:27:33.333] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:402:0)
[09:27:33.333] Timer tick, asking Buildbucket for the build status
[09:27:33.379] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:33.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:403:0) after 1m0s
[09:28:33.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:403:0)
[09:28:33.932] Timer tick, asking Buildbucket for the build status
[09:28:34.068] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:34.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:404:0) after 1m0s
[09:29:34.995] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:404:0)
[09:29:34.995] Timer tick, asking Buildbucket for the build status
[09:29:35.082] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:35.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:405:0) after 1m0s
[09:30:35.118] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:405:0)
[09:30:35.118] Timer tick, asking Buildbucket for the build status
[09:30:35.178] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:35.178] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:406:0) after 1m0s
[09:31:35.228] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:406:0)
[09:31:35.228] Timer tick, asking Buildbucket for the build status
[09:31:35.313] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:35.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:407:0) after 1m0s
[09:32:35.355] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:407:0)
[09:32:35.355] Timer tick, asking Buildbucket for the build status
[09:32:35.422] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:35.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:408:0) after 1m0s
[09:33:35.464] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:408:0)
[09:33:35.464] Timer tick, asking Buildbucket for the build status
[09:33:35.535] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:35.535] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:409:0) after 1m0s
[09:34:35.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:409:0)
[09:34:35.616] Timer tick, asking Buildbucket for the build status
[09:34:35.667] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:35.667] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:410:0) after 1m0s
[09:35:35.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:410:0)
[09:35:35.701] Timer tick, asking Buildbucket for the build status
[09:35:35.787] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
--- the log has been cut here ---
[10:41:11.178] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:475:0)
[10:41:11.178] Timer tick, asking Buildbucket for the build status
[10:41:11.315] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:11.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:476:0) after 1m0s
[10:42:11.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:476:0)
[10:42:11.459] Timer tick, asking Buildbucket for the build status
[10:42:11.503] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:11.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:477:0) after 1m0s
[10:43:11.611] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:477:0)
[10:43:11.611] Timer tick, asking Buildbucket for the build status
[10:43:11.786] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:11.786] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:478:0) after 1m0s
[10:44:11.829] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:478:0)
[10:44:11.829] Timer tick, asking Buildbucket for the build status
[10:44:11.940] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:11.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:479:0) after 1m0s
[10:45:12.021] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:479:0)
[10:45:12.021] Timer tick, asking Buildbucket for the build status
[10:45:12.291] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:12.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:480:0) after 1m0s
[10:46:12.407] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:480:0)
[10:46:12.407] Timer tick, asking Buildbucket for the build status
[10:46:12.482] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:12.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:481:0) after 1m0s
[10:47:13.064] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:481:0)
[10:47:13.064] Timer tick, asking Buildbucket for the build status
[10:47:13.162] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:13.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:482:0) after 1m0s
[10:48:13.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:482:0)
--- the log has been cut here ---
[10:59:16.317] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:493:0)
[10:59:16.317] Timer tick, asking Buildbucket for the build status
[10:59:16.407] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:16.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:494:0) after 1m0s
[11:00:16.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:494:0)
[11:00:16.894] Timer tick, asking Buildbucket for the build status
[11:00:17.028] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:17.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:495:0) after 1m0s
[11:01:17.456] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:495:0)
[11:01:17.456] Timer tick, asking Buildbucket for the build status
[11:01:17.505] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:17.505] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:496:0) after 1m0s
[11:02:17.853] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:496:0)
[11:02:17.853] Timer tick, asking Buildbucket for the build status
[11:02:17.942] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:17.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:497:0) after 1m0s
[11:03:18.068] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:497:0)
[11:03:18.068] Timer tick, asking Buildbucket for the build status
[11:03:18.244] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:18.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:498:0) after 1m0s
[11:04:18.277] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:498:0)
[11:04:18.277] Timer tick, asking Buildbucket for the build status
[11:04:18.380] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:18.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:499:0) after 1m0s
[11:05:19.200] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:499:0)
[11:05:19.200] Timer tick, asking Buildbucket for the build status
[11:05:19.395] Build 8929193295622443648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:19.395] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9094623357883925904:500:0) after 1m0s
[11:05:22.399] Received PubSub notification, asking Buildbucket for the build status
[11:05:22.464] Build 8929193295622443648: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[11:05:22.464] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1542884721545660",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1542854709945122",
    "experimental": true,
    "failure_reason": "INFRA_FAILURE",
    "id": "8929193295622443648",
    "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\": \"f701a90597fc85979319447c0cd44c3b52201c78\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3874-22d9c44\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-west1-c-0g9c\"], \"pool\": [\"luci.nacl.toolchain\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1542873894823634",
    "status": "COMPLETED",
    "status_changed_ts": "1542884722107754",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_64/10",
      "builder:linux-pnacl-x86_64-tests-x86_64",
      "buildset:commit/git/f701a90597fc85979319447c0cd44c3b52201c78",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f701a90597fc85979319447c0cd44c3b52201c78",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9094623357883925904",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_64",
      "swarming_dimension:caches:builder_bf14184df246ade0cf783e61825966ff5c624694bcccef3edd9032289b04d52b_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/10",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8929193295622443648",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:586d78b1df9b356be85f0824ec8364d9ecbabf90",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-x86_64",
      "swarming_tag:buildset:commit/git/f701a90597fc85979319447c0cd44c3b52201c78",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f701a90597fc85979319447c0cd44c3b52201c78",
      "swarming_tag:caches:builder_bf14184df246ade0cf783e61825966ff5c624694bcccef3edd9032289b04d52b_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/8929193295622443648/+/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:9094623357883925904",
      "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:5b53a70aa8482a54ee03de11951e8067cb630a16",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4152201f57e44610",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1542884722108892",
    "url": "https://ci.chromium.org/b/8929193295622443648",
    "utcnow_ts": "1542884722444038"
  }
}
[11:05:22.465] Invocation finished in 8h20m14.060081004s with status FAILED