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

Status: FAILED

Triggered by: -

Duration: 6 hours

Actions:

Definition (rev 1c82d86159c2071b02a7ddf08ffd2ae0bff92186)

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

Incoming triggers

db355f48151995834fbdddd464fc00b8ad265132 (6 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[00:32:46.938] New invocation is queued and will start shortly
[00:32:48.249] Starting the invocation (attempt 1)
[00:32:48.283] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:32:48.283] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:32:48.283] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9089467658048407376",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-x86_32\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"db355f48151995834fbdddd464fc00b8ad265132\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-pnacl-x86_64-tests-x86_32",
    "scheduler_invocation_id:9089467658048407376",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
    "user_agent:luci-scheduler",
    "buildset:commit/git/db355f48151995834fbdddd464fc00b8ad265132",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/db355f48151995834fbdddd464fc00b8ad265132",
    "gitiles_ref:refs/heads/master"
  ]
}
[00:32:49.561] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary": true,
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1547771568401299",
    "id": "8924037595850944096",
    "lease_expiration_ts": "1547922769277164",
    "lease_key": "2028597171",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_32\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"db355f48151995834fbdddd464fc00b8ad265132\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1547771569446224",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/5111",
      "builder:linux-pnacl-x86_64-tests-x86_32",
      "buildset:commit/git/db355f48151995834fbdddd464fc00b8ad265132",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/db355f48151995834fbdddd464fc00b8ad265132",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9089467658048407376",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_dimension:caches:builder_d982c0762990b9abf737d190051a0a3bd67b51c14564e55713aea0114e04ab24_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/5111",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8924037595850944096",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-x86_32",
      "swarming_tag:buildset:commit/git/db355f48151995834fbdddd464fc00b8ad265132",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/db355f48151995834fbdddd464fc00b8ad265132",
      "swarming_tag:caches:builder_d982c0762990b9abf737d190051a0a3bd67b51c14564e55713aea0114e04ab24_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8924037595850944096/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9089467658048407376",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:7bd44c5698750454da45e03e17f93c16ef58f23d",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4277316af2d17410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1547771569446330",
    "url": "https://ci.chromium.org/b/8924037595850944096",
    "utcnow_ts": "1547771569549444"
  }
}
[00:32:49.561] Task URL: https://ci.chromium.org/b/8924037595850944096
[00:32:49.561] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:2:0) after 1m0s
[00:33:49.620] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:2:0)
[00:33:49.620] Timer tick, asking Buildbucket for the build status
[00:33:49.831] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:49.831] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:3:0) after 1m0s
[00:34:50.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:3:0)
[00:34:50.149] Timer tick, asking Buildbucket for the build status
[00:34:50.196] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:50.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:4:0) after 1m0s
[00:35:50.281] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:4:0)
[00:35:50.281] Timer tick, asking Buildbucket for the build status
[00:35:50.355] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:50.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:5:0) after 1m0s
[00:36:50.372] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:5:0)
[00:36:50.372] Timer tick, asking Buildbucket for the build status
[00:36:50.447] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:50.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:6:0) after 1m0s
[00:37:50.492] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:6:0)
[00:37:50.492] Timer tick, asking Buildbucket for the build status
[00:37:50.566] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:50.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:7:0) after 1m0s
[00:38:50.598] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:7:0)
[00:38:50.598] Timer tick, asking Buildbucket for the build status
[00:38:50.691] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:50.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:8:0) after 1m0s
[00:39:50.710] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:8:0)
[00:39:50.710] Timer tick, asking Buildbucket for the build status
[00:39:50.881] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:50.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:9:0) after 1m0s
[00:40:50.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:9:0)
[00:40:50.900] Timer tick, asking Buildbucket for the build status
[00:40:51.031] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:51.031] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:10:0) after 1m0s
[00:41:51.056] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:10:0)
[00:41:51.056] Timer tick, asking Buildbucket for the build status
[00:41:51.107] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:51.108] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:11:0) after 1m0s
[00:42:51.126] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:11:0)
[00:42:51.126] Timer tick, asking Buildbucket for the build status
[00:42:51.175] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:51.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:12:0) after 1m0s
[00:43:51.193] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:12:0)
[00:43:51.193] Timer tick, asking Buildbucket for the build status
[00:43:51.234] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:51.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:13:0) after 1m0s
[00:44:51.253] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:13:0)
[00:44:51.253] Timer tick, asking Buildbucket for the build status
[00:44:51.447] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:51.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:14:0) after 1m0s
[00:45:51.515] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:14:0)
[00:45:51.515] Timer tick, asking Buildbucket for the build status
[00:45:51.562] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:51.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:15:0) after 1m0s
[00:46:51.598] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:15:0)
[00:46:51.598] Timer tick, asking Buildbucket for the build status
[00:46:51.734] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:51.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:16:0) after 1m0s
[00:47:51.762] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:16:0)
[00:47:51.762] Timer tick, asking Buildbucket for the build status
[00:47:51.828] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:51.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:17:0) after 1m0s
[00:48:51.848] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:17:0)
[00:48:51.848] Timer tick, asking Buildbucket for the build status
[00:48:51.924] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:51.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:18:0) after 1m0s
[00:49:51.944] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:18:0)
[00:49:51.944] Timer tick, asking Buildbucket for the build status
[00:49:52.005] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:52.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:19:0) after 1m0s
[00:50:52.027] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:19:0)
[00:50:52.027] Timer tick, asking Buildbucket for the build status
[00:50:52.078] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:52.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:20:0) after 1m0s
[00:51:52.109] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:20:0)
[00:51:52.109] Timer tick, asking Buildbucket for the build status
[00:51:52.248] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:52.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:21:0) after 1m0s
[00:52:52.277] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:21:0)
[00:52:52.277] Timer tick, asking Buildbucket for the build status
[00:52:52.410] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:52.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:22:0) after 1m0s
[00:53:52.426] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:22:0)
[00:53:52.426] Timer tick, asking Buildbucket for the build status
[00:53:52.508] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:52.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:23:0) after 1m0s
[00:54:52.528] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:23:0)
[00:54:52.528] Timer tick, asking Buildbucket for the build status
[00:54:52.635] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:52.635] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:24:0) after 1m0s
[00:55:52.653] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:24:0)
[00:55:52.653] Timer tick, asking Buildbucket for the build status
[00:55:52.792] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:52.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:25:0) after 1m0s
[00:56:52.851] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:25:0)
[00:56:52.851] Timer tick, asking Buildbucket for the build status
[00:56:52.938] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:52.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:26:0) after 1m0s
[00:57:52.956] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:26:0)
[00:57:52.956] Timer tick, asking Buildbucket for the build status
[00:57:53.026] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:53.026] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:27:0) after 1m0s
[00:58:53.043] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:27:0)
[00:58:53.043] Timer tick, asking Buildbucket for the build status
[00:58:53.076] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:53.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:28:0) after 1m0s
[00:59:53.108] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:28:0)
[00:59:53.108] Timer tick, asking Buildbucket for the build status
[00:59:53.166] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:53.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:29:0) after 1m0s
[01:00:53.187] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:29:0)
[01:00:53.187] Timer tick, asking Buildbucket for the build status
[01:00:53.234] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:53.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:30:0) after 1m0s
[01:01:53.252] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:30:0)
[01:01:53.252] Timer tick, asking Buildbucket for the build status
[01:01:53.355] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:53.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:31:0) after 1m0s
[01:02:53.375] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:31:0)
[01:02:53.375] Timer tick, asking Buildbucket for the build status
[01:02:53.465] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:53.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:32:0) after 1m0s
[01:03:53.530] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:32:0)
[01:03:53.531] Timer tick, asking Buildbucket for the build status
[01:03:53.772] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:53.772] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:33:0) after 1m0s
[01:04:53.789] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:33:0)
[01:04:53.789] Timer tick, asking Buildbucket for the build status
[01:04:53.851] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:53.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:34:0) after 1m0s
[01:05:53.866] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:34:0)
[01:05:53.866] Timer tick, asking Buildbucket for the build status
[01:05:53.924] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:53.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:35:0) after 1m0s
[01:06:53.942] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:35:0)
[01:06:53.942] Timer tick, asking Buildbucket for the build status
[01:06:53.993] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:53.993] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:36:0) after 1m0s
[01:07:54.004] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:36:0)
[01:07:54.004] Timer tick, asking Buildbucket for the build status
[01:07:54.057] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:54.057] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:37:0) after 1m0s
[01:08:54.077] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:37:0)
[01:08:54.077] Timer tick, asking Buildbucket for the build status
[01:08:54.152] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:54.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:38:0) after 1m0s
[01:09:54.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:38:0)
[01:09:54.207] Timer tick, asking Buildbucket for the build status
[01:09:55.657] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:55.657] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:39:0) after 1m0s
[01:10:55.684] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:39:0)
[01:10:55.684] Timer tick, asking Buildbucket for the build status
[01:10:55.729] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:55.730] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:40:0) after 1m0s
[01:11:55.746] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:40:0)
[01:11:55.746] Timer tick, asking Buildbucket for the build status
[01:11:55.775] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:55.775] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:41:0) after 1m0s
[01:12:55.795] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:41:0)
[01:12:55.795] Timer tick, asking Buildbucket for the build status
[01:12:55.854] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:55.854] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:42:0) after 1m0s
[01:13:55.875] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:42:0)
[01:13:55.875] Timer tick, asking Buildbucket for the build status
[01:13:55.929] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:55.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:43:0) after 1m0s
[01:14:55.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:43:0)
[01:14:55.969] Timer tick, asking Buildbucket for the build status
[01:14:56.136] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:56.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:44:0) after 1m0s
[01:15:56.159] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:44:0)
[01:15:56.159] Timer tick, asking Buildbucket for the build status
[01:15:56.334] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:56.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:45:0) after 1m0s
[01:16:56.358] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:45:0)
[01:16:56.358] Timer tick, asking Buildbucket for the build status
[01:16:56.419] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:56.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:46:0) after 1m0s
[01:17:56.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:46:0)
[01:17:56.438] Timer tick, asking Buildbucket for the build status
[01:17:56.537] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:56.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:47:0) after 1m0s
[01:18:56.601] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:47:0)
[01:18:56.601] Timer tick, asking Buildbucket for the build status
[01:18:56.641] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:56.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:48:0) after 1m0s
[01:19:56.674] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:48:0)
[01:19:56.674] Timer tick, asking Buildbucket for the build status
[01:19:56.758] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:56.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:49:0) after 1m0s
[01:20:56.778] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:49:0)
[01:20:56.778] Timer tick, asking Buildbucket for the build status
[01:20:56.816] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:56.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:50:0) after 1m0s
[01:21:56.835] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:50:0)
[01:21:56.835] Timer tick, asking Buildbucket for the build status
[01:21:56.903] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:56.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:51:0) after 1m0s
[01:22:56.923] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:51:0)
[01:22:56.923] Timer tick, asking Buildbucket for the build status
[01:22:56.991] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:56.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:52:0) after 1m0s
[01:23:57.012] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:52:0)
[01:23:57.012] Timer tick, asking Buildbucket for the build status
[01:23:57.098] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:57.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:53:0) after 1m0s
[01:24:57.125] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:53:0)
[01:24:57.125] Timer tick, asking Buildbucket for the build status
[01:24:57.223] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:57.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:54:0) after 1m0s
[01:25:57.247] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:54:0)
[01:25:57.247] Timer tick, asking Buildbucket for the build status
[01:25:57.299] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:57.299] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:55:0) after 1m0s
[01:26:57.320] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:55:0)
[01:26:57.320] Timer tick, asking Buildbucket for the build status
[01:26:57.352] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:57.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:56:0) after 1m0s
[01:27:57.371] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:56:0)
[01:27:57.371] Timer tick, asking Buildbucket for the build status
[01:27:57.480] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:57.480] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:57:0) after 1m0s
[01:28:57.527] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:57:0)
[01:28:57.527] Timer tick, asking Buildbucket for the build status
[01:28:57.631] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:57.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:58:0) after 1m0s
[01:29:57.651] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:58:0)
[01:29:57.651] Timer tick, asking Buildbucket for the build status
[01:29:57.690] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:57.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:59:0) after 1m0s
[01:30:57.711] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:59:0)
[01:30:57.711] Timer tick, asking Buildbucket for the build status
[01:30:57.823] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:57.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:60:0) after 1m0s
[01:31:57.841] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:60:0)
[01:31:57.841] Timer tick, asking Buildbucket for the build status
[01:31:57.874] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:57.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:61:0) after 1m0s
[01:32:57.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:61:0)
[01:32:57.900] Timer tick, asking Buildbucket for the build status
[01:32:58.117] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:58.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:62:0) after 1m0s
[01:33:58.138] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:62:0)
[01:33:58.138] Timer tick, asking Buildbucket for the build status
[01:33:58.183] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:58.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:63:0) after 1m0s
[01:34:58.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:63:0)
[01:34:58.207] Timer tick, asking Buildbucket for the build status
[01:34:58.272] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:58.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:64:0) after 1m0s
[01:35:58.314] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:64:0)
[01:35:58.314] Timer tick, asking Buildbucket for the build status
[01:35:58.361] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:58.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:65:0) after 1m0s
[01:36:58.383] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:65:0)
[01:36:58.383] Timer tick, asking Buildbucket for the build status
[01:36:58.462] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:58.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:66:0) after 1m0s
[01:37:58.482] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:66:0)
[01:37:58.482] Timer tick, asking Buildbucket for the build status
[01:37:58.520] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:58.520] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:67:0) after 1m0s
[01:38:58.542] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:67:0)
[01:38:58.543] Timer tick, asking Buildbucket for the build status
[01:38:58.592] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:58.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:68:0) after 1m0s
[01:39:58.620] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:68:0)
[01:39:58.620] Timer tick, asking Buildbucket for the build status
[01:39:58.689] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:58.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:69:0) after 1m0s
[01:40:58.767] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:69:0)
[01:40:58.767] Timer tick, asking Buildbucket for the build status
[01:40:59.022] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:59.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:70:0) after 1m0s
[01:41:59.052] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:70:0)
[01:41:59.052] Timer tick, asking Buildbucket for the build status
[01:41:59.122] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:59.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:71:0) after 1m0s
[01:42:59.160] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:71:0)
[01:42:59.160] Timer tick, asking Buildbucket for the build status
[01:42:59.347] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:59.347] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:72:0) after 1m0s
[01:43:59.402] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:72:0)
[01:43:59.402] Timer tick, asking Buildbucket for the build status
[01:43:59.716] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:59.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:73:0) after 1m0s
[01:44:59.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:73:0)
[01:44:59.735] Timer tick, asking Buildbucket for the build status
[01:44:59.803] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:59.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:74:0) after 1m0s
[01:45:59.823] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:74:0)
[01:45:59.823] Timer tick, asking Buildbucket for the build status
[01:45:59.858] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:59.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:75:0) after 1m0s
[01:46:59.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:75:0)
[01:46:59.878] Timer tick, asking Buildbucket for the build status
[01:46:59.937] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:59.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:76:0) after 1m0s
[01:47:59.955] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:76:0)
[01:47:59.955] Timer tick, asking Buildbucket for the build status
[01:48:00.019] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:00.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:77:0) after 1m0s
[01:49:00.039] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:77:0)
[01:49:00.039] Timer tick, asking Buildbucket for the build status
[01:49:00.146] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:00.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:78:0) after 1m0s
[01:50:00.206] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:78:0)
[01:50:00.206] Timer tick, asking Buildbucket for the build status
[01:50:00.256] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:00.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:79:0) after 1m0s
[01:51:00.275] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:79:0)
[01:51:00.275] Timer tick, asking Buildbucket for the build status
[01:51:00.330] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:00.330] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:80:0) after 1m0s
[01:52:00.349] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:80:0)
[01:52:00.349] Timer tick, asking Buildbucket for the build status
[01:52:00.391] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:00.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:81:0) after 1m0s
[01:53:00.476] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:81:0)
[01:53:00.476] Timer tick, asking Buildbucket for the build status
[01:53:00.635] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:00.635] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:82:0) after 1m0s
[01:54:00.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:82:0)
[01:54:00.663] Timer tick, asking Buildbucket for the build status
[01:54:00.749] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:00.749] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:83:0) after 1m0s
[01:55:00.769] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:83:0)
[01:55:00.769] Timer tick, asking Buildbucket for the build status
[01:55:00.827] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:00.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:84:0) after 1m0s
[01:56:00.886] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:84:0)
[01:56:00.886] Timer tick, asking Buildbucket for the build status
[01:56:01.020] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:01.020] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:85:0) after 1m0s
[01:57:01.054] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:85:0)
[01:57:01.054] Timer tick, asking Buildbucket for the build status
[01:57:01.148] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:01.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:86:0) after 1m0s
[01:58:01.252] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:86:0)
[01:58:01.252] Timer tick, asking Buildbucket for the build status
[01:58:01.324] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:01.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:87:0) after 1m0s
[01:59:01.342] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:87:0)
[01:59:01.342] Timer tick, asking Buildbucket for the build status
[01:59:01.429] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:01.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:88:0) after 1m0s
[02:00:01.545] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:88:0)
[02:00:01.545] Timer tick, asking Buildbucket for the build status
[02:00:01.848] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:01.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:89:0) after 1m0s
[02:01:01.868] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:89:0)
[02:01:01.868] Timer tick, asking Buildbucket for the build status
[02:01:01.905] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:01.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:90:0) after 1m0s
[02:02:01.925] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:90:0)
[02:02:01.925] Timer tick, asking Buildbucket for the build status
[02:02:01.959] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:01.959] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:91:0) after 1m0s
[02:03:02.068] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:91:0)
[02:03:02.068] Timer tick, asking Buildbucket for the build status
[02:03:02.201] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:02.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:92:0) after 1m0s
[02:04:02.220] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:92:0)
[02:04:02.220] Timer tick, asking Buildbucket for the build status
[02:04:02.370] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:02.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:93:0) after 1m0s
[02:05:02.395] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:93:0)
[02:05:02.395] Timer tick, asking Buildbucket for the build status
[02:05:02.507] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:02.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:94:0) after 1m0s
[02:06:02.531] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:94:0)
[02:06:02.531] Timer tick, asking Buildbucket for the build status
[02:06:02.648] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:02.648] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:95:0) after 1m0s
[02:07:02.761] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:95:0)
[02:07:02.761] Timer tick, asking Buildbucket for the build status
[02:07:02.828] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:02.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:96:0) after 1m0s
[02:08:02.923] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:96:0)
[02:08:02.923] Timer tick, asking Buildbucket for the build status
[02:08:02.998] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:02.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:97:0) after 1m0s
[02:09:03.089] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:97:0)
[02:09:03.089] Timer tick, asking Buildbucket for the build status
[02:09:03.122] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:03.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:98:0) after 1m0s
[02:10:03.159] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:98:0)
[02:10:03.159] Timer tick, asking Buildbucket for the build status
[02:10:03.290] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:03.290] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:99:0) after 1m0s
[02:11:03.310] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:99:0)
[02:11:03.310] Timer tick, asking Buildbucket for the build status
[02:11:03.376] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:03.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:100:0) after 1m0s
[02:12:03.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:100:0)
[02:12:03.396] Timer tick, asking Buildbucket for the build status
[02:12:03.450] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:03.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:101:0) after 1m0s
[02:13:03.472] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:101:0)
[02:13:03.472] Timer tick, asking Buildbucket for the build status
[02:13:03.515] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:03.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:102:0) after 1m0s
[02:14:03.571] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:102:0)
[02:14:03.571] Timer tick, asking Buildbucket for the build status
[02:14:03.616] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:03.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:103:0) after 1m0s
[02:15:03.641] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:103:0)
[02:15:03.641] Timer tick, asking Buildbucket for the build status
[02:15:03.683] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:03.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:104:0) after 1m0s
[02:16:03.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:104:0)
[02:16:03.701] Timer tick, asking Buildbucket for the build status
[02:16:03.762] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:03.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:105:0) after 1m0s
[02:17:03.782] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:105:0)
[02:17:03.782] Timer tick, asking Buildbucket for the build status
[02:17:03.818] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:03.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:106:0) after 1m0s
[02:18:03.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:106:0)
[02:18:03.844] Timer tick, asking Buildbucket for the build status
[02:18:03.909] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:03.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:107:0) after 1m0s
[02:19:03.930] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:107:0)
[02:19:03.930] Timer tick, asking Buildbucket for the build status
[02:19:03.969] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:03.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:108:0) after 1m0s
[02:20:04.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:108:0)
[02:20:04.001] Timer tick, asking Buildbucket for the build status
[02:20:04.097] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:04.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:109:0) after 1m0s
[02:21:04.131] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:109:0)
[02:21:04.131] Timer tick, asking Buildbucket for the build status
[02:21:04.176] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:04.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:110:0) after 1m0s
[02:22:04.210] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:110:0)
[02:22:04.210] Timer tick, asking Buildbucket for the build status
[02:22:04.310] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:04.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:111:0) after 1m0s
[02:23:04.329] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:111:0)
[02:23:04.329] Timer tick, asking Buildbucket for the build status
[02:23:04.448] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:04.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:112:0) after 1m0s
[02:24:04.490] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:112:0)
[02:24:04.490] Timer tick, asking Buildbucket for the build status
[02:24:04.539] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:04.539] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:113:0) after 1m0s
[02:25:04.564] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:113:0)
[02:25:04.564] Timer tick, asking Buildbucket for the build status
[02:25:04.629] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:04.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:114:0) after 1m0s
[02:26:04.676] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:114:0)
[02:26:04.676] Timer tick, asking Buildbucket for the build status
[02:26:04.729] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:04.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:115:0) after 1m0s
[02:27:04.761] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:115:0)
[02:27:04.761] Timer tick, asking Buildbucket for the build status
[02:27:04.839] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:04.839] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:116:0) after 1m0s
[02:28:04.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:116:0)
[02:28:04.894] Timer tick, asking Buildbucket for the build status
[02:28:05.155] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:05.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:117:0) after 1m0s
[02:29:05.175] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:117:0)
[02:29:05.175] Timer tick, asking Buildbucket for the build status
[02:29:05.209] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:05.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:118:0) after 1m0s
[02:30:05.275] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:118:0)
[02:30:05.275] Timer tick, asking Buildbucket for the build status
[02:30:05.440] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:05.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:119:0) after 1m0s
[02:31:05.464] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:119:0)
[02:31:05.464] Timer tick, asking Buildbucket for the build status
[02:31:05.498] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:05.498] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:120:0) after 1m0s
[02:32:05.525] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:120:0)
[02:32:05.525] Timer tick, asking Buildbucket for the build status
[02:32:05.567] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:05.567] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:121:0) after 1m0s
[02:33:05.590] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:121:0)
[02:33:05.590] Timer tick, asking Buildbucket for the build status
[02:33:05.765] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:05.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:122:0) after 1m0s
[02:34:05.797] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:122:0)
[02:34:05.797] Timer tick, asking Buildbucket for the build status
[02:34:05.855] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:05.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:123:0) after 1m0s
[02:35:05.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:123:0)
[02:35:05.878] Timer tick, asking Buildbucket for the build status
[02:35:05.910] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:05.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:124:0) after 1m0s
[02:36:05.941] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:124:0)
[02:36:05.941] Timer tick, asking Buildbucket for the build status
[02:36:05.980] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:05.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:125:0) after 1m0s
[02:37:06.024] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:125:0)
[02:37:06.024] Timer tick, asking Buildbucket for the build status
[02:37:06.105] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:06.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:126:0) after 1m0s
[02:38:06.125] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:126:0)
[02:38:06.125] Timer tick, asking Buildbucket for the build status
[02:38:06.158] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:06.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:127:0) after 1m0s
[02:39:06.189] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:127:0)
[02:39:06.189] Timer tick, asking Buildbucket for the build status
[02:39:06.269] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:06.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:128:0) after 1m0s
[02:40:06.290] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:128:0)
[02:40:06.290] Timer tick, asking Buildbucket for the build status
[02:40:06.355] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:06.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:129:0) after 1m0s
[02:41:06.391] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:129:0)
[02:41:06.391] Timer tick, asking Buildbucket for the build status
[02:41:06.462] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:06.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:130:0) after 1m0s
[02:42:06.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:130:0)
[02:42:06.497] Timer tick, asking Buildbucket for the build status
[02:42:06.620] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:06.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:131:0) after 1m0s
[02:43:06.668] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:131:0)
[02:43:06.668] Timer tick, asking Buildbucket for the build status
[02:43:06.707] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:06.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:132:0) after 1m0s
[02:44:06.746] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:132:0)
[02:44:06.746] Timer tick, asking Buildbucket for the build status
[02:44:06.846] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:06.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:133:0) after 1m0s
[02:45:06.869] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:133:0)
[02:45:06.869] Timer tick, asking Buildbucket for the build status
[02:45:06.924] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:06.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:134:0) after 1m0s
[02:46:06.947] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:134:0)
[02:46:06.947] Timer tick, asking Buildbucket for the build status
[02:46:06.986] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:06.986] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:135:0) after 1m0s
[02:47:07.004] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:135:0)
[02:47:07.004] Timer tick, asking Buildbucket for the build status
[02:47:07.083] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:07.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:136:0) after 1m0s
[02:48:07.107] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:136:0)
[02:48:07.107] Timer tick, asking Buildbucket for the build status
[02:48:07.251] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:07.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:137:0) after 1m0s
[02:49:07.285] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:137:0)
[02:49:07.285] Timer tick, asking Buildbucket for the build status
[02:49:07.361] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:07.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:138:0) after 1m0s
[02:50:07.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:138:0)
[02:50:07.394] Timer tick, asking Buildbucket for the build status
[02:50:07.465] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:07.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:139:0) after 1m0s
[02:51:07.519] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:139:0)
[02:51:07.519] Timer tick, asking Buildbucket for the build status
[02:51:07.702] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:07.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:140:0) after 1m0s
[02:52:07.744] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:140:0)
[02:52:07.744] Timer tick, asking Buildbucket for the build status
[02:52:07.797] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:07.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:141:0) after 1m0s
[02:53:07.860] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:141:0)
[02:53:07.860] Timer tick, asking Buildbucket for the build status
[02:53:08.037] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:08.037] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:142:0) after 1m0s
[02:54:08.058] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:142:0)
[02:54:08.059] Timer tick, asking Buildbucket for the build status
[02:54:08.125] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:08.125] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:143:0) after 1m0s
[02:55:08.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:143:0)
[02:55:08.147] Timer tick, asking Buildbucket for the build status
[02:55:08.306] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:08.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:144:0) after 1m0s
[02:56:08.349] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:144:0)
[02:56:08.349] Timer tick, asking Buildbucket for the build status
[02:56:08.392] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:08.392] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:145:0) after 1m0s
[02:57:08.416] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:145:0)
[02:57:08.416] Timer tick, asking Buildbucket for the build status
[02:57:08.544] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:08.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:146:0) after 1m0s
[02:58:08.567] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:146:0)
[02:58:08.567] Timer tick, asking Buildbucket for the build status
[02:58:08.616] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:08.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:147:0) after 1m0s
[02:59:08.637] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:147:0)
[02:59:08.637] Timer tick, asking Buildbucket for the build status
[02:59:08.696] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:08.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:148:0) after 1m0s
[03:00:08.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:148:0)
[03:00:08.755] Timer tick, asking Buildbucket for the build status
[03:00:08.896] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:08.896] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:149:0) after 1m0s
[03:01:08.918] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:149:0)
[03:01:08.918] Timer tick, asking Buildbucket for the build status
[03:01:08.980] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:08.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:150:0) after 1m0s
[03:02:09.015] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:150:0)
[03:02:09.015] Timer tick, asking Buildbucket for the build status
[03:02:09.076] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:09.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:151:0) after 1m0s
[03:03:09.099] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:151:0)
[03:03:09.099] Timer tick, asking Buildbucket for the build status
[03:03:09.209] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:09.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:152:0) after 1m0s
[03:04:09.235] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:152:0)
[03:04:09.235] Timer tick, asking Buildbucket for the build status
[03:04:09.289] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:09.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:153:0) after 1m0s
[03:05:09.320] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:153:0)
[03:05:09.320] Timer tick, asking Buildbucket for the build status
[03:05:09.387] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:09.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:154:0) after 1m0s
[03:06:09.409] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:154:0)
[03:06:09.409] Timer tick, asking Buildbucket for the build status
[03:06:09.457] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:09.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:155:0) after 1m0s
[03:07:09.483] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:155:0)
[03:07:09.483] Timer tick, asking Buildbucket for the build status
[03:07:09.742] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:09.742] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:156:0) after 1m0s
[03:08:09.765] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:156:0)
[03:08:09.765] Timer tick, asking Buildbucket for the build status
[03:08:09.916] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:09.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:157:0) after 1m0s
[03:09:09.941] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:157:0)
[03:09:09.941] Timer tick, asking Buildbucket for the build status
[03:09:10.017] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:10.017] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:158:0) after 1m0s
[03:10:10.053] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:158:0)
[03:10:10.053] Timer tick, asking Buildbucket for the build status
[03:10:10.103] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:10:10.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:159:0) after 1m0s
[03:11:10.172] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:159:0)
[03:11:10.172] Timer tick, asking Buildbucket for the build status
[03:11:10.255] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:10.255] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:160:0) after 1m0s
[03:12:10.277] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:160:0)
[03:12:10.277] Timer tick, asking Buildbucket for the build status
[03:12:10.522] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:10.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:161:0) after 1m0s
[03:13:10.554] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:161:0)
[03:13:10.554] Timer tick, asking Buildbucket for the build status
[03:13:10.627] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:10.627] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:162:0) after 1m0s
[03:14:10.653] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:162:0)
[03:14:10.653] Timer tick, asking Buildbucket for the build status
[03:14:10.704] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:10.704] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:163:0) after 1m0s
[03:15:10.729] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:163:0)
[03:15:10.729] Timer tick, asking Buildbucket for the build status
[03:15:10.797] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:10.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:164:0) after 1m0s
[03:16:10.825] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:164:0)
[03:16:10.825] Timer tick, asking Buildbucket for the build status
[03:16:10.913] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:10.913] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:165:0) after 1m0s
[03:17:10.947] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:165:0)
[03:17:10.947] Timer tick, asking Buildbucket for the build status
[03:17:11.014] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:11.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:166:0) after 1m0s
[03:18:11.038] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:166:0)
[03:18:11.038] Timer tick, asking Buildbucket for the build status
[03:18:11.408] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:11.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:167:0) after 1m0s
[03:19:11.500] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:167:0)
[03:19:11.500] Timer tick, asking Buildbucket for the build status
[03:19:11.585] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:11.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:168:0) after 1m0s
[03:20:11.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:168:0)
[03:20:11.608] Timer tick, asking Buildbucket for the build status
[03:20:11.658] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:11.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:169:0) after 1m0s
[03:21:11.682] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:169:0)
[03:21:11.682] Timer tick, asking Buildbucket for the build status
[03:21:11.730] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:11.730] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:170:0) after 1m0s
[03:22:11.772] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:170:0)
[03:22:11.772] Timer tick, asking Buildbucket for the build status
[03:22:11.892] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:11.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:171:0) after 1m0s
[03:23:11.915] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:171:0)
[03:23:11.915] Timer tick, asking Buildbucket for the build status
[03:23:12.134] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:23:12.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:172:0) after 1m0s
[03:24:12.160] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:172:0)
[03:24:12.160] Timer tick, asking Buildbucket for the build status
[03:24:12.215] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:24:12.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:173:0) after 1m0s
[03:25:12.238] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:173:0)
[03:25:12.238] Timer tick, asking Buildbucket for the build status
[03:25:12.286] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:12.286] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:174:0) after 1m0s
[03:26:12.308] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:174:0)
[03:26:12.308] Timer tick, asking Buildbucket for the build status
[03:26:12.426] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:12.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:175:0) after 1m0s
[03:27:12.471] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:175:0)
[03:27:12.471] Timer tick, asking Buildbucket for the build status
[03:27:12.607] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:27:12.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:176:0) after 1m0s
[03:28:12.630] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:176:0)
[03:28:12.630] Timer tick, asking Buildbucket for the build status
[03:28:12.674] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:28:12.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:177:0) after 1m0s
[03:29:12.696] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:177:0)
[03:29:12.696] Timer tick, asking Buildbucket for the build status
[03:29:12.766] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:12.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:178:0) after 1m0s
[03:30:12.801] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:178:0)
[03:30:12.801] Timer tick, asking Buildbucket for the build status
[03:30:12.853] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:12.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:179:0) after 1m0s
[03:31:12.876] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:179:0)
[03:31:12.876] Timer tick, asking Buildbucket for the build status
[03:31:13.095] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:13.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:180:0) after 1m0s
[03:32:13.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:180:0)
[03:32:13.119] Timer tick, asking Buildbucket for the build status
[03:32:13.228] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:13.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:181:0) after 1m0s
[03:33:13.250] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:181:0)
[03:33:13.250] Timer tick, asking Buildbucket for the build status
[03:33:13.285] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:33:13.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:182:0) after 1m0s
[03:34:13.308] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:182:0)
[03:34:13.308] Timer tick, asking Buildbucket for the build status
[03:34:13.519] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:13.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:183:0) after 1m0s
[03:35:13.611] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:183:0)
[03:35:13.611] Timer tick, asking Buildbucket for the build status
[03:35:13.859] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:13.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:184:0) after 1m0s
[03:36:13.953] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:184:0)
[03:36:13.953] Timer tick, asking Buildbucket for the build status
[03:36:14.082] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:14.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:185:0) after 1m0s
[03:37:14.187] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:185:0)
[03:37:14.187] Timer tick, asking Buildbucket for the build status
[03:37:14.306] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:14.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:186:0) after 1m0s
[03:38:14.366] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:186:0)
[03:38:14.366] Timer tick, asking Buildbucket for the build status
[03:38:14.439] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:14.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:187:0) after 1m0s
[03:39:14.525] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:187:0)
[03:39:14.525] Timer tick, asking Buildbucket for the build status
[03:39:14.612] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:14.613] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:188:0) after 1m0s
[03:40:14.710] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:188:0)
[03:40:14.710] Timer tick, asking Buildbucket for the build status
[03:40:14.794] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:40:14.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:189:0) after 1m0s
[03:41:14.823] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:189:0)
[03:41:14.823] Timer tick, asking Buildbucket for the build status
[03:41:14.888] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:14.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:190:0) after 1m0s
[03:42:14.911] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:190:0)
[03:42:14.911] Timer tick, asking Buildbucket for the build status
[03:42:15.047] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:15.047] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:191:0) after 1m0s
[03:43:15.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:191:0)
[03:43:15.088] Timer tick, asking Buildbucket for the build status
[03:43:15.287] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:15.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:192:0) after 1m0s
[03:44:15.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:192:0)
[03:44:15.318] Timer tick, asking Buildbucket for the build status
[03:44:15.364] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:15.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:193:0) after 1m0s
[03:45:15.389] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:193:0)
[03:45:15.389] Timer tick, asking Buildbucket for the build status
[03:45:15.421] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:15.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:194:0) after 1m0s
[03:46:15.451] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:194:0)
[03:46:15.451] Timer tick, asking Buildbucket for the build status
[03:46:15.484] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:15.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:195:0) after 1m0s
[03:47:15.563] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:195:0)
[03:47:15.563] Timer tick, asking Buildbucket for the build status
[03:47:15.743] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:15.743] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:196:0) after 1m0s
[03:48:15.766] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:196:0)
[03:48:15.767] Timer tick, asking Buildbucket for the build status
[03:48:15.806] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:15.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:197:0) after 1m0s
[03:49:15.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:197:0)
[03:49:15.832] Timer tick, asking Buildbucket for the build status
[03:49:15.910] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:15.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:198:0) after 1m0s
[03:50:15.935] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:198:0)
[03:50:15.935] Timer tick, asking Buildbucket for the build status
[03:50:17.566] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:50:17.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:199:0) after 1m0s
[03:51:17.621] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:199:0)
[03:51:17.621] Timer tick, asking Buildbucket for the build status
[03:51:17.666] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:51:17.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:200:0) after 1m0s
[03:52:17.707] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:200:0)
[03:52:17.707] Timer tick, asking Buildbucket for the build status
[03:52:17.912] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:17.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:201:0) after 1m0s
[03:53:17.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:201:0)
[03:53:17.950] Timer tick, asking Buildbucket for the build status
[03:53:17.981] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:17.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:202:0) after 1m0s
[03:54:18.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:202:0)
[03:54:18.032] Timer tick, asking Buildbucket for the build status
[03:54:18.140] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:18.140] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:203:0) after 1m0s
[03:55:18.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:203:0)
[03:55:18.168] Timer tick, asking Buildbucket for the build status
[03:55:18.217] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:18.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:204:0) after 1m0s
[03:56:18.248] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:204:0)
[03:56:18.248] Timer tick, asking Buildbucket for the build status
[03:56:18.317] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:18.317] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:205:0) after 1m0s
[03:57:18.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:205:0)
[03:57:18.344] Timer tick, asking Buildbucket for the build status
[03:57:18.382] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:18.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:206:0) after 1m0s
[03:58:18.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:206:0)
[03:58:18.414] Timer tick, asking Buildbucket for the build status
[03:58:18.483] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:18.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:207:0) after 1m0s
[03:59:18.508] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:207:0)
[03:59:18.508] Timer tick, asking Buildbucket for the build status
[03:59:18.631] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:59:18.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:208:0) after 1m0s
[04:00:18.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:208:0)
[04:00:18.656] Timer tick, asking Buildbucket for the build status
[04:00:18.827] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:00:18.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:209:0) after 1m0s
[04:01:18.850] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:209:0)
[04:01:18.850] Timer tick, asking Buildbucket for the build status
[04:01:18.903] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:18.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:210:0) after 1m0s
[04:02:18.929] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:210:0)
[04:02:18.929] Timer tick, asking Buildbucket for the build status
[04:02:19.102] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:19.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:211:0) after 1m0s
[04:03:19.124] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:211:0)
[04:03:19.124] Timer tick, asking Buildbucket for the build status
[04:03:19.177] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:19.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:212:0) after 1m0s
[04:04:19.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:212:0)
[04:04:19.207] Timer tick, asking Buildbucket for the build status
[04:04:19.262] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:19.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:213:0) after 1m0s
[04:05:19.291] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:213:0)
[04:05:19.291] Timer tick, asking Buildbucket for the build status
[04:05:19.448] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:19.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:214:0) after 1m0s
[04:06:19.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:214:0)
[04:06:19.473] Timer tick, asking Buildbucket for the build status
[04:06:19.521] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:19.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:215:0) after 1m0s
[04:07:19.636] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:215:0)
[04:07:19.636] Timer tick, asking Buildbucket for the build status
[04:07:19.687] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:19.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:216:0) after 1m0s
[04:08:19.737] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:216:0)
[04:08:19.737] Timer tick, asking Buildbucket for the build status
[04:08:19.807] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:19.807] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:217:0) after 1m0s
[04:09:19.831] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:217:0)
[04:09:19.831] Timer tick, asking Buildbucket for the build status
[04:09:19.906] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:19.906] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:218:0) after 1m0s
[04:10:20.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:218:0)
[04:10:20.032] Timer tick, asking Buildbucket for the build status
[04:10:20.100] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:20.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:219:0) after 1m0s
[04:11:20.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:219:0)
[04:11:20.147] Timer tick, asking Buildbucket for the build status
[04:11:20.324] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:20.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:220:0) after 1m0s
[04:12:20.355] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:220:0)
[04:12:20.355] Timer tick, asking Buildbucket for the build status
[04:12:20.407] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:20.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:221:0) after 1m0s
[04:13:20.433] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:221:0)
[04:13:20.433] Timer tick, asking Buildbucket for the build status
[04:13:20.483] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:20.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:222:0) after 1m0s
[04:14:20.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:222:0)
[04:14:20.556] Timer tick, asking Buildbucket for the build status
[04:14:20.606] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:20.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:223:0) after 1m0s
[04:15:20.647] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:223:0)
[04:15:20.647] Timer tick, asking Buildbucket for the build status
[04:15:20.684] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:20.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:224:0) after 1m0s
[04:16:20.707] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:224:0)
[04:16:20.707] Timer tick, asking Buildbucket for the build status
[04:16:20.768] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:20.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:225:0) after 1m0s
[04:17:20.790] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:225:0)
[04:17:20.790] Timer tick, asking Buildbucket for the build status
[04:17:20.868] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:20.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:226:0) after 1m0s
[04:18:20.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:226:0)
[04:18:20.894] Timer tick, asking Buildbucket for the build status
[04:18:20.932] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:20.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:227:0) after 1m0s
[04:19:20.954] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:227:0)
[04:19:20.954] Timer tick, asking Buildbucket for the build status
[04:19:21.014] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:21.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:228:0) after 1m0s
[04:20:21.039] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:228:0)
[04:20:21.039] Timer tick, asking Buildbucket for the build status
[04:20:21.096] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:21.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:229:0) after 1m0s
[04:21:21.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:229:0)
[04:21:21.119] Timer tick, asking Buildbucket for the build status
[04:21:21.341] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:21.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:230:0) after 1m0s
[04:22:21.382] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:230:0)
[04:22:21.382] Timer tick, asking Buildbucket for the build status
[04:22:21.472] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:21.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:231:0) after 1m0s
[04:23:21.494] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:231:0)
[04:23:21.494] Timer tick, asking Buildbucket for the build status
[04:23:21.543] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:21.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:232:0) after 1m0s
[04:24:21.570] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:232:0)
[04:24:21.570] Timer tick, asking Buildbucket for the build status
[04:24:21.675] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:21.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:233:0) after 1m0s
[04:25:21.702] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:233:0)
[04:25:21.702] Timer tick, asking Buildbucket for the build status
[04:25:21.844] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:21.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:234:0) after 1m0s
[04:26:21.869] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:234:0)
[04:26:21.869] Timer tick, asking Buildbucket for the build status
[04:26:21.936] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:21.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:235:0) after 1m0s
[04:27:22.030] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:235:0)
[04:27:22.030] Timer tick, asking Buildbucket for the build status
[04:27:22.087] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:22.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:236:0) after 1m0s
[04:28:22.118] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:236:0)
[04:28:22.118] Timer tick, asking Buildbucket for the build status
[04:28:22.182] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:22.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:237:0) after 1m0s
[04:29:22.298] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:237:0)
[04:29:22.298] Timer tick, asking Buildbucket for the build status
[04:29:22.335] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:22.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:238:0) after 1m0s
[04:30:22.362] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:238:0)
[04:30:22.362] Timer tick, asking Buildbucket for the build status
[04:30:22.432] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:22.432] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:239:0) after 1m0s
[04:31:22.483] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:239:0)
[04:31:22.483] Timer tick, asking Buildbucket for the build status
[04:31:22.543] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:22.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:240:0) after 1m0s
[04:32:22.573] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:240:0)
[04:32:22.573] Timer tick, asking Buildbucket for the build status
[04:32:22.656] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:22.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:241:0) after 1m0s
[04:33:22.682] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:241:0)
[04:33:22.682] Timer tick, asking Buildbucket for the build status
[04:33:22.804] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:22.804] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:242:0) after 1m0s
[04:34:22.835] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:242:0)
[04:34:22.835] Timer tick, asking Buildbucket for the build status
[04:34:22.879] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:22.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:243:0) after 1m0s
[04:35:22.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:243:0)
[04:35:22.907] Timer tick, asking Buildbucket for the build status
[04:35:23.025] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:23.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:244:0) after 1m0s
[04:36:23.053] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:244:0)
[04:36:23.053] Timer tick, asking Buildbucket for the build status
[04:36:23.151] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:23.151] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:245:0) after 1m0s
[04:37:23.176] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:245:0)
[04:37:23.176] Timer tick, asking Buildbucket for the build status
[04:37:23.351] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:23.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:246:0) after 1m0s
[04:38:23.416] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:246:0)
[04:38:23.416] Timer tick, asking Buildbucket for the build status
[04:38:23.510] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:23.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:247:0) after 1m0s
[04:39:23.550] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:247:0)
[04:39:23.550] Timer tick, asking Buildbucket for the build status
[04:39:23.645] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:23.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:248:0) after 1m0s
[04:40:23.704] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:248:0)
[04:40:23.704] Timer tick, asking Buildbucket for the build status
[04:40:23.838] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:23.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:249:0) after 1m0s
[04:41:23.862] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:249:0)
[04:41:23.862] Timer tick, asking Buildbucket for the build status
[04:41:24.150] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:24.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:250:0) after 1m0s
[04:42:24.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:250:0)
[04:42:24.185] Timer tick, asking Buildbucket for the build status
[04:42:24.232] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:24.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:251:0) after 1m0s
[04:43:24.263] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:251:0)
[04:43:24.263] Timer tick, asking Buildbucket for the build status
[04:43:24.487] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:24.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:252:0) after 1m0s
[04:44:24.567] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:252:0)
[04:44:24.567] Timer tick, asking Buildbucket for the build status
[04:44:24.737] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:24.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:253:0) after 1m0s
[04:45:24.792] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:253:0)
[04:45:24.792] Timer tick, asking Buildbucket for the build status
[04:45:24.872] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:24.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:254:0) after 1m0s
[04:46:24.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:254:0)
[04:46:24.906] Timer tick, asking Buildbucket for the build status
[04:46:24.947] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:24.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:255:0) after 1m0s
[04:47:25.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:255:0)
[04:47:25.025] Timer tick, asking Buildbucket for the build status
[04:47:25.142] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:25.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:256:0) after 1m0s
[04:48:25.183] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:256:0)
[04:48:25.183] Timer tick, asking Buildbucket for the build status
[04:48:25.278] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:25.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:257:0) after 1m0s
[04:49:25.313] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:257:0)
[04:49:25.313] Timer tick, asking Buildbucket for the build status
[04:49:25.465] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:25.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:258:0) after 1m0s
[04:50:25.494] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:258:0)
[04:50:25.494] Timer tick, asking Buildbucket for the build status
[04:50:25.559] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:25.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:259:0) after 1m0s
[04:51:25.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:259:0)
[04:51:25.587] Timer tick, asking Buildbucket for the build status
[04:51:25.629] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:25.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:260:0) after 1m0s
[04:52:25.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:260:0)
[04:52:25.656] Timer tick, asking Buildbucket for the build status
[04:52:25.727] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:25.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:261:0) after 1m0s
[04:53:25.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:261:0)
[04:53:25.755] Timer tick, asking Buildbucket for the build status
[04:53:25.820] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:25.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:262:0) after 1m0s
[04:54:25.847] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:262:0)
[04:54:25.847] Timer tick, asking Buildbucket for the build status
[04:54:25.946] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:25.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:263:0) after 1m0s
[04:55:25.976] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:263:0)
[04:55:25.976] Timer tick, asking Buildbucket for the build status
[04:55:26.207] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:26.207] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:264:0) after 1m0s
[04:56:26.237] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:264:0)
[04:56:26.237] Timer tick, asking Buildbucket for the build status
[04:56:26.358] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:26.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:265:0) after 1m0s
[04:57:26.385] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:265:0)
[04:57:26.385] Timer tick, asking Buildbucket for the build status
[04:57:26.455] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:26.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:266:0) after 1m0s
[04:58:26.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:266:0)
[04:58:26.496] Timer tick, asking Buildbucket for the build status
[04:58:26.538] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:26.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:267:0) after 1m0s
[04:59:26.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:267:0)
[04:59:26.652] Timer tick, asking Buildbucket for the build status
[04:59:26.798] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:26.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:268:0) after 1m0s
[05:00:26.827] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:268:0)
[05:00:26.827] Timer tick, asking Buildbucket for the build status
[05:00:27.023] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:27.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:269:0) after 1m0s
[05:01:27.053] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:269:0)
[05:01:27.053] Timer tick, asking Buildbucket for the build status
[05:01:27.136] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:27.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:270:0) after 1m0s
[05:02:27.183] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:270:0)
[05:02:27.183] Timer tick, asking Buildbucket for the build status
[05:02:27.233] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:27.233] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:271:0) after 1m0s
[05:03:27.282] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:271:0)
[05:03:27.282] Timer tick, asking Buildbucket for the build status
[05:03:27.406] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:27.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:272:0) after 1m0s
[05:04:27.431] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:272:0)
[05:04:27.431] Timer tick, asking Buildbucket for the build status
[05:04:27.496] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:27.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:273:0) after 1m0s
[05:05:27.522] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:273:0)
[05:05:27.522] Timer tick, asking Buildbucket for the build status
[05:05:27.656] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:27.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:274:0) after 1m0s
[05:06:27.699] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:274:0)
[05:06:27.699] Timer tick, asking Buildbucket for the build status
[05:06:27.761] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:27.761] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:275:0) after 1m0s
[05:07:27.788] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:275:0)
[05:07:27.788] Timer tick, asking Buildbucket for the build status
[05:07:27.870] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:27.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:276:0) after 1m0s
[05:08:27.897] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:276:0)
[05:08:27.897] Timer tick, asking Buildbucket for the build status
[05:08:27.937] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:27.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:277:0) after 1m0s
[05:09:27.965] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:277:0)
[05:09:27.965] Timer tick, asking Buildbucket for the build status
[05:09:28.023] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:28.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:278:0) after 1m0s
[05:10:28.074] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:278:0)
[05:10:28.074] Timer tick, asking Buildbucket for the build status
[05:10:28.150] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:28.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:279:0) after 1m0s
[05:11:28.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:279:0)
[05:11:28.177] Timer tick, asking Buildbucket for the build status
[05:11:28.249] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:28.249] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:280:0) after 1m0s
[05:12:28.292] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:280:0)
[05:12:28.293] Timer tick, asking Buildbucket for the build status
[05:12:28.356] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:28.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:281:0) after 1m0s
[05:13:28.400] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:281:0)
[05:13:28.400] Timer tick, asking Buildbucket for the build status
[05:13:28.450] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:28.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:282:0) after 1m0s
[05:14:28.485] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:282:0)
[05:14:28.485] Timer tick, asking Buildbucket for the build status
[05:14:28.577] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:28.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:283:0) after 1m0s
[05:15:28.639] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:283:0)
[05:15:28.639] Timer tick, asking Buildbucket for the build status
[05:15:28.804] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:28.804] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:284:0) after 1m0s
[05:16:28.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:284:0)
[05:16:28.832] Timer tick, asking Buildbucket for the build status
[05:16:28.901] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:28.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:285:0) after 1m0s
[05:17:28.928] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:285:0)
[05:17:28.928] Timer tick, asking Buildbucket for the build status
[05:17:28.970] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:28.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:286:0) after 1m0s
[05:18:29.004] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:286:0)
[05:18:29.004] Timer tick, asking Buildbucket for the build status
[05:18:29.080] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:18:29.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:287:0) after 1m0s
[05:19:29.130] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:287:0)
[05:19:29.130] Timer tick, asking Buildbucket for the build status
[05:19:29.480] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:19:29.480] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:288:0) after 1m0s
[05:20:29.505] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:288:0)
[05:20:29.505] Timer tick, asking Buildbucket for the build status
[05:20:29.540] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:20:29.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:289:0) after 1m0s
[05:21:29.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:289:0)
[05:21:29.569] Timer tick, asking Buildbucket for the build status
[05:21:29.705] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:29.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:290:0) after 1m0s
[05:22:29.744] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:290:0)
[05:22:29.744] Timer tick, asking Buildbucket for the build status
[05:22:29.779] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:22:29.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:291:0) after 1m0s
[05:23:29.811] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:291:0)
[05:23:29.811] Timer tick, asking Buildbucket for the build status
[05:23:29.889] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:29.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:292:0) after 1m0s
[05:24:29.916] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:292:0)
[05:24:29.916] Timer tick, asking Buildbucket for the build status
[05:24:29.959] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:29.959] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:293:0) after 1m0s
[05:25:30.043] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:293:0)
[05:25:30.043] Timer tick, asking Buildbucket for the build status
[05:25:30.257] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:25:30.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:294:0) after 1m0s
[05:26:30.306] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:294:0)
[05:26:30.306] Timer tick, asking Buildbucket for the build status
[05:26:30.413] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:26:30.413] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:295:0) after 1m0s
[05:27:30.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:295:0)
[05:27:30.438] Timer tick, asking Buildbucket for the build status
[05:27:30.484] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:27:30.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:296:0) after 1m0s
[05:28:30.510] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:296:0)
[05:28:30.510] Timer tick, asking Buildbucket for the build status
[05:28:30.609] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:28:30.609] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:297:0) after 1m0s
[05:29:30.634] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:297:0)
[05:29:30.634] Timer tick, asking Buildbucket for the build status
[05:29:30.709] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:29:30.709] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:298:0) after 1m0s
[05:30:30.743] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:298:0)
[05:30:30.743] Timer tick, asking Buildbucket for the build status
[05:30:30.815] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:30.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:299:0) after 1m0s
[05:31:30.848] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:299:0)
[05:31:30.849] Timer tick, asking Buildbucket for the build status
[05:31:30.946] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:30.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:300:0) after 1m0s
[05:32:30.977] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:300:0)
[05:32:30.977] Timer tick, asking Buildbucket for the build status
[05:32:31.084] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:31.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:301:0) after 1m0s
[05:33:31.115] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:301:0)
[05:33:31.115] Timer tick, asking Buildbucket for the build status
[05:33:31.184] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:31.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:302:0) after 1m0s
[05:34:31.214] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:302:0)
[05:34:31.214] Timer tick, asking Buildbucket for the build status
[05:34:31.322] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:31.322] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:303:0) after 1m0s
[05:35:31.372] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:303:0)
[05:35:31.372] Timer tick, asking Buildbucket for the build status
[05:35:31.439] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:31.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:304:0) after 1m0s
[05:36:31.466] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:304:0)
[05:36:31.466] Timer tick, asking Buildbucket for the build status
[05:36:31.503] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:31.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:305:0) after 1m0s
[05:37:31.529] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:305:0)
[05:37:31.529] Timer tick, asking Buildbucket for the build status
[05:37:31.752] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:31.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:306:0) after 1m0s
[05:38:31.783] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:306:0)
[05:38:31.783] Timer tick, asking Buildbucket for the build status
[05:38:31.865] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:31.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:307:0) after 1m0s
[05:39:31.893] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:307:0)
[05:39:31.893] Timer tick, asking Buildbucket for the build status
[05:39:31.942] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:31.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:308:0) after 1m0s
[05:40:31.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:308:0)
[05:40:31.969] Timer tick, asking Buildbucket for the build status
[05:40:32.034] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:32.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:309:0) after 1m0s
[05:41:32.074] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:309:0)
[05:41:32.074] Timer tick, asking Buildbucket for the build status
[05:41:32.120] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:32.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:310:0) after 1m0s
[05:42:32.155] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:310:0)
[05:42:32.155] Timer tick, asking Buildbucket for the build status
[05:42:32.212] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:32.212] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:311:0) after 1m0s
[05:43:32.240] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:311:0)
[05:43:32.240] Timer tick, asking Buildbucket for the build status
[05:43:32.291] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:32.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:312:0) after 1m0s
[05:44:32.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:312:0)
[05:44:32.318] Timer tick, asking Buildbucket for the build status
[05:44:32.396] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:44:32.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:313:0) after 1m0s
[05:45:32.422] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:313:0)
[05:45:32.422] Timer tick, asking Buildbucket for the build status
[05:45:32.465] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:32.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:314:0) after 1m0s
[05:46:32.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:314:0)
[05:46:32.497] Timer tick, asking Buildbucket for the build status
[05:46:32.587] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:32.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:315:0) after 1m0s
[05:47:32.621] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:315:0)
[05:47:32.621] Timer tick, asking Buildbucket for the build status
[05:47:32.671] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:32.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:316:0) after 1m0s
[05:48:32.705] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:316:0)
[05:48:32.705] Timer tick, asking Buildbucket for the build status
[05:48:32.775] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:32.775] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:317:0) after 1m0s
[05:49:32.803] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:317:0)
[05:49:32.803] Timer tick, asking Buildbucket for the build status
[05:49:33.124] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:49:33.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:318:0) after 1m0s
[05:50:33.159] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:318:0)
[05:50:33.159] Timer tick, asking Buildbucket for the build status
[05:50:33.209] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:33.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:319:0) after 1m0s
[05:51:33.240] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:319:0)
[05:51:33.240] Timer tick, asking Buildbucket for the build status
[05:51:33.360] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:33.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:320:0) after 1m0s
[05:52:33.392] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:320:0)
[05:52:33.392] Timer tick, asking Buildbucket for the build status
[05:52:33.459] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:33.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:321:0) after 1m0s
[05:53:33.490] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:321:0)
[05:53:33.490] Timer tick, asking Buildbucket for the build status
[05:53:33.608] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:33.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:322:0) after 1m0s
[05:54:33.635] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:322:0)
[05:54:33.635] Timer tick, asking Buildbucket for the build status
[05:54:33.718] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:33.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:323:0) after 1m0s
[05:55:33.747] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:323:0)
[05:55:33.747] Timer tick, asking Buildbucket for the build status
[05:55:33.938] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:33.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:324:0) after 1m0s
[05:56:33.972] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:324:0)
[05:56:33.972] Timer tick, asking Buildbucket for the build status
[05:56:34.180] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:34.180] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:325:0) after 1m0s
[05:57:34.211] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:325:0)
[05:57:34.211] Timer tick, asking Buildbucket for the build status
[05:57:34.294] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:34.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:326:0) after 1m0s
[05:58:34.323] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:326:0)
[05:58:34.323] Timer tick, asking Buildbucket for the build status
[05:58:34.357] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:34.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:327:0) after 1m0s
[05:59:34.405] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:327:0)
[05:59:34.405] Timer tick, asking Buildbucket for the build status
[05:59:34.580] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:34.580] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:328:0) after 1m0s
[06:00:34.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:328:0)
[06:00:34.608] Timer tick, asking Buildbucket for the build status
[06:01:32.979] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:32.979] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:329:0) after 1m0s
[06:02:33.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:329:0)
[06:02:33.006] Timer tick, asking Buildbucket for the build status
[06:02:33.186] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:02:33.186] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:330:0) after 1m0s
[06:03:33.214] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:330:0)
[06:03:33.214] Timer tick, asking Buildbucket for the build status
[06:03:33.468] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:03:33.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:331:0) after 1m0s
[06:04:33.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:331:0)
[06:04:33.496] Timer tick, asking Buildbucket for the build status
[06:04:33.556] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:04:33.556] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:332:0) after 1m0s
[06:05:33.595] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:332:0)
[06:05:33.595] Timer tick, asking Buildbucket for the build status
[06:05:33.653] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:05:33.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:333:0) after 1m0s
[06:06:33.694] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:333:0)
[06:06:33.694] Timer tick, asking Buildbucket for the build status
[06:06:33.820] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:06:33.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:334:0) after 1m0s
[06:07:33.850] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:334:0)
[06:07:33.850] Timer tick, asking Buildbucket for the build status
[06:07:33.917] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:07:33.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:335:0) after 1m0s
[06:08:33.960] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:335:0)
[06:08:33.960] Timer tick, asking Buildbucket for the build status
[06:08:34.003] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:08:34.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:336:0) after 1m0s
[06:09:34.058] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:336:0)
[06:09:34.058] Timer tick, asking Buildbucket for the build status
[06:09:34.143] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:09:34.143] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:337:0) after 1m0s
[06:10:34.220] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:337:0)
[06:10:34.220] Timer tick, asking Buildbucket for the build status
[06:10:34.251] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:10:34.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:338:0) after 1m0s
[06:11:34.303] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:338:0)
[06:11:34.303] Timer tick, asking Buildbucket for the build status
[06:11:34.372] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:11:34.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:339:0) after 1m0s
[06:12:34.458] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:339:0)
[06:12:34.458] Timer tick, asking Buildbucket for the build status
[06:12:34.538] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:12:34.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:340:0) after 1m0s
[06:13:34.581] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:340:0)
[06:13:34.581] Timer tick, asking Buildbucket for the build status
[06:13:34.643] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:13:34.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:341:0) after 1m0s
[06:14:34.682] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:341:0)
[06:14:34.682] Timer tick, asking Buildbucket for the build status
[06:14:34.947] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:34.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:342:0) after 1m0s
[06:15:34.981] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:342:0)
[06:15:34.981] Timer tick, asking Buildbucket for the build status
[06:15:35.033] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:35.033] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:343:0) after 1m0s
[06:16:35.084] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:343:0)
[06:16:35.084] Timer tick, asking Buildbucket for the build status
[06:16:35.123] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:35.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:344:0) after 1m0s
[06:17:35.173] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:344:0)
[06:17:35.173] Timer tick, asking Buildbucket for the build status
[06:17:35.274] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:35.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:345:0) after 1m0s
[06:18:35.306] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:345:0)
[06:18:35.306] Timer tick, asking Buildbucket for the build status
[06:18:35.496] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:35.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:346:0) after 1m0s
[06:19:35.524] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:346:0)
[06:19:35.524] Timer tick, asking Buildbucket for the build status
[06:19:35.580] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:35.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:347:0) after 1m0s
[06:20:35.614] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:347:0)
[06:20:35.614] Timer tick, asking Buildbucket for the build status
[06:20:35.865] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:35.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:348:0) after 1m0s
[06:21:35.902] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:348:0)
[06:21:35.902] Timer tick, asking Buildbucket for the build status
[06:21:36.003] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:21:36.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:349:0) after 1m0s
[06:22:36.036] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:349:0)
[06:22:36.036] Timer tick, asking Buildbucket for the build status
[06:22:36.132] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:22:36.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:350:0) after 1m0s
[06:23:36.172] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:350:0)
[06:23:36.172] Timer tick, asking Buildbucket for the build status
[06:23:36.223] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:23:36.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:351:0) after 1m0s
[06:24:36.253] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:351:0)
[06:24:36.253] Timer tick, asking Buildbucket for the build status
[06:24:36.287] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:24:36.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:352:0) after 1m0s
[06:25:36.320] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:352:0)
[06:25:36.320] Timer tick, asking Buildbucket for the build status
[06:25:36.365] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:25:36.365] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:353:0) after 1m0s
[06:26:36.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:353:0)
[06:26:36.394] Timer tick, asking Buildbucket for the build status
[06:26:36.467] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:26:36.467] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:354:0) after 1m0s
[06:27:36.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:354:0)
[06:27:36.503] Timer tick, asking Buildbucket for the build status
[06:27:36.546] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:27:36.546] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:355:0) after 1m0s
[06:28:36.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:355:0)
[06:28:36.587] Timer tick, asking Buildbucket for the build status
[06:28:36.642] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:28:36.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:356:0) after 1m0s
[06:29:36.684] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:356:0)
[06:29:36.684] Timer tick, asking Buildbucket for the build status
[06:29:36.723] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:29:36.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:357:0) after 1m0s
[06:30:36.753] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:357:0)
[06:30:36.753] Timer tick, asking Buildbucket for the build status
[06:30:36.917] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:30:36.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:358:0) after 1m0s
[06:31:36.957] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:358:0)
[06:31:36.957] Timer tick, asking Buildbucket for the build status
[06:31:37.149] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:31:37.149] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:359:0) after 1m0s
[06:32:37.178] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:359:0)
[06:32:37.178] Timer tick, asking Buildbucket for the build status
[06:32:37.319] Build 8924037595850944096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:32:37.319] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9089467658048407376:360:0) after 1m0s
[06:33:04.071] Received PubSub notification, asking Buildbucket for the build status
[06:33:04.128] Build 8924037595850944096: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[06:33:04.128] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary": true,
    "canary_preference": "AUTO",
    "cancelation_reason": "TIMEOUT",
    "completed_ts": "1547793183218498",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1547771568401299",
    "id": "8924037595850944096",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_32\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"db355f48151995834fbdddd464fc00b8ad265132\"}}",
    "project": "nacl",
    "result": "CANCELED",
    "result_details_json": "{\"swarming\": {\"bot_dimensions\": {}}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "COMPLETED",
    "status_changed_ts": "1547793183637708",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/5111",
      "builder:linux-pnacl-x86_64-tests-x86_32",
      "buildset:commit/git/db355f48151995834fbdddd464fc00b8ad265132",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/db355f48151995834fbdddd464fc00b8ad265132",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9089467658048407376",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_dimension:caches:builder_d982c0762990b9abf737d190051a0a3bd67b51c14564e55713aea0114e04ab24_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/5111",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8924037595850944096",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-x86_32",
      "swarming_tag:buildset:commit/git/db355f48151995834fbdddd464fc00b8ad265132",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/db355f48151995834fbdddd464fc00b8ad265132",
      "swarming_tag:caches:builder_d982c0762990b9abf737d190051a0a3bd67b51c14564e55713aea0114e04ab24_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8924037595850944096/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9089467658048407376",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:7bd44c5698750454da45e03e17f93c16ef58f23d",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4277316af2d17410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1547793183639163",
    "url": "https://ci.chromium.org/b/8924037595850944096",
    "utcnow_ts": "1547793184107657"
  }
}
[06:33:04.128] Invocation finished in 6h0m17.207185638s with status FAILED