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

Status: FAILED

Triggered by: -

Duration: 4 hours

Actions:

Definition (rev 1c82d86159c2071b02a7ddf08ffd2ae0bff92186)

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

Incoming triggers

1e2123822ca7424ac63ecdf241af0da87d3ec740 (6 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[04:32:34.323] New invocation is queued and will start shortly
[04:32:36.242] Starting the invocation (attempt 1)
[04:32:36.277] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:32:36.277] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:32:36.277] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9092170480774192224",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-arm\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"1e2123822ca7424ac63ecdf241af0da87d3ec740\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-pnacl-x86_64-tests-arm",
    "scheduler_invocation_id:9092170480774192224",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
    "user_agent:luci-scheduler",
    "buildset:commit/git/1e2123822ca7424ac63ecdf241af0da87d3ec740",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1e2123822ca7424ac63ecdf241af0da87d3ec740",
    "gitiles_ref:refs/heads/master"
  ]
}
[04:32:38.097] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1545193956347906",
    "id": "8926740417988196992",
    "lease_expiration_ts": "1545345157711685",
    "lease_key": "1308048312",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"1e2123822ca7424ac63ecdf241af0da87d3ec740\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1545193957920126",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4687",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/1e2123822ca7424ac63ecdf241af0da87d3ec740",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1e2123822ca7424ac63ecdf241af0da87d3ec740",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9092170480774192224",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_dimension:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_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-arm/4687",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8926740417988196992",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-arm",
      "swarming_tag:buildset:commit/git/1e2123822ca7424ac63ecdf241af0da87d3ec740",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1e2123822ca7424ac63ecdf241af0da87d3ec740",
      "swarming_tag:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_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/8926740417988196992/+/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:9092170480774192224",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:a951373af11284d7583d5fd2ca25a760bc744af6",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:41dd8e2e8e591910",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1545193957920269",
    "url": "https://ci.chromium.org/b/8926740417988196992",
    "utcnow_ts": "1545193958085187"
  }
}
[04:32:38.097] Task URL: https://ci.chromium.org/b/8926740417988196992
[04:32:38.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:2:0) after 1m0s
[04:33:38.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:2:0)
[04:33:38.119] Timer tick, asking Buildbucket for the build status
[04:33:38.178] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:38.178] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:3:0) after 1m0s
[04:34:38.221] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:3:0)
[04:34:38.221] Timer tick, asking Buildbucket for the build status
[04:34:38.332] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:38.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:4:0) after 1m0s
[04:35:38.376] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:4:0)
[04:35:38.376] Timer tick, asking Buildbucket for the build status
[04:35:38.453] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:38.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:5:0) after 1m0s
[04:36:38.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:5:0)
[04:36:38.473] Timer tick, asking Buildbucket for the build status
[04:36:38.571] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:38.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:6:0) after 1m0s
[04:37:38.589] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:6:0)
[04:37:38.589] Timer tick, asking Buildbucket for the build status
[04:37:38.646] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:38.646] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:7:0) after 1m0s
[04:38:38.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:7:0)
[04:38:38.663] Timer tick, asking Buildbucket for the build status
[04:38:38.718] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:38.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:8:0) after 1m0s
[04:39:38.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:8:0)
[04:39:38.735] Timer tick, asking Buildbucket for the build status
[04:39:38.812] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:38.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:9:0) after 1m0s
[04:40:38.829] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:9:0)
[04:40:38.829] Timer tick, asking Buildbucket for the build status
[04:40:38.899] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:38.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:10:0) after 1m0s
[04:41:38.954] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:10:0)
[04:41:38.954] Timer tick, asking Buildbucket for the build status
[04:41:38.989] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:38.989] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:11:0) after 1m0s
[04:42:39.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:11:0)
[04:42:39.006] Timer tick, asking Buildbucket for the build status
[04:42:39.073] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:39.073] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:12:0) after 1m0s
[04:43:39.092] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:12:0)
[04:43:39.092] Timer tick, asking Buildbucket for the build status
[04:43:39.129] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:39.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:13:0) after 1m0s
[04:44:39.181] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:13:0)
[04:44:39.181] Timer tick, asking Buildbucket for the build status
[04:44:39.238] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:39.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:14:0) after 1m0s
[04:45:39.255] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:14:0)
[04:45:39.255] Timer tick, asking Buildbucket for the build status
[04:45:39.288] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:39.288] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:15:0) after 1m0s
[04:46:39.326] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:15:0)
[04:46:39.326] Timer tick, asking Buildbucket for the build status
[04:46:39.390] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:39.390] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:16:0) after 1m0s
[04:47:39.407] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:16:0)
[04:47:39.407] Timer tick, asking Buildbucket for the build status
[04:47:39.529] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:39.529] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:17:0) after 1m0s
[04:48:39.547] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:17:0)
[04:48:39.547] Timer tick, asking Buildbucket for the build status
[04:48:39.629] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:39.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:18:0) after 1m0s
[04:49:39.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:18:0)
[04:49:39.646] Timer tick, asking Buildbucket for the build status
[04:49:39.680] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:39.680] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:19:0) after 1m0s
[04:50:39.716] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:19:0)
[04:50:39.716] Timer tick, asking Buildbucket for the build status
[04:50:39.806] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:39.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:20:0) after 1m0s
[04:51:39.831] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:20:0)
[04:51:39.831] Timer tick, asking Buildbucket for the build status
[04:51:39.911] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:39.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:21:0) after 1m0s
[04:52:39.927] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:21:0)
[04:52:39.927] Timer tick, asking Buildbucket for the build status
[04:52:40.029] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:40.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:22:0) after 1m0s
[04:53:40.051] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:22:0)
[04:53:40.051] Timer tick, asking Buildbucket for the build status
[04:53:40.160] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:40.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:23:0) after 1m0s
[04:54:40.191] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:23:0)
[04:54:40.191] Timer tick, asking Buildbucket for the build status
[04:54:40.243] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:40.243] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:24:0) after 1m0s
[04:55:40.264] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:24:0)
[04:55:40.264] Timer tick, asking Buildbucket for the build status
[04:55:40.323] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:40.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:25:0) after 1m0s
[04:56:40.343] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:25:0)
[04:56:40.343] Timer tick, asking Buildbucket for the build status
[04:56:40.411] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:40.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:26:0) after 1m0s
[04:57:40.458] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:26:0)
[04:57:40.458] Timer tick, asking Buildbucket for the build status
[04:57:40.500] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:40.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:27:0) after 1m0s
[04:58:40.526] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:27:0)
[04:58:40.526] Timer tick, asking Buildbucket for the build status
[04:58:40.724] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:40.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:28:0) after 1m0s
[04:59:40.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:28:0)
[04:59:40.740] Timer tick, asking Buildbucket for the build status
[04:59:42.398] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:42.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:29:0) after 1m0s
[05:00:42.447] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:29:0)
[05:00:42.447] Timer tick, asking Buildbucket for the build status
[05:00:42.512] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:42.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:30:0) after 1m0s
[05:01:42.530] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:30:0)
[05:01:42.530] Timer tick, asking Buildbucket for the build status
[05:01:42.564] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:42.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:31:0) after 1m0s
[05:02:42.585] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:31:0)
[05:02:42.585] Timer tick, asking Buildbucket for the build status
[05:02:42.650] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:42.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:32:0) after 1m0s
[05:03:42.772] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:32:0)
[05:03:42.772] Timer tick, asking Buildbucket for the build status
[05:03:42.924] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:42.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:33:0) after 1m0s
[05:04:42.946] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:33:0)
[05:04:42.946] Timer tick, asking Buildbucket for the build status
[05:04:42.999] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:42.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:34:0) after 1m0s
[05:05:43.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:34:0)
[05:05:43.018] Timer tick, asking Buildbucket for the build status
[05:05:43.074] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:43.074] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:35:0) after 1m0s
[05:06:43.135] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:35:0)
[05:06:43.135] Timer tick, asking Buildbucket for the build status
[05:06:43.238] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:43.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:36:0) after 1m0s
[05:07:43.346] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:36:0)
[05:07:43.346] Timer tick, asking Buildbucket for the build status
[05:07:43.412] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:43.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:37:0) after 1m0s
[05:08:43.412] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:37:0)
[05:08:43.412] Timer tick, asking Buildbucket for the build status
[05:08:43.465] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:43.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:38:0) after 1m0s
[05:09:43.484] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:38:0)
[05:09:43.484] Timer tick, asking Buildbucket for the build status
[05:09:43.536] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:43.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:39:0) after 1m0s
[05:10:43.603] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:39:0)
[05:10:43.604] Timer tick, asking Buildbucket for the build status
[05:10:43.716] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:43.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:40:0) after 1m0s
[05:11:43.732] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:40:0)
[05:11:43.732] Timer tick, asking Buildbucket for the build status
[05:11:44.028] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:44.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:41:0) after 1m0s
[05:12:44.048] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:41:0)
[05:12:44.048] Timer tick, asking Buildbucket for the build status
[05:12:44.114] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:44.114] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:42:0) after 1m0s
[05:13:44.141] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:42:0)
[05:13:44.141] Timer tick, asking Buildbucket for the build status
[05:13:44.237] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:44.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:43:0) after 1m0s
[05:14:44.253] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:43:0)
[05:14:44.253] Timer tick, asking Buildbucket for the build status
[05:14:44.344] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:44.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:44:0) after 1m0s
[05:15:44.365] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:44:0)
[05:15:44.365] Timer tick, asking Buildbucket for the build status
[05:15:44.434] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:44.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:45:0) after 1m0s
[05:16:44.456] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:45:0)
[05:16:44.457] Timer tick, asking Buildbucket for the build status
[05:16:44.710] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:44.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:46:0) after 1m0s
[05:17:44.781] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:46:0)
[05:17:44.781] Timer tick, asking Buildbucket for the build status
[05:17:44.814] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:44.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:47:0) after 1m0s
[05:18:44.908] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:47:0)
[05:18:44.908] Timer tick, asking Buildbucket for the build status
[05:18:44.974] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:18:44.974] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:48:0) after 1m0s
[05:19:44.994] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:48:0)
[05:19:44.994] Timer tick, asking Buildbucket for the build status
[05:19:45.078] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:19:45.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:49:0) after 1m0s
[05:20:45.097] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:49:0)
[05:20:45.097] Timer tick, asking Buildbucket for the build status
[05:20:45.279] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:20:45.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:50:0) after 1m0s
[05:21:45.298] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:50:0)
[05:21:45.298] Timer tick, asking Buildbucket for the build status
[05:21:45.352] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:45.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:51:0) after 1m0s
[05:22:45.378] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:51:0)
[05:22:45.378] Timer tick, asking Buildbucket for the build status
[05:22:45.448] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:22:45.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:52:0) after 1m0s
[05:23:45.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:52:0)
[05:23:45.553] Timer tick, asking Buildbucket for the build status
[05:23:45.617] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:45.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:53:0) after 1m0s
[05:24:45.649] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:53:0)
[05:24:45.649] Timer tick, asking Buildbucket for the build status
[05:24:45.708] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:45.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:54:0) after 1m0s
[05:25:45.725] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:54:0)
[05:25:45.725] Timer tick, asking Buildbucket for the build status
[05:25:45.781] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:25:45.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:55:0) after 1m0s
[05:26:45.810] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:55:0)
[05:26:45.810] Timer tick, asking Buildbucket for the build status
[05:26:46.687] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:26:46.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:56:0) after 1m0s
[05:27:46.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:56:0)
[05:27:46.715] Timer tick, asking Buildbucket for the build status
[05:27:46.783] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:27:46.783] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:57:0) after 1m0s
[05:28:46.831] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:57:0)
[05:28:46.831] Timer tick, asking Buildbucket for the build status
[05:28:46.927] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:28:46.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:58:0) after 1m0s
[05:29:46.997] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:58:0)
[05:29:46.997] Timer tick, asking Buildbucket for the build status
[05:29:47.053] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:29:47.053] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:59:0) after 1m0s
[05:30:47.078] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:59:0)
[05:30:47.078] Timer tick, asking Buildbucket for the build status
[05:30:47.215] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:47.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:60:0) after 1m0s
[05:31:47.272] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:60:0)
[05:31:47.272] Timer tick, asking Buildbucket for the build status
[05:31:47.326] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:47.326] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:61:0) after 1m0s
[05:32:47.352] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:61:0)
[05:32:47.352] Timer tick, asking Buildbucket for the build status
[05:32:47.423] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:47.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:62:0) after 1m0s
[05:33:47.452] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:62:0)
[05:33:47.452] Timer tick, asking Buildbucket for the build status
[05:33:47.512] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:47.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:63:0) after 1m0s
[05:34:47.529] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:63:0)
[05:34:47.529] Timer tick, asking Buildbucket for the build status
[05:34:47.612] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:47.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:64:0) after 1m0s
[05:35:47.633] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:64:0)
[05:35:47.633] Timer tick, asking Buildbucket for the build status
[05:35:47.684] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:47.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:65:0) after 1m0s
[05:36:47.708] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:65:0)
[05:36:47.708] Timer tick, asking Buildbucket for the build status
[05:36:47.842] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:47.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:66:0) after 1m0s
[05:37:47.865] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:66:0)
[05:37:47.865] Timer tick, asking Buildbucket for the build status
[05:37:48.000] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:48.000] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:67:0) after 1m0s
[05:38:48.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:67:0)
[05:38:48.018] Timer tick, asking Buildbucket for the build status
[05:38:48.057] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:48.057] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:68:0) after 1m0s
[05:39:48.078] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:68:0)
[05:39:48.078] Timer tick, asking Buildbucket for the build status
[05:39:48.184] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:48.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:69:0) after 1m0s
[05:40:48.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:69:0)
[05:40:48.203] Timer tick, asking Buildbucket for the build status
[05:40:48.271] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:48.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:70:0) after 1m0s
[05:41:48.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:70:0)
[05:41:48.300] Timer tick, asking Buildbucket for the build status
[05:41:48.369] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:48.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:71:0) after 1m0s
[05:42:48.387] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:71:0)
[05:42:48.387] Timer tick, asking Buildbucket for the build status
[05:42:48.596] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:48.596] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:72:0) after 1m0s
[05:43:48.615] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:72:0)
[05:43:48.615] Timer tick, asking Buildbucket for the build status
[05:43:48.662] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:48.663] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:73:0) after 1m0s
[05:44:48.684] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:73:0)
[05:44:48.684] Timer tick, asking Buildbucket for the build status
[05:44:48.743] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:44:48.743] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:74:0) after 1m0s
[05:45:48.764] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:74:0)
[05:45:48.764] Timer tick, asking Buildbucket for the build status
[05:45:48.798] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:48.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:75:0) after 1m0s
[05:46:48.819] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:75:0)
[05:46:48.819] Timer tick, asking Buildbucket for the build status
[05:46:48.936] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:48.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:76:0) after 1m0s
[05:47:48.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:76:0)
[05:47:48.971] Timer tick, asking Buildbucket for the build status
[05:47:49.025] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:49.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:77:0) after 1m0s
[05:48:49.074] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:77:0)
[05:48:49.074] Timer tick, asking Buildbucket for the build status
[05:48:49.157] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:49.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:78:0) after 1m0s
[05:49:49.175] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:78:0)
[05:49:49.175] Timer tick, asking Buildbucket for the build status
[05:49:49.240] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:49:49.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:79:0) after 1m0s
[05:50:49.319] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:79:0)
[05:50:49.319] Timer tick, asking Buildbucket for the build status
[05:50:49.375] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:49.375] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:80:0) after 1m0s
[05:51:49.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:80:0)
[05:51:49.394] Timer tick, asking Buildbucket for the build status
[05:51:49.453] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:49.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:81:0) after 1m0s
[05:52:49.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:81:0)
[05:52:49.473] Timer tick, asking Buildbucket for the build status
[05:52:49.634] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:49.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:82:0) after 1m0s
[05:53:49.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:82:0)
[05:53:49.656] Timer tick, asking Buildbucket for the build status
[05:53:49.708] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:49.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:83:0) after 1m0s
[05:54:49.727] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:83:0)
[05:54:49.727] Timer tick, asking Buildbucket for the build status
[05:54:49.800] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:49.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:84:0) after 1m0s
[05:55:49.873] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:84:0)
[05:55:49.873] Timer tick, asking Buildbucket for the build status
[05:55:49.911] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:49.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:85:0) after 1m0s
[05:56:49.939] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:85:0)
[05:56:49.939] Timer tick, asking Buildbucket for the build status
[05:56:50.028] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:50.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:86:0) after 1m0s
[05:57:50.076] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:86:0)
[05:57:50.076] Timer tick, asking Buildbucket for the build status
[05:57:50.149] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:50.149] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:87:0) after 1m0s
[05:58:50.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:87:0)
[05:58:50.168] Timer tick, asking Buildbucket for the build status
[05:58:50.279] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:50.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:88:0) after 1m0s
[05:59:50.298] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:88:0)
[05:59:50.298] Timer tick, asking Buildbucket for the build status
[05:59:50.346] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:50.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:89:0) after 1m0s
[06:00:50.379] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:89:0)
[06:00:50.380] Timer tick, asking Buildbucket for the build status
[06:00:50.446] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:00:50.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:90:0) after 1m0s
[06:01:50.465] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:90:0)
[06:01:50.465] Timer tick, asking Buildbucket for the build status
[06:01:50.502] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:50.502] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:91:0) after 1m0s
[06:02:50.524] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:91:0)
[06:02:50.524] Timer tick, asking Buildbucket for the build status
[06:02:50.579] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:02:50.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:92:0) after 1m0s
[06:03:50.631] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:92:0)
[06:03:50.631] Timer tick, asking Buildbucket for the build status
[06:03:50.714] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:03:50.714] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:93:0) after 1m0s
[06:04:50.733] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:93:0)
[06:04:50.733] Timer tick, asking Buildbucket for the build status
[06:04:50.772] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:04:50.772] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:94:0) after 1m0s
[06:05:50.793] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:94:0)
[06:05:50.793] Timer tick, asking Buildbucket for the build status
[06:05:50.868] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:05:50.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:95:0) after 1m0s
[06:06:50.891] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:95:0)
[06:06:50.891] Timer tick, asking Buildbucket for the build status
[06:06:50.982] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:06:50.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:96:0) after 1m0s
[06:07:51.003] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:96:0)
[06:07:51.003] Timer tick, asking Buildbucket for the build status
[06:07:51.146] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:07:51.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:97:0) after 1m0s
[06:08:51.167] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:97:0)
[06:08:51.167] Timer tick, asking Buildbucket for the build status
[06:08:51.492] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:08:51.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:98:0) after 1m0s
[06:09:51.511] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:98:0)
[06:09:51.511] Timer tick, asking Buildbucket for the build status
[06:09:51.613] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:09:51.613] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:99:0) after 1m0s
[06:10:51.634] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:99:0)
[06:10:51.634] Timer tick, asking Buildbucket for the build status
[06:10:51.697] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:10:51.697] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:100:0) after 1m0s
[06:11:51.750] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:100:0)
[06:11:51.750] Timer tick, asking Buildbucket for the build status
[06:11:51.849] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:11:51.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:101:0) after 1m0s
[06:12:51.870] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:101:0)
[06:12:51.870] Timer tick, asking Buildbucket for the build status
[06:12:52.048] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:12:52.048] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:102:0) after 1m0s
[06:13:52.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:102:0)
[06:13:52.072] Timer tick, asking Buildbucket for the build status
[06:13:52.209] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:13:52.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:103:0) after 1m0s
[06:14:52.231] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:103:0)
[06:14:52.231] Timer tick, asking Buildbucket for the build status
[06:14:52.297] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:52.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:104:0) after 1m0s
[06:15:52.316] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:104:0)
[06:15:52.316] Timer tick, asking Buildbucket for the build status
[06:15:52.422] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:52.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:105:0) after 1m0s
[06:16:52.474] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:105:0)
[06:16:52.474] Timer tick, asking Buildbucket for the build status
[06:16:52.548] Build 8926740417988196992: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:52.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:106:0) after 1m0s
[06:16:55.260] Received PubSub notification, asking Buildbucket for the build status
[06:16:55.329] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:52.571] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:106:0)
[06:17:52.571] Timer tick, asking Buildbucket for the build status
[06:17:52.624] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:52.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:108:0) after 1m0s
[06:18:52.647] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:108:0)
[06:18:52.647] Timer tick, asking Buildbucket for the build status
[06:18:52.705] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:52.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:109:0) after 1m0s
[06:19:52.732] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:109:0)
[06:19:52.732] Timer tick, asking Buildbucket for the build status
[06:19:52.928] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:52.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:110:0) after 1m0s
[06:20:52.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:110:0)
[06:20:52.950] Timer tick, asking Buildbucket for the build status
[06:20:53.054] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:53.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:111:0) after 1m0s
[06:21:53.077] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:111:0)
[06:21:53.077] Timer tick, asking Buildbucket for the build status
[06:21:53.248] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:53.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:112:0) after 1m0s
[06:22:53.267] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:112:0)
[06:22:53.267] Timer tick, asking Buildbucket for the build status
[06:22:53.329] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:53.329] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:113:0) after 1m0s
[06:23:53.353] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:113:0)
[06:23:53.353] Timer tick, asking Buildbucket for the build status
[06:23:53.412] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:53.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:114:0) after 1m0s
[06:24:53.432] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:114:0)
[06:24:53.432] Timer tick, asking Buildbucket for the build status
[06:24:53.479] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:53.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:115:0) after 1m0s
[06:25:53.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:115:0)
[06:25:53.503] Timer tick, asking Buildbucket for the build status
[06:25:53.567] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:53.567] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:116:0) after 1m0s
[06:26:53.585] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:116:0)
[06:26:53.585] Timer tick, asking Buildbucket for the build status
[06:26:53.662] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:53.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:117:0) after 1m0s
[06:27:53.685] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:117:0)
[06:27:53.685] Timer tick, asking Buildbucket for the build status
[06:27:53.744] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:53.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:118:0) after 1m0s
[06:28:53.765] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:118:0)
[06:28:53.765] Timer tick, asking Buildbucket for the build status
[06:28:53.834] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:53.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:119:0) after 1m0s
[06:29:53.854] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:119:0)
[06:29:53.854] Timer tick, asking Buildbucket for the build status
[06:29:54.004] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:54.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:120:0) after 1m0s
[06:30:54.033] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:120:0)
[06:30:54.033] Timer tick, asking Buildbucket for the build status
[06:30:54.094] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:54.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:121:0) after 1m0s
[06:31:54.124] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:121:0)
[06:31:54.124] Timer tick, asking Buildbucket for the build status
[06:31:54.195] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:54.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:122:0) after 1m0s
[06:32:54.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:122:0)
[06:32:54.217] Timer tick, asking Buildbucket for the build status
[06:32:54.263] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:54.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:123:0) after 1m0s
[06:33:54.296] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:123:0)
[06:33:54.296] Timer tick, asking Buildbucket for the build status
[06:33:54.503] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:54.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:124:0) after 1m0s
[06:34:54.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:124:0)
[06:34:54.553] Timer tick, asking Buildbucket for the build status
[06:34:54.610] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:54.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:125:0) after 1m0s
[06:35:54.631] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:125:0)
[06:35:54.631] Timer tick, asking Buildbucket for the build status
[06:35:54.691] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:54.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:126:0) after 1m0s
[06:36:54.712] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:126:0)
[06:36:54.712] Timer tick, asking Buildbucket for the build status
[06:36:54.809] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:54.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:127:0) after 1m0s
[06:37:54.839] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:127:0)
[06:37:54.839] Timer tick, asking Buildbucket for the build status
[06:37:54.923] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:54.923] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:128:0) after 1m0s
[06:38:54.948] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:128:0)
[06:38:54.948] Timer tick, asking Buildbucket for the build status
[06:38:55.013] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:55.013] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:129:0) after 1m0s
[06:39:55.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:129:0)
[06:39:55.035] Timer tick, asking Buildbucket for the build status
[06:39:55.120] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:55.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:130:0) after 1m0s
[06:40:55.141] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:130:0)
[06:40:55.141] Timer tick, asking Buildbucket for the build status
[06:40:55.215] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:55.216] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:131:0) after 1m0s
[06:41:55.238] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:131:0)
[06:41:55.238] Timer tick, asking Buildbucket for the build status
[06:41:55.292] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:55.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:132:0) after 1m0s
[06:42:55.314] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:132:0)
[06:42:55.314] Timer tick, asking Buildbucket for the build status
[06:42:55.443] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:55.443] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:133:0) after 1m0s
[06:43:55.512] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:133:0)
[06:43:55.512] Timer tick, asking Buildbucket for the build status
[06:43:55.614] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:55.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:134:0) after 1m0s
[06:44:55.700] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:134:0)
[06:44:55.700] Timer tick, asking Buildbucket for the build status
[06:44:55.763] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:55.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:135:0) after 1m0s
[06:45:55.806] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:135:0)
[06:45:55.806] Timer tick, asking Buildbucket for the build status
[06:45:55.940] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:55.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:136:0) after 1m0s
[06:46:55.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:136:0)
[06:46:55.967] Timer tick, asking Buildbucket for the build status
[06:46:56.021] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:56.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:137:0) after 1m0s
[06:47:56.124] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:137:0)
[06:47:56.125] Timer tick, asking Buildbucket for the build status
[06:47:56.243] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:56.243] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:138:0) after 1m0s
[06:48:56.296] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:138:0)
[06:48:56.296] Timer tick, asking Buildbucket for the build status
[06:48:56.336] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:56.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:139:0) after 1m0s
[06:49:56.366] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:139:0)
[06:49:56.366] Timer tick, asking Buildbucket for the build status
[06:49:56.641] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:56.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:140:0) after 1m0s
[06:50:56.669] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:140:0)
[06:50:56.669] Timer tick, asking Buildbucket for the build status
[06:50:56.917] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:56.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:141:0) after 1m0s
[06:51:56.999] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:141:0)
[06:51:56.999] Timer tick, asking Buildbucket for the build status
[06:51:57.109] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:57.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:142:0) after 1m0s
[06:52:57.133] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:142:0)
[06:52:57.133] Timer tick, asking Buildbucket for the build status
[06:52:57.182] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:57.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:143:0) after 1m0s
[06:53:57.206] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:143:0)
[06:53:57.206] Timer tick, asking Buildbucket for the build status
[06:53:57.306] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:57.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:144:0) after 1m0s
[06:54:57.340] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:144:0)
[06:54:57.340] Timer tick, asking Buildbucket for the build status
[06:54:57.428] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:57.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:145:0) after 1m0s
[06:55:57.458] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:145:0)
[06:55:57.458] Timer tick, asking Buildbucket for the build status
[06:55:57.528] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:57.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:146:0) after 1m0s
[06:56:57.554] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:146:0)
[06:56:57.554] Timer tick, asking Buildbucket for the build status
[06:56:57.660] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:57.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:147:0) after 1m0s
[06:57:57.697] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:147:0)
[06:57:57.697] Timer tick, asking Buildbucket for the build status
[06:57:57.743] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:57.743] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:148:0) after 1m0s
[06:58:57.765] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:148:0)
[06:58:57.765] Timer tick, asking Buildbucket for the build status
[06:58:57.847] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:57.847] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:149:0) after 1m0s
[06:59:57.889] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:149:0)
[06:59:57.889] Timer tick, asking Buildbucket for the build status
[06:59:57.924] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:57.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:150:0) after 1m0s
[07:00:57.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:150:0)
[07:00:57.950] Timer tick, asking Buildbucket for the build status
[07:00:57.999] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:57.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:151:0) after 1m0s
[07:01:58.070] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:151:0)
[07:01:58.070] Timer tick, asking Buildbucket for the build status
[07:01:58.150] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:58.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:152:0) after 1m0s
[07:02:58.188] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:152:0)
[07:02:58.188] Timer tick, asking Buildbucket for the build status
[07:02:58.239] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:58.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:153:0) after 1m0s
[07:03:58.261] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:153:0)
[07:03:58.261] Timer tick, asking Buildbucket for the build status
[07:03:58.318] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:58.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:154:0) after 1m0s
[07:04:58.345] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:154:0)
[07:04:58.345] Timer tick, asking Buildbucket for the build status
[07:04:58.865] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:58.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:155:0) after 1m0s
[07:05:58.886] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:155:0)
[07:05:58.886] Timer tick, asking Buildbucket for the build status
[07:05:59.169] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:59.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:156:0) after 1m0s
[07:06:59.195] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:156:0)
[07:06:59.195] Timer tick, asking Buildbucket for the build status
[07:06:59.267] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:59.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:157:0) after 1m0s
[07:07:59.291] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:157:0)
[07:07:59.291] Timer tick, asking Buildbucket for the build status
[07:07:59.362] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:59.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:158:0) after 1m0s
[07:08:59.384] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:158:0)
[07:08:59.384] Timer tick, asking Buildbucket for the build status
[07:08:59.470] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:59.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:159:0) after 1m0s
[07:09:59.505] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:159:0)
[07:09:59.505] Timer tick, asking Buildbucket for the build status
[07:09:59.746] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:59.746] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:160:0) after 1m0s
[07:10:59.779] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:160:0)
[07:10:59.779] Timer tick, asking Buildbucket for the build status
[07:10:59.855] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:59.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:161:0) after 1m0s
[07:11:59.876] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:161:0)
[07:11:59.876] Timer tick, asking Buildbucket for the build status
[07:11:59.908] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:59.908] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:162:0) after 1m0s
[07:12:59.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:162:0)
[07:12:59.932] Timer tick, asking Buildbucket for the build status
[07:13:00.033] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:00.033] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:163:0) after 1m0s
[07:14:00.064] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:163:0)
[07:14:00.064] Timer tick, asking Buildbucket for the build status
[07:14:00.128] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:00.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:164:0) after 1m0s
[07:15:00.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:164:0)
[07:15:00.203] Timer tick, asking Buildbucket for the build status
[07:15:00.316] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:00.316] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:165:0) after 1m0s
[07:16:00.335] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:165:0)
[07:16:00.335] Timer tick, asking Buildbucket for the build status
[07:16:00.447] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:00.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:166:0) after 1m0s
[07:17:00.476] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:166:0)
[07:17:00.476] Timer tick, asking Buildbucket for the build status
[07:17:00.519] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:00.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:167:0) after 1m0s
[07:18:00.540] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:167:0)
[07:18:00.540] Timer tick, asking Buildbucket for the build status
[07:18:00.633] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:00.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:168:0) after 1m0s
[07:19:00.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:168:0)
[07:19:00.660] Timer tick, asking Buildbucket for the build status
[07:19:00.716] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:00.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:169:0) after 1m0s
[07:20:00.742] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:169:0)
[07:20:00.742] Timer tick, asking Buildbucket for the build status
[07:20:00.804] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:00.804] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:170:0) after 1m0s
[07:21:00.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:170:0)
[07:21:00.844] Timer tick, asking Buildbucket for the build status
[07:21:00.893] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:00.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:171:0) after 1m0s
[07:22:00.917] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:171:0)
[07:22:00.917] Timer tick, asking Buildbucket for the build status
[07:22:00.958] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:00.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:172:0) after 1m0s
[07:23:00.997] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:172:0)
[07:23:00.997] Timer tick, asking Buildbucket for the build status
[07:23:01.057] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:01.057] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:173:0) after 1m0s
[07:24:01.082] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:173:0)
[07:24:01.082] Timer tick, asking Buildbucket for the build status
[07:24:01.188] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:01.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:174:0) after 1m0s
[07:25:01.211] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:174:0)
[07:25:01.211] Timer tick, asking Buildbucket for the build status
[07:25:01.308] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:01.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:175:0) after 1m0s
[07:26:01.330] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:175:0)
[07:26:01.330] Timer tick, asking Buildbucket for the build status
[07:26:01.677] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:01.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:176:0) after 1m0s
[07:27:01.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:176:0)
[07:27:01.722] Timer tick, asking Buildbucket for the build status
[07:27:02.041] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:02.041] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:177:0) after 1m0s
[07:28:02.067] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:177:0)
[07:28:02.067] Timer tick, asking Buildbucket for the build status
[07:28:02.237] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:02.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:178:0) after 1m0s
[07:29:02.258] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:178:0)
[07:29:02.258] Timer tick, asking Buildbucket for the build status
[07:29:02.291] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:02.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:179:0) after 1m0s
[07:30:02.314] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:179:0)
[07:30:02.314] Timer tick, asking Buildbucket for the build status
[07:30:02.394] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:02.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:180:0) after 1m0s
[07:31:02.416] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:180:0)
[07:31:02.416] Timer tick, asking Buildbucket for the build status
[07:31:02.517] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:02.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:181:0) after 1m0s
[07:32:02.541] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:181:0)
[07:32:02.541] Timer tick, asking Buildbucket for the build status
[07:32:02.593] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:02.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:182:0) after 1m0s
[07:33:02.650] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:182:0)
[07:33:02.650] Timer tick, asking Buildbucket for the build status
[07:33:02.695] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:02.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:183:0) after 1m0s
[07:34:02.716] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:183:0)
[07:34:02.716] Timer tick, asking Buildbucket for the build status
[07:34:02.810] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:02.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:184:0) after 1m0s
[07:35:02.856] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:184:0)
[07:35:02.856] Timer tick, asking Buildbucket for the build status
[07:35:02.960] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:02.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:185:0) after 1m0s
[07:36:02.993] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:185:0)
[07:36:02.993] Timer tick, asking Buildbucket for the build status
[07:36:03.079] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:03.079] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:186:0) after 1m0s
[07:37:03.103] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:186:0)
[07:37:03.103] Timer tick, asking Buildbucket for the build status
[07:37:03.595] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:03.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:187:0) after 1m0s
[07:38:03.639] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:187:0)
[07:38:03.639] Timer tick, asking Buildbucket for the build status
[07:38:03.708] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:03.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:188:0) after 1m0s
[07:39:03.725] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:188:0)
[07:39:03.725] Timer tick, asking Buildbucket for the build status
[07:39:03.766] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:03.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:189:0) after 1m0s
[07:40:03.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:189:0)
[07:40:03.787] Timer tick, asking Buildbucket for the build status
[07:40:03.937] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:03.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:190:0) after 1m0s
[07:41:03.961] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:190:0)
[07:41:03.961] Timer tick, asking Buildbucket for the build status
[07:41:04.602] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:04.602] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:191:0) after 1m0s
[07:42:04.692] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:191:0)
[07:42:04.692] Timer tick, asking Buildbucket for the build status
[07:42:04.752] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:04.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:192:0) after 1m0s
[07:43:04.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:192:0)
[07:43:04.773] Timer tick, asking Buildbucket for the build status
[07:43:04.833] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:04.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:193:0) after 1m0s
[07:44:04.855] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:193:0)
[07:44:04.855] Timer tick, asking Buildbucket for the build status
[07:44:04.904] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:04.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:194:0) after 1m0s
[07:45:04.927] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:194:0)
[07:45:04.927] Timer tick, asking Buildbucket for the build status
[07:45:05.155] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:05.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:195:0) after 1m0s
[07:46:05.191] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:195:0)
[07:46:05.191] Timer tick, asking Buildbucket for the build status
[07:46:05.239] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:05.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:196:0) after 1m0s
[07:47:05.269] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:196:0)
[07:47:05.269] Timer tick, asking Buildbucket for the build status
[07:47:05.358] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:05.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:197:0) after 1m0s
[07:48:05.385] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:197:0)
[07:48:05.385] Timer tick, asking Buildbucket for the build status
[07:48:05.442] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:05.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:198:0) after 1m0s
[07:49:05.468] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:198:0)
[07:49:05.468] Timer tick, asking Buildbucket for the build status
[07:49:05.550] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:05.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:199:0) after 1m0s
[07:50:05.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:199:0)
[07:50:05.577] Timer tick, asking Buildbucket for the build status
[07:50:05.640] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:05.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:200:0) after 1m0s
[07:51:05.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:200:0)
[07:51:05.663] Timer tick, asking Buildbucket for the build status
[07:51:05.724] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:05.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:201:0) after 1m0s
[07:52:05.788] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:201:0)
[07:52:05.788] Timer tick, asking Buildbucket for the build status
[07:52:06.189] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:06.189] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:202:0) after 1m0s
[07:53:06.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:202:0)
[07:53:06.233] Timer tick, asking Buildbucket for the build status
[07:53:06.302] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:06.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:203:0) after 1m0s
[07:54:06.328] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:203:0)
[07:54:06.328] Timer tick, asking Buildbucket for the build status
[07:54:06.410] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:06.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:204:0) after 1m0s
[07:55:06.432] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:204:0)
[07:55:06.433] Timer tick, asking Buildbucket for the build status
[07:55:06.497] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:06.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:205:0) after 1m0s
[07:56:06.522] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:205:0)
[07:56:06.522] Timer tick, asking Buildbucket for the build status
[07:56:06.878] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:06.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:206:0) after 1m0s
[07:57:06.912] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:206:0)
[07:57:06.912] Timer tick, asking Buildbucket for the build status
[07:57:07.064] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:07.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:207:0) after 1m0s
[07:58:07.110] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:207:0)
[07:58:07.110] Timer tick, asking Buildbucket for the build status
[07:58:07.175] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:07.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:208:0) after 1m0s
[07:59:07.197] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:208:0)
[07:59:07.197] Timer tick, asking Buildbucket for the build status
[07:59:07.373] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:07.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:209:0) after 1m0s
[08:00:07.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:209:0)
[08:00:07.394] Timer tick, asking Buildbucket for the build status
[08:00:07.438] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:07.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:210:0) after 1m0s
[08:01:07.462] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:210:0)
[08:01:07.462] Timer tick, asking Buildbucket for the build status
[08:01:07.542] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:07.542] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:211:0) after 1m0s
[08:02:07.566] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:211:0)
[08:02:07.566] Timer tick, asking Buildbucket for the build status
[08:02:07.610] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:07.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:212:0) after 1m0s
[08:03:07.632] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:212:0)
[08:03:07.632] Timer tick, asking Buildbucket for the build status
[08:03:07.699] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:07.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:213:0) after 1m0s
[08:04:07.745] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:213:0)
[08:04:07.745] Timer tick, asking Buildbucket for the build status
[08:04:07.916] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:07.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:214:0) after 1m0s
[08:05:07.945] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:214:0)
[08:05:07.945] Timer tick, asking Buildbucket for the build status
[08:05:08.021] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:08.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:215:0) after 1m0s
[08:06:08.044] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:215:0)
[08:06:08.044] Timer tick, asking Buildbucket for the build status
[08:06:08.160] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:08.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:216:0) after 1m0s
[08:07:08.201] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:216:0)
[08:07:08.201] Timer tick, asking Buildbucket for the build status
[08:07:08.762] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:08.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:217:0) after 1m0s
[08:08:08.784] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:217:0)
[08:08:08.784] Timer tick, asking Buildbucket for the build status
[08:08:09.014] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:09.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:218:0) after 1m0s
[08:09:09.038] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:218:0)
[08:09:09.038] Timer tick, asking Buildbucket for the build status
[08:09:09.100] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:09.101] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:219:0) after 1m0s
[08:10:09.124] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:219:0)
[08:10:09.124] Timer tick, asking Buildbucket for the build status
[08:10:09.185] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:09.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:220:0) after 1m0s
[08:11:09.209] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:220:0)
[08:11:09.209] Timer tick, asking Buildbucket for the build status
[08:11:09.292] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:09.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:221:0) after 1m0s
[08:12:09.317] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:221:0)
[08:12:09.317] Timer tick, asking Buildbucket for the build status
[08:12:09.376] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:09.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:222:0) after 1m0s
[08:13:09.407] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:222:0)
[08:13:09.407] Timer tick, asking Buildbucket for the build status
[08:13:09.540] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:09.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:223:0) after 1m0s
[08:14:09.589] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:223:0)
[08:14:09.589] Timer tick, asking Buildbucket for the build status
[08:14:09.671] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:09.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:224:0) after 1m0s
[08:15:09.865] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:224:0)
[08:15:09.865] Timer tick, asking Buildbucket for the build status
[08:15:09.946] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:09.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:225:0) after 1m0s
[08:16:10.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:225:0)
[08:16:10.018] Timer tick, asking Buildbucket for the build status
[08:16:10.083] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:10.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:226:0) after 1m0s
[08:17:10.139] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:226:0)
[08:17:10.139] Timer tick, asking Buildbucket for the build status
[08:17:11.813] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:11.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:227:0) after 1m0s
[08:18:11.842] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:227:0)
[08:18:11.842] Timer tick, asking Buildbucket for the build status
[08:18:11.927] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:11.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:228:0) after 1m0s
[08:19:11.952] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:228:0)
[08:19:11.952] Timer tick, asking Buildbucket for the build status
[08:19:12.024] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:12.024] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:229:0) after 1m0s
[08:20:12.049] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:229:0)
[08:20:12.049] Timer tick, asking Buildbucket for the build status
[08:20:12.104] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:12.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:230:0) after 1m0s
[08:21:12.135] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:230:0)
[08:21:12.135] Timer tick, asking Buildbucket for the build status
[08:21:12.183] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:12.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:231:0) after 1m0s
[08:22:12.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:231:0)
[08:22:12.207] Timer tick, asking Buildbucket for the build status
[08:22:12.283] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:12.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:232:0) after 1m0s
[08:23:12.334] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:232:0)
[08:23:12.334] Timer tick, asking Buildbucket for the build status
[08:23:12.456] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:12.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:233:0) after 1m0s
[08:24:12.485] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:233:0)
[08:24:12.485] Timer tick, asking Buildbucket for the build status
[08:24:12.668] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:12.668] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:234:0) after 1m0s
[08:25:12.726] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:234:0)
[08:25:12.726] Timer tick, asking Buildbucket for the build status
[08:25:12.866] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:12.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:235:0) after 1m0s
[08:26:12.888] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:235:0)
[08:26:12.888] Timer tick, asking Buildbucket for the build status
[08:26:12.949] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:12.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:236:0) after 1m0s
[08:27:12.991] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:236:0)
[08:27:12.991] Timer tick, asking Buildbucket for the build status
[08:27:13.081] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:13.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:237:0) after 1m0s
[08:28:13.110] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:237:0)
[08:28:13.110] Timer tick, asking Buildbucket for the build status
[08:28:13.248] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:13.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:238:0) after 1m0s
[08:29:13.275] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:238:0)
[08:29:13.275] Timer tick, asking Buildbucket for the build status
[08:29:13.391] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:13.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:239:0) after 1m0s
[08:30:13.418] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:239:0)
[08:30:13.418] Timer tick, asking Buildbucket for the build status
[08:30:13.818] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:13.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:240:0) after 1m0s
[08:31:13.840] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:240:0)
[08:31:13.840] Timer tick, asking Buildbucket for the build status
[08:31:13.910] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:13.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:241:0) after 1m0s
[08:32:13.931] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:241:0)
[08:32:13.931] Timer tick, asking Buildbucket for the build status
[08:32:13.983] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:13.983] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:242:0) after 1m0s
[08:33:14.008] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:242:0)
[08:33:14.008] Timer tick, asking Buildbucket for the build status
[08:33:14.075] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:14.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:243:0) after 1m0s
[08:34:14.101] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:243:0)
[08:34:14.101] Timer tick, asking Buildbucket for the build status
[08:34:14.159] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:14.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:244:0) after 1m0s
[08:35:14.182] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:244:0)
[08:35:14.182] Timer tick, asking Buildbucket for the build status
[08:35:14.409] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:14.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:245:0) after 1m0s
[08:36:14.436] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:245:0)
[08:36:14.436] Timer tick, asking Buildbucket for the build status
[08:36:14.645] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:14.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:246:0) after 1m0s
[08:37:14.667] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:246:0)
[08:37:14.667] Timer tick, asking Buildbucket for the build status
[08:37:14.833] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:14.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:247:0) after 1m0s
[08:38:14.893] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:247:0)
[08:38:14.893] Timer tick, asking Buildbucket for the build status
[08:38:14.987] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:14.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:248:0) after 1m0s
[08:39:15.015] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:248:0)
[08:39:15.015] Timer tick, asking Buildbucket for the build status
[08:39:15.433] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:15.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:249:0) after 1m0s
[08:40:15.468] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:249:0)
[08:40:15.468] Timer tick, asking Buildbucket for the build status
[08:40:15.577] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:15.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:250:0) after 1m0s
[08:41:15.601] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:250:0)
[08:41:15.601] Timer tick, asking Buildbucket for the build status
[08:41:15.674] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:15.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:251:0) after 1m0s
[08:42:15.695] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:251:0)
[08:42:15.695] Timer tick, asking Buildbucket for the build status
[08:42:15.864] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:15.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:252:0) after 1m0s
[08:43:15.886] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:252:0)
[08:43:15.886] Timer tick, asking Buildbucket for the build status
[08:43:15.951] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:15.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:253:0) after 1m0s
[08:44:15.978] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:253:0)
[08:44:15.978] Timer tick, asking Buildbucket for the build status
[08:44:16.154] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:16.154] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:254:0) after 1m0s
[08:45:16.194] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:254:0)
[08:45:16.194] Timer tick, asking Buildbucket for the build status
[08:45:16.274] Build 8926740417988196992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:16.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9092170480774192224:255:0) after 1m0s
[08:45:48.496] Received PubSub notification, asking Buildbucket for the build status
[08:45:48.667] Build 8926740417988196992: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:45:48.667] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1545209146412573",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1545193956347906",
    "failure_reason": "BUILD_FAILURE",
    "id": "8926740417988196992",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"1e2123822ca7424ac63ecdf241af0da87d3ec740\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"Failure annotated steps\\nFailure torture_tests_clang arm\\nFailure llvm-test-suite arm --opt O3f --opt O2b\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3945-402d3be\"], \"machine_type\": [\"n1-standard-16\"], \"gpu\": [\"none\"], \"cores\": [\"16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-16-145e5bab-us-west1-c-3mct\"], \"pool\": [\"luci.nacl.toolchain\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 4687, \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"buildername\": \"linux-pnacl-x86_64-tests-arm\", \"got_revision\": \"1e2123822ca7424ac63ecdf241af0da87d3ec740\", \"recipe\": \"nacl\", \"mastername\": \"client.nacl.toolchain\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1545193956347906, \"tags\": [\"builder:linux-pnacl-x86_64-tests-arm\", \"buildset:commit/git/1e2123822ca7424ac63ecdf241af0da87d3ec740\", \"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1e2123822ca7424ac63ecdf241af0da87d3ec740\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9092170480774192224\", \"scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.nacl.toolchain\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"nacl\", \"id\": \"8926740417988196992\"}}, \"slavetype\": \"BuilderTester\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"1e2123822ca7424ac63ecdf241af0da87d3ec740\", \"bot_id\": \"gce-trusty-16-145e5bab-us-west1-c-3mct\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1545200214443864",
    "status": "COMPLETED",
    "status_changed_ts": "1545209147920471",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4687",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/1e2123822ca7424ac63ecdf241af0da87d3ec740",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1e2123822ca7424ac63ecdf241af0da87d3ec740",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9092170480774192224",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_dimension:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_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-arm/4687",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8926740417988196992",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-arm",
      "swarming_tag:buildset:commit/git/1e2123822ca7424ac63ecdf241af0da87d3ec740",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1e2123822ca7424ac63ecdf241af0da87d3ec740",
      "swarming_tag:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_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/8926740417988196992/+/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:9092170480774192224",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:a951373af11284d7583d5fd2ca25a760bc744af6",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:41dd8e2e8e591910",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1545209147923929",
    "url": "https://ci.chromium.org/b/8926740417988196992",
    "utcnow_ts": "1545209148642688"
  }
}
[08:45:48.667] Invocation finished in 4h13m14.361668733s with status FAILED