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

• 4ad2ff292145e8613ec371302875f0eaf8b4fa14 (4 years ago)

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

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

[09:31:32.879] New invocation is queued and will start shortly
[09:31:34.084] Starting the invocation (attempt 1)
[09:31:34.127] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:31:34.128] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:31:34.128] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9020308276491961984",
  "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\":\"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4ad2ff292145e8613ec371302875f0eaf8b4fa14\",\"title\":\"4ad2ff292145e8613ec371302875f0eaf8b4fa14\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}}",
  "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:9020308276491961984",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
    "user_agent:luci-scheduler",
    "buildset:commit/git/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
    "gitiles_ref:refs/heads/master"
  ]
}
[09:31:34.825] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1613727094241231",
    "id": "8854878214387670112",
    "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\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"title\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1613727094596787",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4762",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020308276491961984",
      "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/8854878214387670112/+/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": "1613727094596903",
    "url": "https://ci.chromium.org/b/8854878214387670112",
    "utcnow_ts": "1613727094815108"
  }
}
[09:31:34.825] Task URL: https://ci.chromium.org/b/8854878214387670112
[09:31:34.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:2:0) after 1m0s
[09:31:59.965] Received PubSub notification, asking Buildbucket for the build status
[09:32:00.157] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:35.112] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:2:0)
[09:32:35.112] Timer tick, asking Buildbucket for the build status
[09:32:35.174] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:35.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:4:0) after 1m0s
[09:33:35.269] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:4:0)
[09:33:35.269] Timer tick, asking Buildbucket for the build status
[09:33:35.387] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:35.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:5:0) after 1m0s
[09:34:35.418] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:5:0)
[09:34:35.418] Timer tick, asking Buildbucket for the build status
[09:34:35.597] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:35.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:6:0) after 1m0s
[09:35:35.762] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:6:0)
[09:35:35.762] Timer tick, asking Buildbucket for the build status
[09:35:36.050] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:36.050] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:7:0) after 1m0s
[09:36:36.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:7:0)
[09:36:36.203] Timer tick, asking Buildbucket for the build status
[09:36:36.535] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:36.535] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:8:0) after 1m0s
[09:37:36.653] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:8:0)
[09:37:36.653] Timer tick, asking Buildbucket for the build status
[09:37:36.751] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:36.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:9:0) after 1m0s
[09:38:36.918] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:9:0)
[09:38:36.918] Timer tick, asking Buildbucket for the build status
[09:38:36.991] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:36.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:10:0) after 1m0s
[09:39:37.013] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:10:0)
[09:39:37.013] Timer tick, asking Buildbucket for the build status
[09:39:37.081] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:37.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:11:0) after 1m0s
[09:40:37.124] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:11:0)
[09:40:37.124] Timer tick, asking Buildbucket for the build status
[09:40:37.276] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:37.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:12:0) after 1m0s
[09:41:37.312] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:12:0)
[09:41:37.312] Timer tick, asking Buildbucket for the build status
[09:41:37.398] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:37.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:13:0) after 1m0s
[09:42:37.449] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:13:0)
[09:42:37.449] Timer tick, asking Buildbucket for the build status
[09:42:37.817] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:37.817] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:14:0) after 1m0s
[09:43:37.885] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:14:0)
[09:43:37.885] Timer tick, asking Buildbucket for the build status
[09:43:37.947] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:37.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:15:0) after 1m0s
[09:44:37.998] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:15:0)
[09:44:37.998] Timer tick, asking Buildbucket for the build status
[09:44:38.076] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:38.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:16:0) after 1m0s
[09:45:38.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:16:0)
[09:45:38.899] Timer tick, asking Buildbucket for the build status
[09:45:39.096] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:39.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:17:0) after 1m0s
[09:46:39.417] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:17:0)
[09:46:39.418] Timer tick, asking Buildbucket for the build status
[09:46:39.508] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:39.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:18:0) after 1m0s
[09:47:39.716] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:18:0)
[09:47:39.716] Timer tick, asking Buildbucket for the build status
[09:47:39.801] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:39.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:19:0) after 1m0s
[09:48:39.949] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:19:0)
[09:48:39.949] Timer tick, asking Buildbucket for the build status
[09:48:40.050] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:40.050] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:20:0) after 1m0s
[09:49:40.226] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:20:0)
[09:49:40.226] Timer tick, asking Buildbucket for the build status
[09:49:40.307] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:40.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:21:0) after 1m0s
[09:50:40.502] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:21:0)
[09:50:40.502] Timer tick, asking Buildbucket for the build status
[09:50:40.728] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:40.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:22:0) after 1m0s
[09:51:40.752] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:22:0)
[09:51:40.752] Timer tick, asking Buildbucket for the build status
[09:51:40.854] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:40.854] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:23:0) after 1m0s
[09:52:40.964] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:23:0)
[09:52:40.964] Timer tick, asking Buildbucket for the build status
[09:52:41.039] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:41.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:24:0) after 1m0s
[09:53:41.052] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:24:0)
[09:53:41.052] Timer tick, asking Buildbucket for the build status
[09:53:41.341] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:41.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:25:0) after 1m0s
[09:54:41.363] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:25:0)
[09:54:41.363] Timer tick, asking Buildbucket for the build status
[09:54:41.446] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:41.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:26:0) after 1m0s
[09:55:41.470] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:26:0)
[09:55:41.470] Timer tick, asking Buildbucket for the build status
[09:55:41.536] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:41.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:27:0) after 1m0s
[09:56:42.347] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:27:0)
[09:56:42.347] Timer tick, asking Buildbucket for the build status
[09:56:42.444] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:42.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:28:0) after 1m0s
[09:57:42.612] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:28:0)
[09:57:42.612] Timer tick, asking Buildbucket for the build status
[09:57:42.673] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:42.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:29:0) after 1m0s
[09:58:42.707] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:29:0)
[09:58:42.707] Timer tick, asking Buildbucket for the build status
[09:58:42.778] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:42.778] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:30:0) after 1m0s
[09:59:42.955] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:30:0)
[09:59:42.955] Timer tick, asking Buildbucket for the build status
[09:59:43.025] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:43.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:31:0) after 1m0s
[10:00:43.464] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:31:0)
[10:00:43.464] Timer tick, asking Buildbucket for the build status
[10:00:43.591] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:43.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:32:0) after 1m0s
[10:01:43.814] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:32:0)
[10:01:43.814] Timer tick, asking Buildbucket for the build status
[10:01:43.904] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:43.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:33:0) after 1m0s
[10:02:44.150] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:33:0)
[10:02:44.150] Timer tick, asking Buildbucket for the build status
[10:02:44.245] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:44.245] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:34:0) after 1m0s
[10:03:44.361] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:34:0)
[10:03:44.361] Timer tick, asking Buildbucket for the build status
[10:03:44.440] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:44.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:35:0) after 1m0s
[10:04:44.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:35:0)
[10:04:44.535] Timer tick, asking Buildbucket for the build status
[10:04:44.695] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:44.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:36:0) after 1m0s
[10:05:44.824] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:36:0)
[10:05:44.824] Timer tick, asking Buildbucket for the build status
[10:05:44.904] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:44.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:37:0) after 1m0s
[10:06:45.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:37:0)
[10:06:45.233] Timer tick, asking Buildbucket for the build status
[10:06:45.355] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:45.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:38:0) after 1m0s
[10:07:45.507] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:38:0)
[10:07:45.507] Timer tick, asking Buildbucket for the build status
[10:07:45.612] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:45.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:39:0) after 1m0s
[10:08:45.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:39:0)
[10:08:45.646] Timer tick, asking Buildbucket for the build status
[10:08:45.740] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:45.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:40:0) after 1m0s
[10:09:45.779] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:40:0)
[10:09:45.779] Timer tick, asking Buildbucket for the build status
[10:09:46.011] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:46.011] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:41:0) after 1m0s
[10:10:46.078] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:41:0)
[10:10:46.078] Timer tick, asking Buildbucket for the build status
[10:10:46.229] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:46.229] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:42:0) after 1m0s
[10:11:46.250] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:42:0)
[10:11:46.250] Timer tick, asking Buildbucket for the build status
[10:11:46.357] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:46.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:43:0) after 1m0s
[10:12:46.377] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:43:0)
[10:12:46.377] Timer tick, asking Buildbucket for the build status
[10:12:46.604] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:46.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:44:0) after 1m0s
[10:13:46.636] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:44:0)
[10:13:46.636] Timer tick, asking Buildbucket for the build status
[10:13:47.014] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:47.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:45:0) after 1m0s
[10:14:47.026] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:45:0)
[10:14:47.026] Timer tick, asking Buildbucket for the build status
[10:14:47.404] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:47.404] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:46:0) after 1m0s
[10:15:47.483] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:46:0)
[10:15:47.483] Timer tick, asking Buildbucket for the build status
[10:15:47.569] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:47.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:47:0) after 1m0s
[10:16:47.648] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:47:0)
[10:16:47.648] Timer tick, asking Buildbucket for the build status
[10:16:47.733] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:47.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:48:0) after 1m0s
[10:17:47.798] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:48:0)
[10:17:47.798] Timer tick, asking Buildbucket for the build status
[10:17:47.871] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:47.871] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:49:0) after 1m0s
[10:18:47.853] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:49:0)
[10:18:47.853] Timer tick, asking Buildbucket for the build status
[10:18:47.914] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:47.914] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:50:0) after 1m0s
[10:19:47.974] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:50:0)
[10:19:47.974] Timer tick, asking Buildbucket for the build status
[10:19:48.052] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:48.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:51:0) after 1m0s
[10:20:48.075] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:51:0)
[10:20:48.075] Timer tick, asking Buildbucket for the build status
[10:20:48.161] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:48.161] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:52:0) after 1m0s
[10:21:48.192] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:52:0)
[10:21:48.192] Timer tick, asking Buildbucket for the build status
[10:21:48.370] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:48.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:53:0) after 1m0s
[10:22:48.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:53:0)
[10:22:48.459] Timer tick, asking Buildbucket for the build status
[10:22:48.569] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:48.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:54:0) after 1m0s
[10:23:48.626] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:54:0)
[10:23:48.626] Timer tick, asking Buildbucket for the build status
[10:23:48.701] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:48.701] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:55:0) after 1m0s
[10:24:48.734] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:55:0)
[10:24:48.734] Timer tick, asking Buildbucket for the build status
[10:24:48.838] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:48.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:56:0) after 1m0s
[10:25:48.874] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:56:0)
[10:25:48.874] Timer tick, asking Buildbucket for the build status
[10:25:49.185] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:49.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:57:0) after 1m0s
[10:26:49.219] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:57:0)
[10:26:49.219] Timer tick, asking Buildbucket for the build status
[10:26:49.315] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:49.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:58:0) after 1m0s
[10:27:49.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:58:0)
[10:27:49.344] Timer tick, asking Buildbucket for the build status
[10:27:49.423] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:49.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:59:0) after 1m0s
[10:28:49.959] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:59:0)
[10:28:49.959] Timer tick, asking Buildbucket for the build status
[10:28:50.064] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:50.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:60:0) after 1m0s
[10:29:50.401] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:60:0)
[10:29:50.401] Timer tick, asking Buildbucket for the build status
[10:29:50.475] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:50.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:61:0) after 1m0s
[10:30:50.543] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:61:0)
[10:30:50.543] Timer tick, asking Buildbucket for the build status
[10:30:50.647] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:50.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:62:0) after 1m0s
[10:31:50.683] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:62:0)
[10:31:50.683] Timer tick, asking Buildbucket for the build status
[10:31:50.793] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:50.793] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:63:0) after 1m0s
[10:32:50.816] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:63:0)
[10:32:50.816] Timer tick, asking Buildbucket for the build status
[10:32:50.884] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:50.884] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:64:0) after 1m0s
[10:33:50.888] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:64:0)
[10:33:50.888] Timer tick, asking Buildbucket for the build status
[10:33:50.963] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:50.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:65:0) after 1m0s
[10:34:50.996] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:65:0)
[10:34:50.997] Timer tick, asking Buildbucket for the build status
[10:34:51.081] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:51.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:66:0) after 1m0s
[10:35:51.108] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:66:0)
[10:35:51.108] Timer tick, asking Buildbucket for the build status
[10:35:51.190] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:51.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:67:0) after 1m0s
[10:36:51.244] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:67:0)
[10:36:51.244] Timer tick, asking Buildbucket for the build status
[10:36:51.344] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:51.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:68:0) after 1m0s
[10:37:51.401] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:68:0)
[10:37:51.401] Timer tick, asking Buildbucket for the build status
[10:37:51.487] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:51.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:69:0) after 1m0s
[10:38:51.530] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:69:0)
[10:38:51.530] Timer tick, asking Buildbucket for the build status
[10:38:51.699] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:51.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:70:0) after 1m0s
[10:39:51.716] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:70:0)
[10:39:51.716] Timer tick, asking Buildbucket for the build status
[10:39:51.804] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:51.804] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:71:0) after 1m0s
[10:40:51.827] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:71:0)
[10:40:51.827] Timer tick, asking Buildbucket for the build status
[10:40:51.940] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:51.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:72:0) after 1m0s
[10:41:51.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:72:0)
[10:41:51.962] Timer tick, asking Buildbucket for the build status
[10:41:52.069] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:52.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:73:0) after 1m0s
[10:42:52.165] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:73:0)
[10:42:52.165] Timer tick, asking Buildbucket for the build status
[10:42:52.247] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:52.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:74:0) after 1m0s
[10:43:52.262] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:74:0)
[10:43:52.262] Timer tick, asking Buildbucket for the build status
[10:43:52.366] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:52.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:75:0) after 1m0s
[10:44:52.370] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:75:0)
[10:44:52.370] Timer tick, asking Buildbucket for the build status
[10:44:52.457] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:52.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:76:0) after 1m0s
[10:45:52.489] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:76:0)
[10:45:52.489] Timer tick, asking Buildbucket for the build status
[10:45:52.911] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:52.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:77:0) after 1m0s
[10:46:53.040] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:77:0)
[10:46:53.040] Timer tick, asking Buildbucket for the build status
[10:46:53.404] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:53.404] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:78:0) after 1m0s
[10:47:53.498] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:78:0)
[10:47:53.498] Timer tick, asking Buildbucket for the build status
[10:47:53.594] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:53.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:79:0) after 1m0s
[10:48:53.776] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:79:0)
[10:48:53.776] Timer tick, asking Buildbucket for the build status
[10:48:53.873] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:53.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:80:0) after 1m0s
[10:49:53.925] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:80:0)
[10:49:53.925] Timer tick, asking Buildbucket for the build status
[10:49:54.296] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:54.296] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:81:0) after 1m0s
[10:50:54.481] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:81:0)
[10:50:54.481] Timer tick, asking Buildbucket for the build status
[10:50:54.558] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:54.558] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:82:0) after 1m0s
[10:51:54.668] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:82:0)
[10:51:54.668] Timer tick, asking Buildbucket for the build status
[10:51:58.078] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:58.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:83:0) after 1m0s
[10:52:58.192] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:83:0)
[10:52:58.192] Timer tick, asking Buildbucket for the build status
[10:52:58.311] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:58.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:84:0) after 1m0s
[10:53:58.502] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:84:0)
[10:53:58.502] Timer tick, asking Buildbucket for the build status
[10:53:58.587] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:58.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:85:0) after 1m0s
[10:54:58.674] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:85:0)
[10:54:58.674] Timer tick, asking Buildbucket for the build status
[10:54:58.801] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:58.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:86:0) after 1m0s
[10:55:58.970] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:86:0)
[10:55:58.970] Timer tick, asking Buildbucket for the build status
[10:55:59.052] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:59.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:87:0) after 1m0s
[10:56:59.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:87:0)
[10:56:59.032] Timer tick, asking Buildbucket for the build status
[10:57:02.330] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:02.330] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:88:0) after 1m0s
[10:58:02.923] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:88:0)
[10:58:02.923] Timer tick, asking Buildbucket for the build status
[10:58:03.063] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:03.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:89:0) after 1m0s
[10:59:03.123] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:89:0)
[10:59:03.123] Timer tick, asking Buildbucket for the build status
[10:59:03.679] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:03.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:90:0) after 1m0s
[11:00:03.888] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:90:0)
[11:00:03.888] Timer tick, asking Buildbucket for the build status
[11:00:03.987] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:03.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:91:0) after 1m0s
[11:01:04.425] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:91:0)
[11:01:04.425] Timer tick, asking Buildbucket for the build status
[11:01:04.638] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:04.638] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:92:0) after 1m0s
[11:02:04.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:92:0)
[11:02:04.749] Timer tick, asking Buildbucket for the build status
[11:02:04.974] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:04.974] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:93:0) after 1m0s
[11:03:05.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:93:0)
[11:03:05.035] Timer tick, asking Buildbucket for the build status
[11:03:05.105] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:05.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:94:0) after 1m0s
[11:04:05.186] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:94:0)
[11:04:05.186] Timer tick, asking Buildbucket for the build status
[11:04:05.295] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:05.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:95:0) after 1m0s
[11:05:05.320] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:95:0)
[11:05:05.320] Timer tick, asking Buildbucket for the build status
[11:05:05.411] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:05.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:96:0) after 1m0s
[11:06:05.436] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:96:0)
[11:06:05.436] Timer tick, asking Buildbucket for the build status
[11:06:05.526] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:05.526] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:97:0) after 1m0s
[11:07:05.618] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:97:0)
[11:07:05.618] Timer tick, asking Buildbucket for the build status
[11:07:06.032] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:06.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:98:0) after 1m0s
[11:08:06.106] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:98:0)
[11:08:06.106] Timer tick, asking Buildbucket for the build status
[11:08:06.299] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:06.299] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:99:0) after 1m0s
[11:09:06.390] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:99:0)
[11:09:06.390] Timer tick, asking Buildbucket for the build status
[11:09:06.470] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:06.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:100:0) after 1m0s
[11:10:06.529] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:100:0)
[11:10:06.529] Timer tick, asking Buildbucket for the build status
[11:10:06.608] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:06.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:101:0) after 1m0s
[11:11:06.777] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:101:0)
[11:11:06.777] Timer tick, asking Buildbucket for the build status
[11:11:06.886] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:06.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:102:0) after 1m0s
[11:12:06.946] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:102:0)
[11:12:06.946] Timer tick, asking Buildbucket for the build status
[11:12:07.062] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:07.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:103:0) after 1m0s
[11:13:07.130] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:103:0)
[11:13:07.130] Timer tick, asking Buildbucket for the build status
[11:13:07.269] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:07.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:104:0) after 1m0s
[11:14:07.329] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:104:0)
[11:14:07.329] Timer tick, asking Buildbucket for the build status
[11:14:07.489] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:07.489] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:105:0) after 1m0s
[11:15:07.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:105:0)
[11:15:07.503] Timer tick, asking Buildbucket for the build status
[11:15:07.584] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:07.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:106:0) after 1m0s
[11:16:07.633] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:106:0)
[11:16:07.634] Timer tick, asking Buildbucket for the build status
[11:16:07.725] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:07.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:107:0) after 1m0s
[11:17:07.815] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:107:0)
[11:17:07.815] Timer tick, asking Buildbucket for the build status
[11:17:07.929] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:07.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:108:0) after 1m0s
[11:18:08.067] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:108:0)
[11:18:08.067] Timer tick, asking Buildbucket for the build status
[11:18:08.151] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:08.151] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:109:0) after 1m0s
[11:19:08.211] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:109:0)
[11:19:08.211] Timer tick, asking Buildbucket for the build status
[11:19:08.360] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:08.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:110:0) after 1m0s
[11:20:08.340] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:110:0)
[11:20:08.340] Timer tick, asking Buildbucket for the build status
[11:20:08.418] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:08.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:111:0) after 1m0s
[11:21:08.572] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:111:0)
[11:21:08.572] Timer tick, asking Buildbucket for the build status
[11:21:08.642] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:08.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:112:0) after 1m0s
[11:22:08.925] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:112:0)
[11:22:08.925] Timer tick, asking Buildbucket for the build status
[11:22:09.045] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:09.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:113:0) after 1m0s
[11:23:09.268] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:113:0)
[11:23:09.268] Timer tick, asking Buildbucket for the build status
[11:23:09.330] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:09.330] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:114:0) after 1m0s
[11:24:09.592] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:114:0)
[11:24:09.592] Timer tick, asking Buildbucket for the build status
[11:24:10.026] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:10.026] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:115:0) after 1m0s
[11:25:10.231] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:115:0)
[11:25:10.231] Timer tick, asking Buildbucket for the build status
[11:25:10.687] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:10.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:116:0) after 1m0s
[11:26:10.780] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:116:0)
[11:26:10.780] Timer tick, asking Buildbucket for the build status
[11:26:10.860] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:10.860] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:117:0) after 1m0s
[11:27:10.926] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:117:0)
[11:27:10.926] Timer tick, asking Buildbucket for the build status
[11:27:11.042] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:11.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:118:0) after 1m0s
[11:28:11.078] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:118:0)
[11:28:11.078] Timer tick, asking Buildbucket for the build status
[11:28:11.472] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:11.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:119:0) after 1m0s
[11:29:11.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:119:0)
[11:29:11.497] Timer tick, asking Buildbucket for the build status
[11:29:11.576] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:11.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:120:0) after 1m0s
[11:30:11.732] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:120:0)
[11:30:11.732] Timer tick, asking Buildbucket for the build status
[11:30:12.110] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:12.111] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:121:0) after 1m0s
[11:31:13.409] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:121:0)
[11:31:13.409] Timer tick, asking Buildbucket for the build status
[11:31:13.542] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:13.542] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:122:0) after 1m0s
[11:32:13.910] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:122:0)
[11:32:13.910] Timer tick, asking Buildbucket for the build status
[11:32:14.167] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:14.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:123:0) after 1m0s
[11:33:14.445] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:123:0)
[11:33:14.445] Timer tick, asking Buildbucket for the build status
[11:33:14.885] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:14.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:124:0) after 1m0s
[11:34:14.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:124:0)
[11:34:14.906] Timer tick, asking Buildbucket for the build status
[11:34:14.994] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:14.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:125:0) after 1m0s
[11:35:15.131] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:125:0)
[11:35:15.131] Timer tick, asking Buildbucket for the build status
[11:35:15.226] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:15.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:126:0) after 1m0s
[11:36:15.613] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:126:0)
[11:36:15.613] Timer tick, asking Buildbucket for the build status
[11:36:15.692] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:15.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:127:0) after 1m0s
[11:37:15.768] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:127:0)
[11:37:15.768] Timer tick, asking Buildbucket for the build status
[11:37:16.208] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:16.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:128:0) after 1m0s
[11:38:16.311] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:128:0)
[11:38:16.311] Timer tick, asking Buildbucket for the build status
[11:38:16.387] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:16.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:129:0) after 1m0s
[11:39:16.489] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:129:0)
[11:39:16.489] Timer tick, asking Buildbucket for the build status
[11:39:16.823] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:16.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:130:0) after 1m0s
[11:40:16.862] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:130:0)
[11:40:16.862] Timer tick, asking Buildbucket for the build status
[11:40:16.947] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:16.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:131:0) after 1m0s
[11:41:17.112] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:131:0)
[11:41:17.112] Timer tick, asking Buildbucket for the build status
[11:41:17.216] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:17.216] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:132:0) after 1m0s
[11:42:17.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:132:0)
[11:42:17.354] Timer tick, asking Buildbucket for the build status
[11:42:17.440] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:17.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:133:0) after 1m0s
[11:43:17.521] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:133:0)
[11:43:17.521] Timer tick, asking Buildbucket for the build status
[11:43:17.612] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:17.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:134:0) after 1m0s
[11:44:17.886] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:134:0)
[11:44:17.886] Timer tick, asking Buildbucket for the build status
[11:44:17.951] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:17.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:135:0) after 1m0s
[11:45:18.249] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:135:0)
[11:45:18.249] Timer tick, asking Buildbucket for the build status
[11:45:18.362] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:18.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:136:0) after 1m0s
[11:46:18.994] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:136:0)
[11:46:18.994] Timer tick, asking Buildbucket for the build status
[11:46:20.325] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:20.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:137:0) after 1m0s
[11:47:20.353] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:137:0)
[11:47:20.353] Timer tick, asking Buildbucket for the build status
[11:47:20.458] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:20.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:138:0) after 1m0s
[11:48:20.501] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:138:0)
[11:48:20.501] Timer tick, asking Buildbucket for the build status
[11:48:20.600] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:20.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:139:0) after 1m0s
[11:49:20.630] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:139:0)
[11:49:20.630] Timer tick, asking Buildbucket for the build status
[11:49:20.759] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:20.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:140:0) after 1m0s
[11:50:20.828] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:140:0)
[11:50:20.828] Timer tick, asking Buildbucket for the build status
[11:50:20.910] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:20.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:141:0) after 1m0s
[11:51:20.939] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:141:0)
[11:51:20.940] Timer tick, asking Buildbucket for the build status
[11:51:21.011] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:21.011] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:142:0) after 1m0s
[11:52:21.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:142:0)
[11:52:21.071] Timer tick, asking Buildbucket for the build status
[11:52:21.476] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:21.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:143:0) after 1m0s
[11:53:21.499] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:143:0)
[11:53:21.499] Timer tick, asking Buildbucket for the build status
[11:53:21.577] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:21.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:144:0) after 1m0s
[11:54:21.614] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:144:0)
[11:54:21.614] Timer tick, asking Buildbucket for the build status
[11:54:21.737] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:21.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:145:0) after 1m0s
[11:55:21.789] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:145:0)
[11:55:21.789] Timer tick, asking Buildbucket for the build status
[11:55:21.864] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:21.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:146:0) after 1m0s
[11:56:21.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:146:0)
[11:56:21.871] Timer tick, asking Buildbucket for the build status
[11:56:21.961] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:21.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:147:0) after 1m0s
[11:57:22.141] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:147:0)
[11:57:22.141] Timer tick, asking Buildbucket for the build status
[11:57:22.237] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:22.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:148:0) after 1m0s
[11:58:22.388] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:148:0)
[11:58:22.388] Timer tick, asking Buildbucket for the build status
[11:58:22.859] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:22.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:149:0) after 1m0s
[11:59:23.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:149:0)
[11:59:23.119] Timer tick, asking Buildbucket for the build status
[11:59:23.192] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:23.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:150:0) after 1m0s
[12:00:23.246] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:150:0)
[12:00:23.246] Timer tick, asking Buildbucket for the build status
[12:00:23.361] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:23.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:151:0) after 1m0s
[12:01:23.472] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:151:0)
[12:01:23.472] Timer tick, asking Buildbucket for the build status
[12:01:23.551] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:23.551] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:152:0) after 1m0s
[12:02:23.627] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:152:0)
[12:02:23.627] Timer tick, asking Buildbucket for the build status
[12:02:23.708] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:23.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:153:0) after 1m0s
[12:03:23.727] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:153:0)
[12:03:23.727] Timer tick, asking Buildbucket for the build status
[12:03:23.818] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:23.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:154:0) after 1m0s
[12:04:23.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:154:0)
[12:04:23.921] Timer tick, asking Buildbucket for the build status
[12:04:24.027] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:24.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:155:0) after 1m0s
[12:05:24.099] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:155:0)
[12:05:24.099] Timer tick, asking Buildbucket for the build status
[12:05:24.294] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:24.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:156:0) after 1m0s
[12:06:24.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:156:0)
[12:06:24.344] Timer tick, asking Buildbucket for the build status
[12:06:24.501] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:24.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:157:0) after 1m0s
[12:07:24.507] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:157:0)
[12:07:24.507] Timer tick, asking Buildbucket for the build status
[12:07:24.693] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:24.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:158:0) after 1m0s
[12:08:24.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:158:0)
[12:08:24.808] Timer tick, asking Buildbucket for the build status
[12:08:27.272] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:27.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:159:0) after 1m0s
[12:09:27.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:159:0)
[12:09:27.354] Timer tick, asking Buildbucket for the build status
[12:09:27.606] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:27.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:160:0) after 1m0s
[12:10:27.684] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:160:0)
[12:10:27.684] Timer tick, asking Buildbucket for the build status
[12:10:27.921] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:27.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:161:0) after 1m0s
[12:11:28.012] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:161:0)
[12:11:28.012] Timer tick, asking Buildbucket for the build status
[12:11:28.102] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:28.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:162:0) after 1m0s
[12:12:28.156] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:162:0)
[12:12:28.156] Timer tick, asking Buildbucket for the build status
[12:12:28.455] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:28.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:163:0) after 1m0s
[12:13:28.630] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:163:0)
[12:13:28.630] Timer tick, asking Buildbucket for the build status
[12:13:28.702] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:28.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:164:0) after 1m0s
[12:14:28.726] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:164:0)
[12:14:28.726] Timer tick, asking Buildbucket for the build status
[12:14:28.837] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:28.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:165:0) after 1m0s
[12:15:29.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:165:0)
[12:15:29.006] Timer tick, asking Buildbucket for the build status
[12:15:29.093] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:29.093] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:166:0) after 1m0s
[12:16:29.162] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:166:0)
[12:16:29.162] Timer tick, asking Buildbucket for the build status
[12:16:29.393] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:29.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:167:0) after 1m0s
[12:17:29.418] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:167:0)
[12:17:29.418] Timer tick, asking Buildbucket for the build status
[12:17:29.508] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:29.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:168:0) after 1m0s
[12:18:29.582] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:168:0)
[12:18:29.582] Timer tick, asking Buildbucket for the build status
[12:18:29.650] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:29.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:169:0) after 1m0s
[12:19:29.937] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:169:0)
[12:19:29.937] Timer tick, asking Buildbucket for the build status
[12:19:30.002] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:30.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:170:0) after 1m0s
[12:20:30.220] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:170:0)
[12:20:30.220] Timer tick, asking Buildbucket for the build status
[12:20:30.396] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:30.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:171:0) after 1m0s
[12:21:30.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:171:0)
[12:21:30.597] Timer tick, asking Buildbucket for the build status
[12:21:30.932] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:30.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:172:0) after 1m0s
[12:22:31.560] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:172:0)
[12:22:31.560] Timer tick, asking Buildbucket for the build status
[12:22:31.678] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:31.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:173:0) after 1m0s
[12:23:31.909] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:173:0)
[12:23:31.909] Timer tick, asking Buildbucket for the build status
[12:23:32.009] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:32.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:174:0) after 1m0s
[12:24:32.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:174:0)
[12:24:32.088] Timer tick, asking Buildbucket for the build status
[12:24:32.172] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:32.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:175:0) after 1m0s
[12:25:32.349] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:175:0)
[12:25:32.349] Timer tick, asking Buildbucket for the build status
[12:25:32.419] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:32.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:176:0) after 1m0s
[12:26:32.561] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:176:0)
[12:26:32.561] Timer tick, asking Buildbucket for the build status
[12:26:32.825] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:32.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:177:0) after 1m0s
[12:27:32.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:177:0)
[12:27:32.843] Timer tick, asking Buildbucket for the build status
[12:27:32.986] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:32.986] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:178:0) after 1m0s
[12:28:33.014] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:178:0)
[12:28:33.014] Timer tick, asking Buildbucket for the build status
[12:28:33.123] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:33.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:179:0) after 1m0s
[12:29:33.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:179:0)
[12:29:33.147] Timer tick, asking Buildbucket for the build status
[12:29:33.239] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:33.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:180:0) after 1m0s
[12:30:33.322] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:180:0)
[12:30:33.322] Timer tick, asking Buildbucket for the build status
[12:30:33.412] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:33.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:181:0) after 1m0s
[12:31:33.500] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:181:0)
[12:31:33.500] Timer tick, asking Buildbucket for the build status
[12:31:33.588] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:33.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:182:0) after 1m0s
[12:32:33.637] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:182:0)
[12:32:33.638] Timer tick, asking Buildbucket for the build status
[12:32:33.723] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:33.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:183:0) after 1m0s
[12:33:33.745] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:183:0)
[12:33:33.745] Timer tick, asking Buildbucket for the build status
[12:33:33.836] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:33.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:184:0) after 1m0s
[12:34:33.866] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:184:0)
[12:34:33.866] Timer tick, asking Buildbucket for the build status
[12:34:33.975] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:33.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:185:0) after 1m0s
[12:35:34.615] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:185:0)
[12:35:34.615] Timer tick, asking Buildbucket for the build status
[12:35:34.694] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:34.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:186:0) after 1m0s
[12:36:34.936] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:186:0)
[12:36:34.936] Timer tick, asking Buildbucket for the build status
[12:36:35.015] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:35.015] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:187:0) after 1m0s
[12:37:35.566] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:187:0)
[12:37:35.566] Timer tick, asking Buildbucket for the build status
[12:37:35.656] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:35.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:188:0) after 1m0s
[12:38:35.752] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:188:0)
[12:38:35.752] Timer tick, asking Buildbucket for the build status
[12:38:36.012] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:36.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:189:0) after 1m0s
[12:39:36.093] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:189:0)
[12:39:36.093] Timer tick, asking Buildbucket for the build status
[12:39:36.215] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:36.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:190:0) after 1m0s
[12:40:36.285] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:190:0)
[12:40:36.285] Timer tick, asking Buildbucket for the build status
[12:40:36.462] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:36.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:191:0) after 1m0s
[12:41:36.593] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:191:0)
[12:41:36.593] Timer tick, asking Buildbucket for the build status
[12:41:36.715] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:36.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:192:0) after 1m0s
[12:42:36.748] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:192:0)
[12:42:36.748] Timer tick, asking Buildbucket for the build status
[12:42:37.326] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:37.326] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:193:0) after 1m0s
[12:43:37.494] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:193:0)
[12:43:37.494] Timer tick, asking Buildbucket for the build status
[12:43:37.633] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:37.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:194:0) after 1m0s
[12:44:37.619] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:194:0)
[12:44:37.619] Timer tick, asking Buildbucket for the build status
[12:44:37.705] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:37.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:195:0) after 1m0s
[12:45:37.732] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:195:0)
[12:45:37.732] Timer tick, asking Buildbucket for the build status
[12:45:37.841] Build 8854878214387670112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:37.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9020308276491961984:196:0) after 1m0s
[12:45:54.058] Received PubSub notification, asking Buildbucket for the build status
[12:45:54.131] Build 8854878214387670112: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:45:54.131] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "completed_ts": "1613738753717822",
    "created_by": "project:nacl",
    "created_ts": "1613727094241231",
    "failure_reason": "BUILD_FAILURE",
    "id": "8854878214387670112",
    "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\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"title\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}}",
    "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\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"title\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}]}, \"bot_id\": \"luci-nacl-toolchain-xenial-0-mvfj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.nacl.toolchain\", \"buildername\": \"linux-pnacl-x86_64-tests-arm\", \"buildnumber\": 4762, \"got_revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"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-0-mvfj\"], \"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\": [\"5706-397711c\"], \"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": "1613727118930992",
    "status": "COMPLETED",
    "status_changed_ts": "1613727119634139",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4762",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020308276491961984",
      "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/8854878214387670112/+/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:51d272e7d279e510",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1613738753798250",
    "url": "https://ci.chromium.org/b/8854878214387670112",
    "utcnow_ts": "1613738754123236"
  }
}
[12:45:54.131] Invocation finished in 3h14m21.281462382s with status FAILED