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

Status: FAILED

Triggered by: -

Duration: 3 hours

Actions:

Definition (rev 1c82d86159c2071b02a7ddf08ffd2ae0bff92186)

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

Incoming triggers

55f40a255928a95a71a5c63b37cdf7cc6ec8acae (6 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[20:44:18.329] New invocation is queued and will start shortly
[20:44:19.607] Starting the invocation (attempt 1)
[20:44:19.650] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:44:19.650] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:44:19.650] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9094646059651919648",
  "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\":\"55f40a255928a95a71a5c63b37cdf7cc6ec8acae\"}}",
  "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:9094646059651919648",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
    "user_agent:luci-scheduler",
    "buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
    "gitiles_ref:refs/heads/master"
  ]
}
[20:44:21.463] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary": true,
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1542833059745530",
    "experimental": true,
    "id": "8929215997503221184",
    "lease_expiration_ts": "1542951861131783",
    "lease_key": "240993818",
    "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\": \"55f40a255928a95a71a5c63b37cdf7cc6ec8acae\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1542833061315895",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/9",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9094646059651919648",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_dimension:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_v2",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/9",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8929215997503221184",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:586d78b1df9b356be85f0824ec8364d9ecbabf90",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-arm",
      "swarming_tag:buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "swarming_tag:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_v2",
      "swarming_tag:cores:8",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8929215997503221184/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:60",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9094646059651919648",
      "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:18bb9400d243d9bda9184c768cca1f92d5a22697",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4150d5c361a5d110",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1542833061316036",
    "url": "https://ci.chromium.org/b/8929215997503221184",
    "utcnow_ts": "1542833061440426"
  }
}
[20:44:21.463] Task URL: https://ci.chromium.org/b/8929215997503221184
[20:44:21.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:2:0) after 1m0s
[20:45:21.518] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:2:0)
[20:45:21.518] Timer tick, asking Buildbucket for the build status
[20:45:21.624] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:21.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:3:0) after 1m0s
[20:46:21.648] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:3:0)
[20:46:21.648] Timer tick, asking Buildbucket for the build status
[20:46:21.749] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:21.749] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:4:0) after 1m0s
[20:47:21.975] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:4:0)
[20:47:21.975] Timer tick, asking Buildbucket for the build status
[20:47:22.042] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:22.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:5:0) after 1m0s
[20:48:22.070] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:5:0)
[20:48:22.070] Timer tick, asking Buildbucket for the build status
[20:48:22.120] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:22.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:6:0) after 1m0s
[20:49:22.142] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:6:0)
[20:49:22.142] Timer tick, asking Buildbucket for the build status
[20:49:22.206] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:22.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:7:0) after 1m0s
[20:50:22.223] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:7:0)
[20:50:22.223] Timer tick, asking Buildbucket for the build status
[20:50:22.807] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:22.807] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:8:0) after 1m0s
[20:51:22.828] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:8:0)
[20:51:22.828] Timer tick, asking Buildbucket for the build status
[20:51:22.890] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:22.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:9:0) after 1m0s
[20:52:22.913] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:9:0)
[20:52:22.913] Timer tick, asking Buildbucket for the build status
[20:52:22.987] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:22.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:10:0) after 1m0s
[20:53:23.008] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:10:0)
[20:53:23.008] Timer tick, asking Buildbucket for the build status
[20:53:23.070] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:23.070] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:11:0) after 1m0s
[20:54:23.101] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:11:0)
[20:54:23.101] Timer tick, asking Buildbucket for the build status
[20:54:23.222] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:23.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:12:0) after 1m0s
[20:55:23.271] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:12:0)
[20:55:23.271] Timer tick, asking Buildbucket for the build status
[20:55:23.348] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:23.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:13:0) after 1m0s
[20:56:23.387] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:13:0)
[20:56:23.387] Timer tick, asking Buildbucket for the build status
[20:56:23.439] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:23.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:14:0) after 1m0s
[20:57:23.471] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:14:0)
[20:57:23.471] Timer tick, asking Buildbucket for the build status
[20:57:23.536] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:23.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:15:0) after 1m0s
[20:58:23.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:15:0)
[20:58:23.556] Timer tick, asking Buildbucket for the build status
[20:58:23.665] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:23.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:16:0) after 1m0s
[20:59:23.686] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:16:0)
[20:59:23.686] Timer tick, asking Buildbucket for the build status
[20:59:23.747] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:23.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:17:0) after 1m0s
[21:00:23.770] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:17:0)
[21:00:23.770] Timer tick, asking Buildbucket for the build status
[21:00:23.827] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:23.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:18:0) after 1m0s
[21:01:23.981] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:18:0)
[21:01:23.981] Timer tick, asking Buildbucket for the build status
[21:01:24.062] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:24.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:19:0) after 1m0s
[21:02:24.080] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:19:0)
[21:02:24.080] Timer tick, asking Buildbucket for the build status
[21:02:24.128] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:24.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:20:0) after 1m0s
[21:03:24.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:20:0)
[21:03:24.149] Timer tick, asking Buildbucket for the build status
[21:03:24.232] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:24.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:21:0) after 1m0s
[21:04:24.249] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:21:0)
[21:04:24.249] Timer tick, asking Buildbucket for the build status
[21:04:24.436] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:24.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:22:0) after 1m0s
[21:05:24.453] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:22:0)
[21:05:24.453] Timer tick, asking Buildbucket for the build status
[21:05:24.560] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:24.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:23:0) after 1m0s
[21:06:24.590] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:23:0)
[21:06:24.590] Timer tick, asking Buildbucket for the build status
[21:06:24.721] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:24.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:24:0) after 1m0s
[21:07:24.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:24:0)
[21:07:24.740] Timer tick, asking Buildbucket for the build status
[21:07:24.933] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:24.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:25:0) after 1m0s
[21:08:24.956] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:25:0)
[21:08:24.956] Timer tick, asking Buildbucket for the build status
[21:08:25.007] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:25.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:26:0) after 1m0s
[21:09:25.036] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:26:0)
[21:09:25.036] Timer tick, asking Buildbucket for the build status
[21:09:25.193] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:25.194] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:27:0) after 1m0s
[21:10:25.214] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:27:0)
[21:10:25.214] Timer tick, asking Buildbucket for the build status
[21:10:25.265] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:25.265] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:28:0) after 1m0s
[21:11:25.287] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:28:0)
[21:11:25.287] Timer tick, asking Buildbucket for the build status
[21:11:25.354] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:25.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:29:0) after 1m0s
[21:12:25.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:29:0)
[21:12:25.394] Timer tick, asking Buildbucket for the build status
[21:12:25.464] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:25.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:30:0) after 1m0s
[21:13:25.487] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:30:0)
[21:13:25.487] Timer tick, asking Buildbucket for the build status
[21:13:25.652] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:25.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:31:0) after 1m0s
[21:14:25.679] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:31:0)
[21:14:25.679] Timer tick, asking Buildbucket for the build status
[21:14:25.722] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:25.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:32:0) after 1m0s
[21:15:25.747] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:32:0)
[21:15:25.747] Timer tick, asking Buildbucket for the build status
[21:15:25.943] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:25.943] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:33:0) after 1m0s
[21:16:26.023] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:33:0)
[21:16:26.023] Timer tick, asking Buildbucket for the build status
[21:16:26.210] Build 8929215997503221184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:26.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:34:0) after 1m0s
[21:16:31.264] Received PubSub notification, asking Buildbucket for the build status
[21:16:31.304] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:26.237] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:34:0)
[21:17:26.237] Timer tick, asking Buildbucket for the build status
[21:17:26.378] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:26.378] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:36:0) after 1m0s
[21:18:26.415] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:36:0)
[21:18:26.415] Timer tick, asking Buildbucket for the build status
[21:18:26.541] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:26.541] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:37:0) after 1m0s
[21:19:26.560] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:37:0)
[21:19:26.560] Timer tick, asking Buildbucket for the build status
[21:19:26.785] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:26.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:38:0) after 1m0s
[21:20:26.876] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:38:0)
[21:20:26.876] Timer tick, asking Buildbucket for the build status
[21:20:27.054] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:27.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:39:0) after 1m0s
[21:21:27.097] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:39:0)
[21:21:27.097] Timer tick, asking Buildbucket for the build status
[21:21:27.232] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:27.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:40:0) after 1m0s
[21:22:27.257] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:40:0)
[21:22:27.257] Timer tick, asking Buildbucket for the build status
[21:22:27.356] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:27.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:41:0) after 1m0s
[21:23:27.495] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:41:0)
[21:23:27.495] Timer tick, asking Buildbucket for the build status
[21:23:27.563] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:27.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:42:0) after 1m0s
[21:24:27.599] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:42:0)
[21:24:27.599] Timer tick, asking Buildbucket for the build status
[21:24:27.752] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:27.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:43:0) after 1m0s
[21:25:27.783] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:43:0)
[21:25:27.783] Timer tick, asking Buildbucket for the build status
[21:25:27.831] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:27.831] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:44:0) after 1m0s
[21:26:27.856] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:44:0)
[21:26:27.856] Timer tick, asking Buildbucket for the build status
[21:26:27.932] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:27.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:45:0) after 1m0s
[21:27:27.952] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:45:0)
[21:27:27.952] Timer tick, asking Buildbucket for the build status
[21:27:28.002] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:28.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:46:0) after 1m0s
[21:28:28.083] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:46:0)
[21:28:28.083] Timer tick, asking Buildbucket for the build status
[21:28:28.167] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:28.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:47:0) after 1m0s
[21:29:28.212] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:47:0)
[21:29:28.212] Timer tick, asking Buildbucket for the build status
[21:29:28.267] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:28.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:48:0) after 1m0s
[21:30:28.302] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:48:0)
[21:30:28.302] Timer tick, asking Buildbucket for the build status
[21:30:28.396] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:28.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:49:0) after 1m0s
[21:31:28.416] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:49:0)
[21:31:28.416] Timer tick, asking Buildbucket for the build status
[21:31:28.600] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:28.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:50:0) after 1m0s
[21:32:28.643] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:50:0)
[21:32:28.643] Timer tick, asking Buildbucket for the build status
[21:32:28.766] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:28.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:51:0) after 1m0s
[21:33:28.786] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:51:0)
[21:33:28.786] Timer tick, asking Buildbucket for the build status
[21:33:28.836] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:28.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:52:0) after 1m0s
[21:34:28.901] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:52:0)
[21:34:28.901] Timer tick, asking Buildbucket for the build status
[21:34:28.948] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:28.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:53:0) after 1m0s
[21:35:28.972] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:53:0)
[21:35:28.972] Timer tick, asking Buildbucket for the build status
[21:35:29.064] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:29.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:54:0) after 1m0s
[21:36:29.086] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:54:0)
[21:36:29.086] Timer tick, asking Buildbucket for the build status
[21:36:29.148] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:29.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:55:0) after 1m0s
[21:37:29.198] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:55:0)
[21:37:29.198] Timer tick, asking Buildbucket for the build status
[21:37:29.256] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:29.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:56:0) after 1m0s
[21:38:29.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:56:0)
[21:38:29.280] Timer tick, asking Buildbucket for the build status
[21:38:29.357] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:29.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:57:0) after 1m0s
[21:39:29.381] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:57:0)
[21:39:29.381] Timer tick, asking Buildbucket for the build status
[21:39:29.430] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:29.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:58:0) after 1m0s
[21:40:29.453] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:58:0)
[21:40:29.453] Timer tick, asking Buildbucket for the build status
[21:40:29.539] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:29.539] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:59:0) after 1m0s
[21:41:29.564] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:59:0)
[21:41:29.564] Timer tick, asking Buildbucket for the build status
[21:41:29.628] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:29.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:60:0) after 1m0s
[21:42:29.655] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:60:0)
[21:42:29.655] Timer tick, asking Buildbucket for the build status
[21:42:29.741] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:29.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:61:0) after 1m0s
[21:43:29.793] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:61:0)
[21:43:29.793] Timer tick, asking Buildbucket for the build status
[21:43:29.867] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:29.867] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:62:0) after 1m0s
[21:44:29.923] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:62:0)
[21:44:29.923] Timer tick, asking Buildbucket for the build status
[21:44:30.100] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:30.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:63:0) after 1m0s
[21:45:30.121] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:63:0)
[21:45:30.121] Timer tick, asking Buildbucket for the build status
[21:45:30.200] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:30.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:64:0) after 1m0s
[21:46:30.222] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:64:0)
[21:46:30.222] Timer tick, asking Buildbucket for the build status
[21:46:30.288] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:30.288] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:65:0) after 1m0s
[21:47:30.316] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:65:0)
[21:47:30.316] Timer tick, asking Buildbucket for the build status
[21:47:30.437] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:30.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:66:0) after 1m0s
[21:48:30.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:66:0)
[21:48:30.459] Timer tick, asking Buildbucket for the build status
[21:48:30.623] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:30.623] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:67:0) after 1m0s
[21:49:30.687] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:67:0)
[21:49:30.687] Timer tick, asking Buildbucket for the build status
[21:49:30.782] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:30.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:68:0) after 1m0s
[21:50:30.804] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:68:0)
[21:50:30.805] Timer tick, asking Buildbucket for the build status
[21:50:30.874] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:30.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:69:0) after 1m0s
[21:51:30.904] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:69:0)
[21:51:30.904] Timer tick, asking Buildbucket for the build status
[21:51:30.980] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:30.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:70:0) after 1m0s
[21:52:31.046] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:70:0)
[21:52:31.046] Timer tick, asking Buildbucket for the build status
[21:52:31.335] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:31.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:71:0) after 1m0s
[21:53:31.407] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:71:0)
[21:53:31.407] Timer tick, asking Buildbucket for the build status
[21:53:31.481] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:31.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:72:0) after 1m0s
[21:54:31.531] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:72:0)
[21:54:31.531] Timer tick, asking Buildbucket for the build status
[21:54:31.811] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:31.811] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:73:0) after 1m0s
[21:55:31.837] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:73:0)
[21:55:31.837] Timer tick, asking Buildbucket for the build status
[21:55:31.899] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:31.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:74:0) after 1m0s
[21:56:31.924] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:74:0)
[21:56:31.925] Timer tick, asking Buildbucket for the build status
[21:56:32.021] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:32.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:75:0) after 1m0s
[21:57:32.045] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:75:0)
[21:57:32.045] Timer tick, asking Buildbucket for the build status
[21:57:32.141] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:32.141] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:76:0) after 1m0s
[21:58:32.169] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:76:0)
[21:58:32.169] Timer tick, asking Buildbucket for the build status
[21:58:32.334] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:32.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:77:0) after 1m0s
[21:59:32.436] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:77:0)
[21:59:32.436] Timer tick, asking Buildbucket for the build status
[21:59:32.676] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:32.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:78:0) after 1m0s
[22:00:32.781] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:78:0)
[22:00:32.781] Timer tick, asking Buildbucket for the build status
[22:00:32.881] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:32.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:79:0) after 1m0s
[22:01:32.919] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:79:0)
[22:01:32.919] Timer tick, asking Buildbucket for the build status
[22:01:32.957] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:32.957] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:80:0) after 1m0s
[22:02:32.996] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:80:0)
[22:02:32.996] Timer tick, asking Buildbucket for the build status
[22:02:33.113] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:33.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:81:0) after 1m0s
[22:03:33.137] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:81:0)
[22:03:33.137] Timer tick, asking Buildbucket for the build status
[22:03:33.185] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:33.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:82:0) after 1m0s
[22:04:33.224] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:82:0)
[22:04:33.224] Timer tick, asking Buildbucket for the build status
[22:04:33.284] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:33.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:83:0) after 1m0s
[22:05:33.326] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:83:0)
[22:05:33.326] Timer tick, asking Buildbucket for the build status
[22:05:33.364] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:33.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:84:0) after 1m0s
[22:06:33.403] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:84:0)
[22:06:33.403] Timer tick, asking Buildbucket for the build status
[22:06:33.475] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:33.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:85:0) after 1m0s
[22:07:33.499] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:85:0)
[22:07:33.499] Timer tick, asking Buildbucket for the build status
[22:07:33.563] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:33.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:86:0) after 1m0s
[22:08:33.584] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:86:0)
[22:08:33.584] Timer tick, asking Buildbucket for the build status
[22:08:33.663] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:33.663] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:87:0) after 1m0s
[22:09:33.731] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:87:0)
[22:09:33.731] Timer tick, asking Buildbucket for the build status
[22:09:33.812] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:33.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:88:0) after 1m0s
[22:10:33.836] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:88:0)
[22:10:33.836] Timer tick, asking Buildbucket for the build status
[22:10:33.995] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:33.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:89:0) after 1m0s
[22:11:34.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:89:0)
[22:11:34.032] Timer tick, asking Buildbucket for the build status
[22:11:34.103] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:34.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:90:0) after 1m0s
[22:12:34.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:90:0)
[22:12:34.177] Timer tick, asking Buildbucket for the build status
[22:12:34.279] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:34.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:91:0) after 1m0s
[22:13:34.305] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:91:0)
[22:13:34.305] Timer tick, asking Buildbucket for the build status
[22:13:34.357] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:34.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:92:0) after 1m0s
[22:14:34.382] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:92:0)
[22:14:34.382] Timer tick, asking Buildbucket for the build status
[22:14:34.533] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:34.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:93:0) after 1m0s
[22:15:34.554] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:93:0)
[22:15:34.554] Timer tick, asking Buildbucket for the build status
[22:15:34.600] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:34.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:94:0) after 1m0s
[22:16:34.623] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:94:0)
[22:16:34.624] Timer tick, asking Buildbucket for the build status
[22:16:34.733] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:34.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:95:0) after 1m0s
[22:17:34.761] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:95:0)
[22:17:34.761] Timer tick, asking Buildbucket for the build status
[22:17:34.845] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:34.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:96:0) after 1m0s
[22:18:34.867] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:96:0)
[22:18:34.867] Timer tick, asking Buildbucket for the build status
[22:18:34.998] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:34.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:97:0) after 1m0s
[22:19:35.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:97:0)
[22:19:35.025] Timer tick, asking Buildbucket for the build status
[22:19:35.088] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:35.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:98:0) after 1m0s
[22:20:35.123] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:98:0)
[22:20:35.123] Timer tick, asking Buildbucket for the build status
[22:20:35.247] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:35.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:99:0) after 1m0s
[22:21:35.269] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:99:0)
[22:21:35.269] Timer tick, asking Buildbucket for the build status
[22:21:35.320] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:35.320] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:100:0) after 1m0s
[22:22:35.345] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:100:0)
[22:22:35.345] Timer tick, asking Buildbucket for the build status
[22:22:35.660] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:35.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:101:0) after 1m0s
[22:23:35.718] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:101:0)
[22:23:35.718] Timer tick, asking Buildbucket for the build status
[22:23:35.780] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:35.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:102:0) after 1m0s
[22:24:35.807] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:102:0)
[22:24:35.807] Timer tick, asking Buildbucket for the build status
[22:24:35.853] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:35.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:103:0) after 1m0s
[22:25:35.910] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:103:0)
[22:25:35.910] Timer tick, asking Buildbucket for the build status
[22:25:36.021] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:36.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:104:0) after 1m0s
[22:26:36.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:104:0)
[22:26:36.088] Timer tick, asking Buildbucket for the build status
[22:26:36.201] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:36.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:105:0) after 1m0s
[22:27:36.230] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:105:0)
[22:27:36.230] Timer tick, asking Buildbucket for the build status
[22:27:36.421] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:36.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:106:0) after 1m0s
[22:28:36.444] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:106:0)
[22:28:36.444] Timer tick, asking Buildbucket for the build status
[22:28:36.499] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:36.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:107:0) after 1m0s
[22:29:36.621] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:107:0)
[22:29:36.621] Timer tick, asking Buildbucket for the build status
[22:29:36.702] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:36.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:108:0) after 1m0s
[22:30:36.728] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:108:0)
[22:30:36.728] Timer tick, asking Buildbucket for the build status
[22:30:36.838] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:36.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:109:0) after 1m0s
[22:31:36.862] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:109:0)
[22:31:36.862] Timer tick, asking Buildbucket for the build status
[22:31:36.918] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:36.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:110:0) after 1m0s
[22:32:36.974] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:110:0)
[22:32:36.974] Timer tick, asking Buildbucket for the build status
[22:32:37.030] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:37.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:111:0) after 1m0s
[22:33:37.131] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:111:0)
[22:33:37.131] Timer tick, asking Buildbucket for the build status
[22:33:37.269] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:37.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:112:0) after 1m0s
[22:34:37.386] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:112:0)
[22:34:37.386] Timer tick, asking Buildbucket for the build status
[22:34:37.442] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:37.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:113:0) after 1m0s
[22:35:37.509] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:113:0)
[22:35:37.509] Timer tick, asking Buildbucket for the build status
[22:35:37.579] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:37.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:114:0) after 1m0s
[22:36:37.664] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:114:0)
[22:36:37.664] Timer tick, asking Buildbucket for the build status
[22:36:37.812] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:37.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:115:0) after 1m0s
[22:37:37.850] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:115:0)
[22:37:37.850] Timer tick, asking Buildbucket for the build status
[22:37:37.987] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:37.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:116:0) after 1m0s
[22:38:38.007] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:116:0)
[22:38:38.007] Timer tick, asking Buildbucket for the build status
[22:38:38.069] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:38.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:117:0) after 1m0s
[22:39:38.150] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:117:0)
[22:39:38.150] Timer tick, asking Buildbucket for the build status
[22:39:38.362] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:38.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:118:0) after 1m0s
[22:40:38.387] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:118:0)
[22:40:38.387] Timer tick, asking Buildbucket for the build status
[22:40:38.446] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:38.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:119:0) after 1m0s
[22:41:38.483] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:119:0)
[22:41:38.483] Timer tick, asking Buildbucket for the build status
[22:41:38.632] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:38.632] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:120:0) after 1m0s
[22:42:38.655] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:120:0)
[22:42:38.655] Timer tick, asking Buildbucket for the build status
[22:42:38.700] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:38.700] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:121:0) after 1m0s
[22:43:38.806] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:121:0)
[22:43:38.806] Timer tick, asking Buildbucket for the build status
[22:43:38.873] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:38.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:122:0) after 1m0s
[22:44:38.917] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:122:0)
[22:44:38.917] Timer tick, asking Buildbucket for the build status
[22:44:38.984] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:38.984] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:123:0) after 1m0s
[22:45:39.106] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:123:0)
[22:45:39.106] Timer tick, asking Buildbucket for the build status
[22:45:39.176] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:39.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:124:0) after 1m0s
[22:46:39.216] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:124:0)
[22:46:39.216] Timer tick, asking Buildbucket for the build status
[22:46:39.303] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:39.303] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:125:0) after 1m0s
[22:47:39.329] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:125:0)
[22:47:39.329] Timer tick, asking Buildbucket for the build status
[22:47:40.055] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:40.055] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:126:0) after 1m0s
[22:48:40.076] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:126:0)
[22:48:40.076] Timer tick, asking Buildbucket for the build status
[22:48:40.185] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:40.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:127:0) after 1m0s
[22:49:40.479] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:127:0)
[22:49:40.479] Timer tick, asking Buildbucket for the build status
[22:49:40.579] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:40.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:128:0) after 1m0s
[22:50:40.606] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:128:0)
[22:50:40.606] Timer tick, asking Buildbucket for the build status
[22:50:40.646] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:40.646] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:129:0) after 1m0s
[22:51:40.666] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:129:0)
[22:51:40.666] Timer tick, asking Buildbucket for the build status
[22:51:40.919] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:40.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:130:0) after 1m0s
[22:52:40.947] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:130:0)
[22:52:40.947] Timer tick, asking Buildbucket for the build status
[22:52:41.019] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:41.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:131:0) after 1m0s
[22:53:41.045] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:131:0)
[22:53:41.045] Timer tick, asking Buildbucket for the build status
[22:53:41.131] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:41.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:132:0) after 1m0s
[22:54:41.158] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:132:0)
[22:54:41.158] Timer tick, asking Buildbucket for the build status
[22:54:41.376] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:41.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:133:0) after 1m0s
[22:55:41.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:133:0)
[22:55:41.455] Timer tick, asking Buildbucket for the build status
[22:55:41.719] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:41.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:134:0) after 1m0s
[22:56:41.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:134:0)
[22:56:41.749] Timer tick, asking Buildbucket for the build status
[22:56:41.792] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:41.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:135:0) after 1m0s
[22:57:41.885] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:135:0)
[22:57:41.885] Timer tick, asking Buildbucket for the build status
[22:57:41.976] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:41.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:136:0) after 1m0s
[22:58:41.999] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:136:0)
[22:58:41.999] Timer tick, asking Buildbucket for the build status
[22:58:42.044] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:42.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:137:0) after 1m0s
[22:59:42.100] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:137:0)
[22:59:42.100] Timer tick, asking Buildbucket for the build status
[22:59:42.169] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:42.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:138:0) after 1m0s
[23:00:42.314] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:138:0)
[23:00:42.314] Timer tick, asking Buildbucket for the build status
[23:00:42.595] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:42.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:139:0) after 1m0s
[23:01:42.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:139:0)
[23:01:42.735] Timer tick, asking Buildbucket for the build status
[23:01:42.908] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:42.908] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:140:0) after 1m0s
[23:02:43.081] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:140:0)
[23:02:43.081] Timer tick, asking Buildbucket for the build status
[23:02:43.126] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:43.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:141:0) after 1m0s
[23:03:43.150] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:141:0)
[23:03:43.150] Timer tick, asking Buildbucket for the build status
[23:03:43.247] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:43.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:142:0) after 1m0s
[23:04:43.272] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:142:0)
[23:04:43.272] Timer tick, asking Buildbucket for the build status
[23:04:43.323] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:43.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:143:0) after 1m0s
[23:05:43.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:143:0)
[23:05:43.578] Timer tick, asking Buildbucket for the build status
[23:05:43.689] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:43.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:144:0) after 1m0s
[23:06:43.716] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:144:0)
[23:06:43.716] Timer tick, asking Buildbucket for the build status
[23:06:43.762] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:43.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:145:0) after 1m0s
[23:07:43.807] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:145:0)
[23:07:43.807] Timer tick, asking Buildbucket for the build status
[23:07:43.940] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:43.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:146:0) after 1m0s
[23:08:44.200] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:146:0)
[23:08:44.200] Timer tick, asking Buildbucket for the build status
[23:08:44.281] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:44.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:147:0) after 1m0s
[23:09:44.774] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:147:0)
[23:09:44.774] Timer tick, asking Buildbucket for the build status
[23:09:44.843] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:44.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:148:0) after 1m0s
[23:10:44.977] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:148:0)
[23:10:44.977] Timer tick, asking Buildbucket for the build status
[23:10:45.069] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:45.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:149:0) after 1m0s
[23:11:45.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:149:0)
[23:11:45.202] Timer tick, asking Buildbucket for the build status
[23:11:45.323] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:45.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:150:0) after 1m0s
[23:12:45.375] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:150:0)
[23:12:45.375] Timer tick, asking Buildbucket for the build status
[23:12:45.510] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:45.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:151:0) after 1m0s
[23:13:45.540] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:151:0)
[23:13:45.540] Timer tick, asking Buildbucket for the build status
[23:13:45.589] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:45.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:152:0) after 1m0s
[23:14:45.617] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:152:0)
[23:14:45.617] Timer tick, asking Buildbucket for the build status
[23:14:45.755] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:45.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:153:0) after 1m0s
[23:15:45.792] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:153:0)
[23:15:45.792] Timer tick, asking Buildbucket for the build status
[23:15:45.858] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:45.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:154:0) after 1m0s
[23:16:45.884] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:154:0)
[23:16:45.884] Timer tick, asking Buildbucket for the build status
[23:16:45.991] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:45.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:155:0) after 1m0s
[23:17:46.027] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:155:0)
[23:17:46.027] Timer tick, asking Buildbucket for the build status
[23:17:46.103] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:46.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:156:0) after 1m0s
[23:18:46.201] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:156:0)
[23:18:46.201] Timer tick, asking Buildbucket for the build status
[23:18:46.284] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:46.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:157:0) after 1m0s
[23:19:46.385] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:157:0)
[23:19:46.385] Timer tick, asking Buildbucket for the build status
[23:19:46.503] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:46.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:158:0) after 1m0s
[23:20:46.533] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:158:0)
[23:20:46.533] Timer tick, asking Buildbucket for the build status
[23:20:46.606] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:46.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:159:0) after 1m0s
[23:21:46.634] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:159:0)
[23:21:46.634] Timer tick, asking Buildbucket for the build status
[23:21:46.721] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:46.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:160:0) after 1m0s
[23:22:46.748] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:160:0)
[23:22:46.748] Timer tick, asking Buildbucket for the build status
[23:22:47.027] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:47.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:161:0) after 1m0s
[23:23:47.056] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:161:0)
[23:23:47.056] Timer tick, asking Buildbucket for the build status
[23:23:47.118] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:47.118] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:162:0) after 1m0s
[23:24:47.156] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:162:0)
[23:24:47.156] Timer tick, asking Buildbucket for the build status
[23:24:47.334] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:47.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:163:0) after 1m0s
[23:25:47.364] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:163:0)
[23:25:47.364] Timer tick, asking Buildbucket for the build status
[23:25:47.451] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:47.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:164:0) after 1m0s
[23:26:47.480] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:164:0)
[23:26:47.480] Timer tick, asking Buildbucket for the build status
[23:26:47.580] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:47.580] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:165:0) after 1m0s
[23:27:47.618] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:165:0)
[23:27:47.618] Timer tick, asking Buildbucket for the build status
[23:27:47.726] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:47.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:166:0) after 1m0s
[23:28:47.750] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:166:0)
[23:28:47.750] Timer tick, asking Buildbucket for the build status
[23:28:47.848] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:47.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:167:0) after 1m0s
[23:29:47.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:167:0)
[23:29:47.871] Timer tick, asking Buildbucket for the build status
[23:29:48.000] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:48.000] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:168:0) after 1m0s
[23:30:48.033] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:168:0)
[23:30:48.033] Timer tick, asking Buildbucket for the build status
[23:30:48.133] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:48.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:169:0) after 1m0s
[23:31:48.213] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:169:0)
[23:31:48.213] Timer tick, asking Buildbucket for the build status
[23:31:48.345] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:48.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:170:0) after 1m0s
[23:32:48.386] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:170:0)
[23:32:48.386] Timer tick, asking Buildbucket for the build status
[23:32:48.653] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:48.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:171:0) after 1m0s
[23:33:48.677] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:171:0)
[23:33:48.677] Timer tick, asking Buildbucket for the build status
[23:33:48.748] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:48.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:172:0) after 1m0s
[23:34:48.772] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:172:0)
[23:34:48.772] Timer tick, asking Buildbucket for the build status
[23:34:48.842] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:48.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:173:0) after 1m0s
[23:35:48.874] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:173:0)
[23:35:48.874] Timer tick, asking Buildbucket for the build status
[23:35:49.098] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:49.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:174:0) after 1m0s
[23:36:49.126] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:174:0)
[23:36:49.126] Timer tick, asking Buildbucket for the build status
[23:36:49.176] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:49.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:175:0) after 1m0s
[23:37:49.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:175:0)
[23:37:49.202] Timer tick, asking Buildbucket for the build status
[23:37:49.285] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:49.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:176:0) after 1m0s
[23:38:49.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:176:0)
[23:38:49.318] Timer tick, asking Buildbucket for the build status
[23:38:49.541] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:49.541] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:177:0) after 1m0s
[23:39:49.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:177:0)
[23:39:49.569] Timer tick, asking Buildbucket for the build status
[23:39:49.642] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:49.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:178:0) after 1m0s
[23:40:49.673] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:178:0)
[23:40:49.673] Timer tick, asking Buildbucket for the build status
[23:40:49.952] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:49.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:179:0) after 1m0s
[23:41:49.982] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:179:0)
[23:41:49.982] Timer tick, asking Buildbucket for the build status
[23:41:50.061] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:50.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:180:0) after 1m0s
[23:42:50.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:180:0)
[23:42:50.088] Timer tick, asking Buildbucket for the build status
[23:42:50.144] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:50.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:181:0) after 1m0s
[23:43:50.181] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:181:0)
[23:43:50.181] Timer tick, asking Buildbucket for the build status
[23:43:50.272] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:50.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:182:0) after 1m0s
[23:44:50.302] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:182:0)
[23:44:50.302] Timer tick, asking Buildbucket for the build status
[23:44:50.345] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:50.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:183:0) after 1m0s
[23:45:50.402] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:183:0)
[23:45:50.402] Timer tick, asking Buildbucket for the build status
[23:45:50.468] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:50.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:184:0) after 1m0s
[23:46:50.494] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:184:0)
[23:46:50.494] Timer tick, asking Buildbucket for the build status
[23:46:50.654] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:50.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:185:0) after 1m0s
[23:47:50.680] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:185:0)
[23:47:50.680] Timer tick, asking Buildbucket for the build status
[23:47:50.754] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:50.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:186:0) after 1m0s
[23:48:50.910] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:186:0)
[23:48:50.910] Timer tick, asking Buildbucket for the build status
[23:48:50.949] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:50.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:187:0) after 1m0s
[23:49:51.218] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:187:0)
[23:49:51.218] Timer tick, asking Buildbucket for the build status
[23:49:51.298] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:51.298] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:188:0) after 1m0s
[23:50:51.628] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:188:0)
[23:50:51.628] Timer tick, asking Buildbucket for the build status
[23:50:51.674] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:51.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:189:0) after 1m0s
[23:51:51.712] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:189:0)
[23:51:51.712] Timer tick, asking Buildbucket for the build status
[23:51:51.816] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:51.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:190:0) after 1m0s
[23:52:52.286] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:190:0)
[23:52:52.286] Timer tick, asking Buildbucket for the build status
[23:52:52.362] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:52.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:191:0) after 1m0s
[23:53:52.385] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:191:0)
[23:53:52.385] Timer tick, asking Buildbucket for the build status
[23:53:52.421] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:52.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:192:0) after 1m0s
[23:54:52.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:192:0)
[23:54:52.455] Timer tick, asking Buildbucket for the build status
[23:54:52.565] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:52.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:193:0) after 1m0s
[23:55:52.589] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:193:0)
[23:55:52.589] Timer tick, asking Buildbucket for the build status
[23:55:52.907] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:52.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:194:0) after 1m0s
[23:56:52.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:194:0)
[23:56:52.932] Timer tick, asking Buildbucket for the build status
[23:56:52.970] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:52.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:195:0) after 1m0s
[23:57:53.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:195:0)
[23:57:53.345] Timer tick, asking Buildbucket for the build status
[23:57:53.566] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:53.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:196:0) after 1m0s
[23:58:54.116] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:196:0)
[23:58:54.116] Timer tick, asking Buildbucket for the build status
[23:58:54.177] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:54.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:197:0) after 1m0s
[23:59:54.686] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:197:0)
[23:59:54.686] Timer tick, asking Buildbucket for the build status
[23:59:54.780] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:54.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:198:0) after 1m0s
[00:00:55.316] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:198:0)
[00:00:55.316] Timer tick, asking Buildbucket for the build status
[00:00:55.413] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:55.413] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:199:0) after 1m0s
[00:01:55.979] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:199:0)
[00:01:55.979] Timer tick, asking Buildbucket for the build status
[00:01:56.206] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:56.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:200:0) after 1m0s
[00:02:56.644] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:200:0)
[00:02:56.644] Timer tick, asking Buildbucket for the build status
[00:02:56.685] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:56.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:201:0) after 1m0s
[00:03:57.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:201:0)
[00:03:57.071] Timer tick, asking Buildbucket for the build status
[00:03:57.134] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:57.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:202:0) after 1m0s
[00:04:57.643] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:202:0)
[00:04:57.643] Timer tick, asking Buildbucket for the build status
[00:04:57.713] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:57.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:203:0) after 1m0s
[00:05:57.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:203:0)
[00:05:57.808] Timer tick, asking Buildbucket for the build status
[00:05:57.901] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:57.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:204:0) after 1m0s
[00:06:57.988] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:204:0)
[00:06:57.988] Timer tick, asking Buildbucket for the build status
[00:06:58.090] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:58.090] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:205:0) after 1m0s
[00:07:58.128] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:205:0)
[00:07:58.128] Timer tick, asking Buildbucket for the build status
[00:07:58.179] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:58.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:206:0) after 1m0s
[00:08:58.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:206:0)
[00:08:58.203] Timer tick, asking Buildbucket for the build status
[00:08:58.315] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:58.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:207:0) after 1m0s
[00:09:58.343] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:207:0)
[00:09:58.343] Timer tick, asking Buildbucket for the build status
[00:09:58.414] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:58.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:208:0) after 1m0s
[00:10:58.444] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:208:0)
[00:10:58.444] Timer tick, asking Buildbucket for the build status
[00:10:58.642] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:58.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:209:0) after 1m0s
[00:11:58.679] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:209:0)
[00:11:58.679] Timer tick, asking Buildbucket for the build status
[00:11:58.756] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:58.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:210:0) after 1m0s
[00:12:58.780] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:210:0)
[00:12:58.780] Timer tick, asking Buildbucket for the build status
[00:12:58.925] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:58.925] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:211:0) after 1m0s
[00:13:58.949] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:211:0)
[00:13:58.949] Timer tick, asking Buildbucket for the build status
[00:13:59.054] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:59.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:212:0) after 1m0s
[00:14:59.077] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:212:0)
[00:14:59.077] Timer tick, asking Buildbucket for the build status
[00:14:59.269] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:59.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:213:0) after 1m0s
[00:15:59.386] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:213:0)
[00:15:59.386] Timer tick, asking Buildbucket for the build status
[00:15:59.544] Build 8929215997503221184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:59.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9094646059651919648:214:0) after 1m0s
[00:16:51.753] Received PubSub notification, asking Buildbucket for the build status
[00:16:51.805] Build 8929215997503221184: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[00:16:51.805] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary": true,
    "canary_preference": "AUTO",
    "completed_ts": "1542845810897055",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1542833059745530",
    "experimental": true,
    "failure_reason": "INFRA_FAILURE",
    "id": "8929215997503221184",
    "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\": \"55f40a255928a95a71a5c63b37cdf7cc6ec8acae\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3874-22d9c44\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-east1-b-7805\"], \"pool\": [\"luci.nacl.toolchain\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1542834990662704",
    "status": "COMPLETED",
    "status_changed_ts": "1542845811472692",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/9",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9094646059651919648",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_dimension:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_v2",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/9",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8929215997503221184",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:1",
      "swarming_tag:buildbucket_template_revision:586d78b1df9b356be85f0824ec8364d9ecbabf90",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-arm",
      "swarming_tag:buildset:commit/git/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/55f40a255928a95a71a5c63b37cdf7cc6ec8acae",
      "swarming_tag:caches:builder_260015d2e489656b9034d382dc1874ce0c1f399ed411416e1867fa173e3e19d1_v2",
      "swarming_tag:cores:8",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8929215997503221184/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:60",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9094646059651919648",
      "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:18bb9400d243d9bda9184c768cca1f92d5a22697",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4150d5c361a5d110",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1542845811473660",
    "url": "https://ci.chromium.org/b/8929215997503221184",
    "utcnow_ts": "1542845811791516"
  }
}
[00:16:51.805] Invocation finished in 3h32m33.493189342s with status FAILED