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

• 952e81813a66902714b68f34b51073c5d1ba6c94 (4 years ago)

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

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

[11:26:47.263] New invocation is queued and will start shortly
[11:26:48.458] Starting the invocation (attempt 1)
[11:26:48.525] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:26:48.533] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:26:48.534] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9021931771629091232",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-arm\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"952e81813a66902714b68f34b51073c5d1ba6c94\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@952e81813a66902714b68f34b51073c5d1ba6c94\",\"title\":\"952e81813a66902714b68f34b51073c5d1ba6c94\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/952e81813a66902714b68f34b51073c5d1ba6c94\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"952e81813a66902714b68f34b51073c5d1ba6c94\"}}",
  "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:9021931771629091232",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
    "user_agent:luci-scheduler",
    "buildset:commit/git/952e81813a66902714b68f34b51073c5d1ba6c94",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/952e81813a66902714b68f34b51073c5d1ba6c94",
    "gitiles_ref:refs/heads/master"
  ]
}
[11:26:49.737] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1612178808726007",
    "id": "8856501709420081472",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@952e81813a66902714b68f34b51073c5d1ba6c94\", \"title\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/952e81813a66902714b68f34b51073c5d1ba6c94\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1612178809538301",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4755",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/952e81813a66902714b68f34b51073c5d1ba6c94",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/952e81813a66902714b68f34b51073c5d1ba6c94",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021931771629091232",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8856501709420081472/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612178809538428",
    "url": "https://ci.chromium.org/b/8856501709420081472",
    "utcnow_ts": "1612178809725750"
  }
}
[11:26:49.737] Task URL: https://ci.chromium.org/b/8856501709420081472
[11:26:49.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:2:0) after 1m0s
[11:27:40.026] Received PubSub notification, asking Buildbucket for the build status
[11:27:40.111] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:49.986] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:2:0)
[11:27:49.986] Timer tick, asking Buildbucket for the build status
[11:27:50.068] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:50.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:4:0) after 1m0s
[11:28:50.144] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:4:0)
[11:28:50.144] Timer tick, asking Buildbucket for the build status
[11:28:50.268] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:50.268] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:5:0) after 1m0s
[11:29:50.292] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:5:0)
[11:29:50.292] Timer tick, asking Buildbucket for the build status
[11:29:50.372] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:50.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:6:0) after 1m0s
[11:30:50.375] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:6:0)
[11:30:50.375] Timer tick, asking Buildbucket for the build status
[11:30:50.806] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:50.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:7:0) after 1m0s
[11:31:50.835] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:7:0)
[11:31:50.835] Timer tick, asking Buildbucket for the build status
[11:31:50.936] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:50.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:8:0) after 1m0s
[11:32:50.954] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:8:0)
[11:32:50.954] Timer tick, asking Buildbucket for the build status
[11:32:51.340] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:51.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:9:0) after 1m0s
[11:33:51.424] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:9:0)
[11:33:51.424] Timer tick, asking Buildbucket for the build status
[11:33:51.640] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:51.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:10:0) after 1m0s
[11:34:51.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:10:0)
[11:34:51.660] Timer tick, asking Buildbucket for the build status
[11:34:51.989] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:51.989] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:11:0) after 1m0s
[11:35:51.973] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:11:0)
[11:35:51.973] Timer tick, asking Buildbucket for the build status
[11:35:52.067] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:52.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:12:0) after 1m0s
[11:36:52.062] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:12:0)
[11:36:52.063] Timer tick, asking Buildbucket for the build status
[11:36:52.528] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:52.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:13:0) after 1m0s
[11:37:52.560] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:13:0)
[11:37:52.560] Timer tick, asking Buildbucket for the build status
[11:37:52.716] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:52.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:14:0) after 1m0s
[11:38:52.742] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:14:0)
[11:38:52.742] Timer tick, asking Buildbucket for the build status
[11:38:52.852] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:52.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:15:0) after 1m0s
[11:39:52.826] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:15:0)
[11:39:52.826] Timer tick, asking Buildbucket for the build status
[11:39:52.953] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:52.953] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:16:0) after 1m0s
[11:40:53.038] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:16:0)
[11:40:53.038] Timer tick, asking Buildbucket for the build status
[11:40:53.310] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:53.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:17:0) after 1m0s
[11:41:53.368] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:17:0)
[11:41:53.368] Timer tick, asking Buildbucket for the build status
[11:41:53.506] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:53.506] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:18:0) after 1m0s
[11:42:53.519] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:18:0)
[11:42:53.519] Timer tick, asking Buildbucket for the build status
[11:42:53.614] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:53.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:19:0) after 1m0s
[11:43:53.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:19:0)
[11:43:53.701] Timer tick, asking Buildbucket for the build status
[11:43:53.821] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:53.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:20:0) after 1m0s
[11:44:53.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:20:0)
[11:44:53.906] Timer tick, asking Buildbucket for the build status
[11:44:54.034] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:54.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:21:0) after 1m0s
[11:45:54.056] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:21:0)
[11:45:54.056] Timer tick, asking Buildbucket for the build status
[11:45:54.167] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:54.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:22:0) after 1m0s
[11:46:54.201] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:22:0)
[11:46:54.201] Timer tick, asking Buildbucket for the build status
[11:46:54.367] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:54.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:23:0) after 1m0s
[11:47:54.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:23:0)
[11:47:54.414] Timer tick, asking Buildbucket for the build status
[11:47:54.916] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:54.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:24:0) after 1m0s
[11:48:54.949] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:24:0)
[11:48:54.949] Timer tick, asking Buildbucket for the build status
[11:48:55.129] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:55.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:25:0) after 1m0s
[11:49:55.151] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:25:0)
[11:49:55.151] Timer tick, asking Buildbucket for the build status
[11:49:55.275] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:55.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:26:0) after 1m0s
[11:50:55.338] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:26:0)
[11:50:55.338] Timer tick, asking Buildbucket for the build status
[11:50:55.464] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:55.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:27:0) after 1m0s
[11:51:55.591] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:27:0)
[11:51:55.591] Timer tick, asking Buildbucket for the build status
[11:51:55.859] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:55.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:28:0) after 1m0s
[11:52:55.882] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:28:0)
[11:52:55.882] Timer tick, asking Buildbucket for the build status
[11:52:56.019] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:56.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:29:0) after 1m0s
[11:53:56.074] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:29:0)
[11:53:56.074] Timer tick, asking Buildbucket for the build status
[11:53:56.138] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:56.138] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:30:0) after 1m0s
[11:54:56.165] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:30:0)
[11:54:56.165] Timer tick, asking Buildbucket for the build status
[11:54:56.222] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:56.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:31:0) after 1m0s
[11:55:56.249] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:31:0)
[11:55:56.249] Timer tick, asking Buildbucket for the build status
[11:55:56.336] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:56.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:32:0) after 1m0s
[11:56:56.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:32:0)
[11:56:56.397] Timer tick, asking Buildbucket for the build status
[11:56:56.522] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:56.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:33:0) after 1m0s
[11:57:56.540] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:33:0)
[11:57:56.540] Timer tick, asking Buildbucket for the build status
[11:57:56.910] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:56.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:34:0) after 1m0s
[11:58:56.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:34:0)
[11:58:56.971] Timer tick, asking Buildbucket for the build status
[11:58:57.059] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:57.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:35:0) after 1m0s
[11:59:57.124] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:35:0)
[11:59:57.124] Timer tick, asking Buildbucket for the build status
[11:59:57.451] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:57.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:36:0) after 1m0s
[12:00:57.546] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:36:0)
[12:00:57.546] Timer tick, asking Buildbucket for the build status
[12:00:57.628] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:57.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:37:0) after 1m0s
[12:01:57.699] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:37:0)
[12:01:57.699] Timer tick, asking Buildbucket for the build status
[12:01:58.012] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:58.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:38:0) after 1m0s
[12:02:58.122] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:38:0)
[12:02:58.122] Timer tick, asking Buildbucket for the build status
[12:02:58.190] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:58.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:39:0) after 1m0s
[12:03:58.413] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:39:0)
[12:03:58.413] Timer tick, asking Buildbucket for the build status
[12:03:58.483] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:58.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:40:0) after 1m0s
[12:04:58.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:40:0)
[12:04:58.556] Timer tick, asking Buildbucket for the build status
[12:04:58.622] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:58.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:41:0) after 1m0s
[12:05:58.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:41:0)
[12:05:58.755] Timer tick, asking Buildbucket for the build status
[12:05:58.813] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:58.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:42:0) after 1m0s
[12:06:59.107] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:42:0)
[12:06:59.107] Timer tick, asking Buildbucket for the build status
[12:06:59.237] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:59.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:43:0) after 1m0s
[12:07:59.365] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:43:0)
[12:07:59.365] Timer tick, asking Buildbucket for the build status
[12:08:00.135] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:00.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:44:0) after 1m0s
[12:09:00.163] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:44:0)
[12:09:00.163] Timer tick, asking Buildbucket for the build status
[12:09:00.279] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:00.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:45:0) after 1m0s
[12:10:00.364] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:45:0)
[12:10:00.364] Timer tick, asking Buildbucket for the build status
[12:10:00.462] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:00.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:46:0) after 1m0s
[12:11:00.620] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:46:0)
[12:11:00.620] Timer tick, asking Buildbucket for the build status
[12:11:00.800] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:00.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:47:0) after 1m0s
[12:12:01.205] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:47:0)
[12:12:01.205] Timer tick, asking Buildbucket for the build status
[12:12:01.579] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:01.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:48:0) after 1m0s
[12:13:01.696] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:48:0)
[12:13:01.696] Timer tick, asking Buildbucket for the build status
[12:13:01.911] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:01.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:49:0) after 1m0s
[12:14:01.977] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:49:0)
[12:14:01.977] Timer tick, asking Buildbucket for the build status
[12:14:02.217] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:02.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:50:0) after 1m0s
[12:15:02.258] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:50:0)
[12:15:02.258] Timer tick, asking Buildbucket for the build status
[12:15:02.359] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:02.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:51:0) after 1m0s
[12:16:02.416] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:51:0)
[12:16:02.416] Timer tick, asking Buildbucket for the build status
[12:16:02.522] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:02.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:52:0) after 1m0s
[12:17:02.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:52:0)
[12:17:02.723] Timer tick, asking Buildbucket for the build status
[12:17:02.833] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:02.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:53:0) after 1m0s
[12:18:02.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:53:0)
[12:18:02.932] Timer tick, asking Buildbucket for the build status
[12:18:03.062] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:03.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:54:0) after 1m0s
[12:19:03.163] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:54:0)
[12:19:03.163] Timer tick, asking Buildbucket for the build status
[12:19:03.695] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:03.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:55:0) after 1m0s
[12:20:03.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:55:0)
[12:20:03.701] Timer tick, asking Buildbucket for the build status
[12:20:03.866] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:03.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:56:0) after 1m0s
[12:21:03.893] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:56:0)
[12:21:03.893] Timer tick, asking Buildbucket for the build status
[12:21:03.963] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:03.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:57:0) after 1m0s
[12:22:03.985] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:57:0)
[12:22:03.985] Timer tick, asking Buildbucket for the build status
[12:22:04.115] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:04.115] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:58:0) after 1m0s
[12:23:04.159] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:58:0)
[12:23:04.159] Timer tick, asking Buildbucket for the build status
[12:23:04.296] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:04.296] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:59:0) after 1m0s
[12:24:04.361] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:59:0)
[12:24:04.361] Timer tick, asking Buildbucket for the build status
[12:24:04.461] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:04.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:60:0) after 1m0s
[12:25:04.530] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:60:0)
[12:25:04.530] Timer tick, asking Buildbucket for the build status
[12:25:04.651] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:04.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:61:0) after 1m0s
[12:26:04.653] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:61:0)
[12:26:04.653] Timer tick, asking Buildbucket for the build status
[12:26:05.010] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:05.010] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:62:0) after 1m0s
[12:27:05.113] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:62:0)
[12:27:05.113] Timer tick, asking Buildbucket for the build status
[12:27:05.378] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:05.378] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:63:0) after 1m0s
[12:28:05.520] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:63:0)
[12:28:05.520] Timer tick, asking Buildbucket for the build status
[12:28:05.692] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:05.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:64:0) after 1m0s
[12:29:05.733] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:64:0)
[12:29:05.733] Timer tick, asking Buildbucket for the build status
[12:29:05.969] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:05.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:65:0) after 1m0s
[12:30:05.978] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:65:0)
[12:30:05.978] Timer tick, asking Buildbucket for the build status
[12:30:06.097] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:06.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:66:0) after 1m0s
[12:31:06.196] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:66:0)
[12:31:06.196] Timer tick, asking Buildbucket for the build status
[12:31:06.322] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:06.322] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:67:0) after 1m0s
[12:32:06.390] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:67:0)
[12:32:06.390] Timer tick, asking Buildbucket for the build status
[12:32:06.892] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:06.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:68:0) after 1m0s
[12:33:06.986] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:68:0)
[12:33:06.986] Timer tick, asking Buildbucket for the build status
[12:33:07.072] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:07.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:69:0) after 1m0s
[12:34:07.118] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:69:0)
[12:34:07.118] Timer tick, asking Buildbucket for the build status
[12:34:07.206] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:07.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:70:0) after 1m0s
[12:35:07.237] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:70:0)
[12:35:07.237] Timer tick, asking Buildbucket for the build status
[12:35:07.309] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:07.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:71:0) after 1m0s
[12:36:07.345] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:71:0)
[12:36:07.345] Timer tick, asking Buildbucket for the build status
[12:36:07.734] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:07.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:72:0) after 1m0s
[12:37:07.767] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:72:0)
[12:37:07.767] Timer tick, asking Buildbucket for the build status
[12:37:07.869] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:07.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:73:0) after 1m0s
[12:38:07.918] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:73:0)
[12:38:07.918] Timer tick, asking Buildbucket for the build status
[12:38:08.273] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:08.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:74:0) after 1m0s
[12:39:08.329] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:74:0)
[12:39:08.329] Timer tick, asking Buildbucket for the build status
[12:39:08.441] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:08.441] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:75:0) after 1m0s
[12:40:08.467] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:75:0)
[12:40:08.467] Timer tick, asking Buildbucket for the build status
[12:40:08.751] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:08.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:76:0) after 1m0s
[12:41:08.785] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:76:0)
[12:41:08.785] Timer tick, asking Buildbucket for the build status
[12:41:08.863] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:08.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:77:0) after 1m0s
[12:42:08.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:77:0)
[12:42:08.900] Timer tick, asking Buildbucket for the build status
[12:42:09.142] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:09.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:78:0) after 1m0s
[12:43:09.278] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:78:0)
[12:43:09.278] Timer tick, asking Buildbucket for the build status
[12:43:09.411] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:09.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:79:0) after 1m0s
[12:44:09.461] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:79:0)
[12:44:09.461] Timer tick, asking Buildbucket for the build status
[12:44:09.783] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:09.783] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:80:0) after 1m0s
[12:45:09.794] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:80:0)
[12:45:09.794] Timer tick, asking Buildbucket for the build status
[12:45:09.860] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:09.860] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:81:0) after 1m0s
[12:46:09.905] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:81:0)
[12:46:09.905] Timer tick, asking Buildbucket for the build status
[12:46:10.021] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:10.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:82:0) after 1m0s
[12:47:10.105] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:82:0)
[12:47:10.105] Timer tick, asking Buildbucket for the build status
[12:47:10.271] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:10.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:83:0) after 1m0s
[12:48:10.296] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:83:0)
[12:48:10.296] Timer tick, asking Buildbucket for the build status
[12:48:10.373] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:10.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:84:0) after 1m0s
[12:49:10.581] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:84:0)
[12:49:10.581] Timer tick, asking Buildbucket for the build status
[12:49:10.723] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:10.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:85:0) after 1m0s
[12:50:10.752] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:85:0)
[12:50:10.752] Timer tick, asking Buildbucket for the build status
[12:50:10.813] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:10.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:86:0) after 1m0s
[12:51:10.861] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:86:0)
[12:51:10.861] Timer tick, asking Buildbucket for the build status
[12:51:10.931] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:10.931] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:87:0) after 1m0s
[12:52:11.313] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:87:0)
[12:52:11.313] Timer tick, asking Buildbucket for the build status
[12:52:11.632] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:11.632] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:88:0) after 1m0s
[12:53:11.877] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:88:0)
[12:53:11.877] Timer tick, asking Buildbucket for the build status
[12:53:12.314] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:12.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:89:0) after 1m0s
[12:54:12.429] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:89:0)
[12:54:12.429] Timer tick, asking Buildbucket for the build status
[12:54:12.627] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:12.627] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:90:0) after 1m0s
[12:55:12.726] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:90:0)
[12:55:12.726] Timer tick, asking Buildbucket for the build status
[12:55:12.823] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:12.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:91:0) after 1m0s
[12:56:13.100] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:91:0)
[12:56:13.100] Timer tick, asking Buildbucket for the build status
[12:56:13.169] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:13.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:92:0) after 1m0s
[12:57:13.302] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:92:0)
[12:57:13.302] Timer tick, asking Buildbucket for the build status
[12:57:13.398] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:13.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:93:0) after 1m0s
[12:58:13.489] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:93:0)
[12:58:13.489] Timer tick, asking Buildbucket for the build status
[12:58:13.603] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:13.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:94:0) after 1m0s
[12:59:13.761] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:94:0)
[12:59:13.761] Timer tick, asking Buildbucket for the build status
[12:59:13.952] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:13.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:95:0) after 1m0s
[13:00:13.994] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:95:0)
[13:00:13.994] Timer tick, asking Buildbucket for the build status
[13:00:14.083] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:14.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:96:0) after 1m0s
[13:01:14.116] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:96:0)
[13:01:14.116] Timer tick, asking Buildbucket for the build status
[13:01:14.177] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:14.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:97:0) after 1m0s
[13:02:14.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:97:0)
[13:02:14.217] Timer tick, asking Buildbucket for the build status
[13:02:14.315] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:14.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:98:0) after 1m0s
[13:03:14.364] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:98:0)
[13:03:14.364] Timer tick, asking Buildbucket for the build status
[13:03:14.423] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:14.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:99:0) after 1m0s
[13:04:14.432] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:99:0)
[13:04:14.432] Timer tick, asking Buildbucket for the build status
[13:04:14.501] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:14.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:100:0) after 1m0s
[13:05:14.603] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:100:0)
[13:05:14.603] Timer tick, asking Buildbucket for the build status
[13:05:15.020] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:15.020] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:101:0) after 1m0s
[13:06:15.111] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:101:0)
[13:06:15.111] Timer tick, asking Buildbucket for the build status
[13:06:15.185] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:15.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:102:0) after 1m0s
[13:07:15.235] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:102:0)
[13:07:15.235] Timer tick, asking Buildbucket for the build status
[13:07:15.362] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:15.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:103:0) after 1m0s
[13:08:15.368] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:103:0)
[13:08:15.368] Timer tick, asking Buildbucket for the build status
[13:08:15.438] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:15.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:104:0) after 1m0s
[13:09:15.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:104:0)
[13:09:15.497] Timer tick, asking Buildbucket for the build status
[13:09:15.579] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:15.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:105:0) after 1m0s
[13:10:15.627] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:105:0)
[13:10:15.627] Timer tick, asking Buildbucket for the build status
[13:10:15.917] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:15.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:106:0) after 1m0s
[13:11:15.973] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:106:0)
[13:11:15.973] Timer tick, asking Buildbucket for the build status
[13:11:16.046] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:16.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:107:0) after 1m0s
[13:12:16.113] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:107:0)
[13:12:16.113] Timer tick, asking Buildbucket for the build status
[13:12:16.243] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:16.243] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:108:0) after 1m0s
[13:13:16.295] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:108:0)
[13:13:16.295] Timer tick, asking Buildbucket for the build status
[13:13:16.622] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:16.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:109:0) after 1m0s
[13:14:16.625] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:109:0)
[13:14:16.625] Timer tick, asking Buildbucket for the build status
[13:14:16.693] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:16.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:110:0) after 1m0s
[13:15:16.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:110:0)
[13:15:16.721] Timer tick, asking Buildbucket for the build status
[13:15:16.794] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:16.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:111:0) after 1m0s
[13:16:16.797] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:111:0)
[13:16:16.797] Timer tick, asking Buildbucket for the build status
[13:16:16.917] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:16.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:112:0) after 1m0s
[13:17:17.002] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:112:0)
[13:17:17.002] Timer tick, asking Buildbucket for the build status
[13:17:17.137] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:17.137] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:113:0) after 1m0s
[13:18:17.309] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:113:0)
[13:18:17.309] Timer tick, asking Buildbucket for the build status
[13:18:17.379] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:17.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:114:0) after 1m0s
[13:19:17.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:114:0)
[13:19:17.459] Timer tick, asking Buildbucket for the build status
[13:19:17.630] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:17.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:115:0) after 1m0s
[13:20:17.707] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:115:0)
[13:20:17.707] Timer tick, asking Buildbucket for the build status
[13:20:17.785] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:17.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:116:0) after 1m0s
[13:21:17.989] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:116:0)
[13:21:17.989] Timer tick, asking Buildbucket for the build status
[13:21:18.104] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:18.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:117:0) after 1m0s
[13:22:18.359] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:117:0)
[13:22:18.359] Timer tick, asking Buildbucket for the build status
[13:22:18.487] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:18.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:118:0) after 1m0s
[13:23:20.520] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:118:0)
[13:23:20.520] Timer tick, asking Buildbucket for the build status
[13:23:20.583] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:20.583] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:119:0) after 1m0s
[13:24:20.641] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:119:0)
[13:24:20.641] Timer tick, asking Buildbucket for the build status
[13:24:20.708] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:20.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:120:0) after 1m0s
[13:25:20.731] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:120:0)
[13:25:20.731] Timer tick, asking Buildbucket for the build status
[13:25:20.810] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:20.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:121:0) after 1m0s
[13:26:20.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:121:0)
[13:26:20.921] Timer tick, asking Buildbucket for the build status
[13:26:20.988] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:20.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:122:0) after 1m0s
[13:27:21.053] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:122:0)
[13:27:21.053] Timer tick, asking Buildbucket for the build status
[13:27:21.163] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:21.163] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:123:0) after 1m0s
[13:28:21.174] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:123:0)
[13:28:21.174] Timer tick, asking Buildbucket for the build status
[13:28:21.378] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:21.378] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:124:0) after 1m0s
[13:29:21.470] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:124:0)
[13:29:21.470] Timer tick, asking Buildbucket for the build status
[13:29:22.367] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:22.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:125:0) after 1m0s
[13:30:22.424] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:125:0)
[13:30:22.424] Timer tick, asking Buildbucket for the build status
[13:30:22.698] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:22.698] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:126:0) after 1m0s
[13:31:22.814] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:126:0)
[13:31:22.814] Timer tick, asking Buildbucket for the build status
[13:31:22.936] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:22.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:127:0) after 1m0s
[13:32:23.024] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:127:0)
[13:32:23.024] Timer tick, asking Buildbucket for the build status
[13:32:23.664] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:23.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:128:0) after 1m0s
[13:33:23.669] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:128:0)
[13:33:23.669] Timer tick, asking Buildbucket for the build status
[13:33:23.735] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:23.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:129:0) after 1m0s
[13:34:23.779] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:129:0)
[13:34:23.779] Timer tick, asking Buildbucket for the build status
[13:34:24.103] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:24.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:130:0) after 1m0s
[13:35:24.165] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:130:0)
[13:35:24.165] Timer tick, asking Buildbucket for the build status
[13:35:24.250] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:24.250] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:131:0) after 1m0s
[13:36:24.332] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:131:0)
[13:36:24.333] Timer tick, asking Buildbucket for the build status
[13:36:24.409] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:24.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:132:0) after 1m0s
[13:37:24.469] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:132:0)
[13:37:24.469] Timer tick, asking Buildbucket for the build status
[13:37:24.604] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:24.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:133:0) after 1m0s
[13:38:24.673] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:133:0)
[13:38:24.673] Timer tick, asking Buildbucket for the build status
[13:38:24.745] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:24.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:134:0) after 1m0s
[13:39:24.807] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:134:0)
[13:39:24.807] Timer tick, asking Buildbucket for the build status
[13:39:24.982] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:24.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:135:0) after 1m0s
[13:40:25.048] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:135:0)
[13:40:25.048] Timer tick, asking Buildbucket for the build status
[13:40:25.130] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:25.130] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:136:0) after 1m0s
[13:41:25.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:136:0)
[13:41:25.217] Timer tick, asking Buildbucket for the build status
[13:41:25.277] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:25.277] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:137:0) after 1m0s
[13:42:25.321] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:137:0)
[13:42:25.321] Timer tick, asking Buildbucket for the build status
[13:42:25.441] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:25.441] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:138:0) after 1m0s
[13:43:25.490] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:138:0)
[13:43:25.490] Timer tick, asking Buildbucket for the build status
[13:43:25.597] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:25.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:139:0) after 1m0s
[13:44:25.620] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:139:0)
[13:44:25.620] Timer tick, asking Buildbucket for the build status
[13:44:25.691] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:25.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:140:0) after 1m0s
[13:45:25.833] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:140:0)
[13:45:25.833] Timer tick, asking Buildbucket for the build status
[13:45:25.895] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:25.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:141:0) after 1m0s
[13:46:26.013] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:141:0)
[13:46:26.013] Timer tick, asking Buildbucket for the build status
[13:46:26.208] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:26.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:142:0) after 1m0s
[13:47:26.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:142:0)
[13:47:26.300] Timer tick, asking Buildbucket for the build status
[13:47:26.468] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:26.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:143:0) after 1m0s
[13:48:26.580] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:143:0)
[13:48:26.580] Timer tick, asking Buildbucket for the build status
[13:48:26.654] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:26.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:144:0) after 1m0s
[13:49:26.786] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:144:0)
[13:49:26.786] Timer tick, asking Buildbucket for the build status
[13:49:26.884] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:26.884] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:145:0) after 1m0s
[13:50:27.094] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:145:0)
[13:50:27.094] Timer tick, asking Buildbucket for the build status
[13:50:27.256] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:27.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:146:0) after 1m0s
[13:51:27.255] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:146:0)
[13:51:27.255] Timer tick, asking Buildbucket for the build status
[13:51:27.336] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:27.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:147:0) after 1m0s
[13:52:27.383] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:147:0)
[13:52:27.383] Timer tick, asking Buildbucket for the build status
[13:52:27.488] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:27.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:148:0) after 1m0s
[13:53:27.567] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:148:0)
[13:53:27.567] Timer tick, asking Buildbucket for the build status
[13:53:27.656] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:27.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:149:0) after 1m0s
[13:54:27.682] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:149:0)
[13:54:27.682] Timer tick, asking Buildbucket for the build status
[13:54:27.766] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:27.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:150:0) after 1m0s
[13:55:27.831] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:150:0)
[13:55:27.831] Timer tick, asking Buildbucket for the build status
[13:55:27.942] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:27.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:151:0) after 1m0s
[13:56:28.069] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:151:0)
[13:56:28.069] Timer tick, asking Buildbucket for the build status
[13:56:28.126] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:28.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:152:0) after 1m0s
[13:57:28.232] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:152:0)
[13:57:28.232] Timer tick, asking Buildbucket for the build status
[13:57:28.695] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:28.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:153:0) after 1m0s
[13:58:28.706] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:153:0)
[13:58:28.706] Timer tick, asking Buildbucket for the build status
[13:58:28.874] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:28.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:154:0) after 1m0s
[13:59:29.004] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:154:0)
[13:59:29.004] Timer tick, asking Buildbucket for the build status
[13:59:29.084] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:29.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:155:0) after 1m0s
[14:00:29.407] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:155:0)
[14:00:29.407] Timer tick, asking Buildbucket for the build status
[14:00:29.492] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:29.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:156:0) after 1m0s
[14:01:29.703] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:156:0)
[14:01:29.703] Timer tick, asking Buildbucket for the build status
[14:01:29.928] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:29.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:157:0) after 1m0s
[14:02:30.002] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:157:0)
[14:02:30.002] Timer tick, asking Buildbucket for the build status
[14:02:30.122] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:30.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:158:0) after 1m0s
[14:03:30.179] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:158:0)
[14:03:30.179] Timer tick, asking Buildbucket for the build status
[14:03:30.242] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:30.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:159:0) after 1m0s
[14:04:30.383] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:159:0)
[14:04:30.383] Timer tick, asking Buildbucket for the build status
[14:04:30.516] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:30.516] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:160:0) after 1m0s
[14:05:30.702] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:160:0)
[14:05:30.702] Timer tick, asking Buildbucket for the build status
[14:05:31.012] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:31.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:161:0) after 1m0s
[14:06:31.084] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:161:0)
[14:06:31.084] Timer tick, asking Buildbucket for the build status
[14:06:31.182] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:31.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:162:0) after 1m0s
[14:07:31.288] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:162:0)
[14:07:31.288] Timer tick, asking Buildbucket for the build status
[14:07:31.417] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:31.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:163:0) after 1m0s
[14:08:31.487] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:163:0)
[14:08:31.487] Timer tick, asking Buildbucket for the build status
[14:08:31.559] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:31.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:164:0) after 1m0s
[14:09:31.664] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:164:0)
[14:09:31.664] Timer tick, asking Buildbucket for the build status
[14:09:31.850] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:31.850] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:165:0) after 1m0s
[14:10:31.964] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:165:0)
[14:10:31.964] Timer tick, asking Buildbucket for the build status
[14:10:32.040] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:32.040] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:166:0) after 1m0s
[14:11:32.093] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:166:0)
[14:11:32.093] Timer tick, asking Buildbucket for the build status
[14:11:32.253] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:32.253] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:167:0) after 1m0s
[14:12:33.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:167:0)
[14:12:33.280] Timer tick, asking Buildbucket for the build status
[14:12:33.402] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:33.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:168:0) after 1m0s
[14:13:33.458] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:168:0)
[14:13:33.458] Timer tick, asking Buildbucket for the build status
[14:13:33.527] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:33.527] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:169:0) after 1m0s
[14:14:33.592] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:169:0)
[14:14:33.592] Timer tick, asking Buildbucket for the build status
[14:14:34.122] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:34.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:170:0) after 1m0s
[14:15:34.117] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:170:0)
[14:15:34.117] Timer tick, asking Buildbucket for the build status
[14:15:34.227] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:34.227] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:171:0) after 1m0s
[14:16:34.265] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:171:0)
[14:16:34.265] Timer tick, asking Buildbucket for the build status
[14:16:34.333] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:34.333] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:172:0) after 1m0s
[14:17:34.409] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:172:0)
[14:17:34.409] Timer tick, asking Buildbucket for the build status
[14:17:34.563] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:34.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:173:0) after 1m0s
[14:18:34.664] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:173:0)
[14:18:34.664] Timer tick, asking Buildbucket for the build status
[14:18:34.776] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:34.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:174:0) after 1m0s
[14:19:34.805] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:174:0)
[14:19:34.805] Timer tick, asking Buildbucket for the build status
[14:19:34.923] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:34.923] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:175:0) after 1m0s
[14:20:34.999] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:175:0)
[14:20:34.999] Timer tick, asking Buildbucket for the build status
[14:20:35.073] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:35.073] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:176:0) after 1m0s
[14:21:35.293] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:176:0)
[14:21:35.293] Timer tick, asking Buildbucket for the build status
[14:21:35.435] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:35.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:177:0) after 1m0s
[14:22:35.508] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:177:0)
[14:22:35.508] Timer tick, asking Buildbucket for the build status
[14:22:35.894] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:35.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:178:0) after 1m0s
[14:23:35.895] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:178:0)
[14:23:35.895] Timer tick, asking Buildbucket for the build status
[14:23:36.229] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:36.229] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:179:0) after 1m0s
[14:24:36.307] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:179:0)
[14:24:36.307] Timer tick, asking Buildbucket for the build status
[14:24:36.380] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:36.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:180:0) after 1m0s
[14:25:36.446] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:180:0)
[14:25:36.446] Timer tick, asking Buildbucket for the build status
[14:25:36.836] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:36.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:181:0) after 1m0s
[14:26:36.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:181:0)
[14:26:36.906] Timer tick, asking Buildbucket for the build status
[14:26:36.970] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:36.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:182:0) after 1m0s
[14:27:37.046] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:182:0)
[14:27:37.046] Timer tick, asking Buildbucket for the build status
[14:27:37.186] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:37.186] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:183:0) after 1m0s
[14:28:37.236] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:183:0)
[14:28:37.236] Timer tick, asking Buildbucket for the build status
[14:28:37.333] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:37.333] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:184:0) after 1m0s
[14:29:37.382] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:184:0)
[14:29:37.382] Timer tick, asking Buildbucket for the build status
[14:29:37.532] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:37.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:185:0) after 1m0s
[14:30:37.578] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:185:0)
[14:30:37.578] Timer tick, asking Buildbucket for the build status
[14:30:37.724] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:37.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:186:0) after 1m0s
[14:31:37.744] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:186:0)
[14:31:37.744] Timer tick, asking Buildbucket for the build status
[14:31:37.883] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:37.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:187:0) after 1m0s
[14:32:37.916] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:187:0)
[14:32:37.916] Timer tick, asking Buildbucket for the build status
[14:32:38.047] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:38.047] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:188:0) after 1m0s
[14:33:38.144] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:188:0)
[14:33:38.144] Timer tick, asking Buildbucket for the build status
[14:33:38.211] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:38.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:189:0) after 1m0s
[14:34:38.306] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:189:0)
[14:34:38.306] Timer tick, asking Buildbucket for the build status
[14:34:38.408] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:38.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:190:0) after 1m0s
[14:35:38.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:190:0)
[14:35:38.535] Timer tick, asking Buildbucket for the build status
[14:35:38.631] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:38.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:191:0) after 1m0s
[14:36:38.793] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:191:0)
[14:36:38.793] Timer tick, asking Buildbucket for the build status
[14:36:38.889] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:38.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:192:0) after 1m0s
[14:37:38.931] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:192:0)
[14:37:38.931] Timer tick, asking Buildbucket for the build status
[14:37:39.035] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:39.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:193:0) after 1m0s
[14:38:39.132] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:193:0)
[14:38:39.132] Timer tick, asking Buildbucket for the build status
[14:38:39.327] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:39.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:194:0) after 1m0s
[14:39:39.311] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:194:0)
[14:39:39.311] Timer tick, asking Buildbucket for the build status
[14:39:39.554] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:39.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:195:0) after 1m0s
[14:40:39.592] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:195:0)
[14:40:39.592] Timer tick, asking Buildbucket for the build status
[14:40:40.042] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:40.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:196:0) after 1m0s
[14:41:40.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:196:0)
[14:41:40.127] Timer tick, asking Buildbucket for the build status
[14:41:40.239] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:40.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:197:0) after 1m0s
[14:42:40.259] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:197:0)
[14:42:40.259] Timer tick, asking Buildbucket for the build status
[14:42:40.654] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:40.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:198:0) after 1m0s
[14:43:40.737] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:198:0)
[14:43:40.737] Timer tick, asking Buildbucket for the build status
[14:43:40.924] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:40.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:199:0) after 1m0s
[14:44:40.948] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:199:0)
[14:44:40.948] Timer tick, asking Buildbucket for the build status
[14:44:41.227] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:41.227] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:200:0) after 1m0s
[14:45:41.301] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:200:0)
[14:45:41.301] Timer tick, asking Buildbucket for the build status
[14:45:41.508] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:41.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:201:0) after 1m0s
[14:46:41.570] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:201:0)
[14:46:41.570] Timer tick, asking Buildbucket for the build status
[14:46:41.644] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:41.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:202:0) after 1m0s
[14:47:41.724] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:202:0)
[14:47:41.724] Timer tick, asking Buildbucket for the build status
[14:47:41.901] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:41.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:203:0) after 1m0s
[14:48:41.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:203:0)
[14:48:41.932] Timer tick, asking Buildbucket for the build status
[14:48:42.146] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:42.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:204:0) after 1m0s
[14:49:42.146] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:204:0)
[14:49:42.146] Timer tick, asking Buildbucket for the build status
[14:49:42.204] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:42.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:205:0) after 1m0s
[14:50:42.322] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:205:0)
[14:50:42.322] Timer tick, asking Buildbucket for the build status
[14:50:42.512] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:42.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:206:0) after 1m0s
[14:51:42.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:206:0)
[14:51:42.536] Timer tick, asking Buildbucket for the build status
[14:51:42.797] Build 8856501709420081472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:42.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9021931771629091232:207:0) after 1m0s
[14:52:34.805] Received PubSub notification, asking Buildbucket for the build status
[14:52:34.983] Build 8856501709420081472: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[14:52:34.984] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "completed_ts": "1612191154439004",
    "created_by": "project:nacl",
    "created_ts": "1612178808726007",
    "failure_reason": "BUILD_FAILURE",
    "id": "8856501709420081472",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@952e81813a66902714b68f34b51073c5d1ba6c94\", \"title\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/952e81813a66902714b68f34b51073c5d1ba6c94\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"Step('annotated steps') (retcode: 1)\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@952e81813a66902714b68f34b51073c5d1ba6c94\", \"title\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/952e81813a66902714b68f34b51073c5d1ba6c94\"}]}, \"bot_id\": \"luci-nacl-toolchain-xenial-1-9j8n\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.nacl.toolchain\", \"buildername\": \"linux-pnacl-x86_64-tests-arm\", \"buildnumber\": 4755, \"got_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"16\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-nacl-toolchain-xenial-1-9j8n\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.nacl.toolchain\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}, \"ui\": {\"info\": \"Step('annotated steps') (retcode: 1)\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1612178859228325",
    "status": "COMPLETED",
    "status_changed_ts": "1612178859767646",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4755",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/952e81813a66902714b68f34b51073c5d1ba6c94",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/952e81813a66902714b68f34b51073c5d1ba6c94",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021931771629091232",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8856501709420081472/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:517629ec44627410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612191154536250",
    "url": "https://ci.chromium.org/b/8856501709420081472",
    "utcnow_ts": "1612191154976630"
  }
}
[14:52:34.984] Invocation finished in 3h25m47.748421922s with status FAILED