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

• 2c300847c7700af6948ad78e79ccd21bd7ba0c14 (5 years ago)

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

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

[19:49:09.693] New invocation is queued and will start shortly
[19:49:11.384] Starting the invocation (attempt 1)
[19:49:11.445] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:49:11.445] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:49:11.445] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9082509535510455280",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-arm\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"2c300847c7700af6948ad78e79ccd21bd7ba0c14\"}}",
  "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:9082509535510455280",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
    "user_agent:luci-scheduler",
    "buildset:commit/git/2c300847c7700af6948ad78e79ccd21bd7ba0c14",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/2c300847c7700af6948ad78e79ccd21bd7ba0c14",
    "gitiles_ref:refs/heads/master"
  ]
}
[19:49:12.868] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "project:nacl",
    "created_ts": "1554407351672188",
    "id": "8917079472771220544",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"2c300847c7700af6948ad78e79ccd21bd7ba0c14\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1554407352695303",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4705",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/2c300847c7700af6948ad78e79ccd21bd7ba0c14",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/2c300847c7700af6948ad78e79ccd21bd7ba0c14",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9082509535510455280",
      "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/8917079472771220544/+/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": "1554407352695413",
    "url": "https://ci.chromium.org/b/8917079472771220544",
    "utcnow_ts": "1554407352858575"
  }
}
[19:49:12.868] Task URL: https://ci.chromium.org/b/8917079472771220544
[19:49:12.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:2:0) after 1m0s
[19:50:12.873] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:2:0)
[19:50:12.873] Timer tick, asking Buildbucket for the build status
[19:50:13.286] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:13.286] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:3:0) after 1m0s
[19:51:13.323] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:3:0)
[19:51:13.323] Timer tick, asking Buildbucket for the build status
[19:51:13.433] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:13.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:4:0) after 1m0s
[19:52:13.433] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:4:0)
[19:52:13.433] Timer tick, asking Buildbucket for the build status
[19:52:13.488] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:13.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:5:0) after 1m0s
[19:53:13.521] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:5:0)
[19:53:13.521] Timer tick, asking Buildbucket for the build status
[19:53:13.666] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:13.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:6:0) after 1m0s
[19:54:13.689] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:6:0)
[19:54:13.689] Timer tick, asking Buildbucket for the build status
[19:54:13.960] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:13.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:7:0) after 1m0s
[19:55:13.990] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:7:0)
[19:55:13.990] Timer tick, asking Buildbucket for the build status
[19:55:14.061] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:14.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:8:0) after 1m0s
[19:56:14.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:8:0)
[19:56:14.088] Timer tick, asking Buildbucket for the build status
[19:56:14.206] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:14.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:9:0) after 1m0s
[19:57:14.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:9:0)
[19:57:14.217] Timer tick, asking Buildbucket for the build status
[19:57:14.270] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:14.270] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:10:0) after 1m0s
[19:58:14.295] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:10:0)
[19:58:14.295] Timer tick, asking Buildbucket for the build status
[19:58:14.439] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:14.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:11:0) after 1m0s
[19:59:14.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:11:0)
[19:59:14.459] Timer tick, asking Buildbucket for the build status
[19:59:14.587] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:14.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:12:0) after 1m0s
[20:00:14.604] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:12:0)
[20:00:14.604] Timer tick, asking Buildbucket for the build status
[20:00:14.809] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:14.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:13:0) after 1m0s
[20:01:14.791] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:13:0)
[20:01:14.791] Timer tick, asking Buildbucket for the build status
[20:01:15.078] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:15.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:14:0) after 1m0s
[20:02:15.079] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:14:0)
[20:02:15.079] Timer tick, asking Buildbucket for the build status
[20:02:15.184] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:15.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:15:0) after 1m0s
[20:03:15.196] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:15:0)
[20:03:15.196] Timer tick, asking Buildbucket for the build status
[20:03:15.256] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:15.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:16:0) after 1m0s
[20:04:15.317] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:16:0)
[20:04:15.317] Timer tick, asking Buildbucket for the build status
[20:04:15.366] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:15.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:17:0) after 1m0s
[20:05:15.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:17:0)
[20:05:15.396] Timer tick, asking Buildbucket for the build status
[20:05:15.491] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:15.491] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:18:0) after 1m0s
[20:06:15.526] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:18:0)
[20:06:15.526] Timer tick, asking Buildbucket for the build status
[20:06:15.586] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:15.586] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:19:0) after 1m0s
[20:07:15.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:19:0)
[20:07:15.608] Timer tick, asking Buildbucket for the build status
[20:07:15.692] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:15.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:20:0) after 1m0s
[20:08:15.695] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:20:0)
[20:08:15.695] Timer tick, asking Buildbucket for the build status
[20:08:15.812] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:15.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:21:0) after 1m0s
[20:09:15.825] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:21:0)
[20:09:15.825] Timer tick, asking Buildbucket for the build status
[20:09:16.073] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:16.073] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:22:0) after 1m0s
[20:10:16.094] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:22:0)
[20:10:16.094] Timer tick, asking Buildbucket for the build status
[20:10:16.169] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:16.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:23:0) after 1m0s
[20:11:16.190] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:23:0)
[20:11:16.190] Timer tick, asking Buildbucket for the build status
[20:11:16.408] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:16.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:24:0) after 1m0s
[20:12:16.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:24:0)
[20:12:16.398] Timer tick, asking Buildbucket for the build status
[20:12:16.497] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:16.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:25:0) after 1m0s
[20:13:16.522] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:25:0)
[20:13:16.522] Timer tick, asking Buildbucket for the build status
[20:13:16.603] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:16.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:26:0) after 1m0s
[20:14:16.622] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:26:0)
[20:14:16.622] Timer tick, asking Buildbucket for the build status
[20:14:16.805] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:16.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:27:0) after 1m0s
[20:15:16.805] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:27:0)
[20:15:16.805] Timer tick, asking Buildbucket for the build status
[20:15:17.202] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:17.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:28:0) after 1m0s
[20:16:17.298] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:28:0)
[20:16:17.298] Timer tick, asking Buildbucket for the build status
[20:16:17.387] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:17.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:29:0) after 1m0s
[20:17:17.423] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:29:0)
[20:17:17.423] Timer tick, asking Buildbucket for the build status
[20:17:17.537] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:17.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:30:0) after 1m0s
[20:18:17.524] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:30:0)
[20:18:17.524] Timer tick, asking Buildbucket for the build status
[20:18:17.573] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:17.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:31:0) after 1m0s
[20:19:17.595] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:31:0)
[20:19:17.595] Timer tick, asking Buildbucket for the build status
[20:19:17.839] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:17.839] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:32:0) after 1m0s
[20:20:17.858] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:32:0)
[20:20:17.858] Timer tick, asking Buildbucket for the build status
[20:20:17.926] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:17.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:33:0) after 1m0s
[20:21:17.926] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:33:0)
[20:21:17.926] Timer tick, asking Buildbucket for the build status
[20:21:17.982] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:17.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:34:0) after 1m0s
[20:22:17.996] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:34:0)
[20:22:17.996] Timer tick, asking Buildbucket for the build status
[20:22:18.094] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:18.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:35:0) after 1m0s
[20:23:18.097] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:35:0)
[20:23:18.097] Timer tick, asking Buildbucket for the build status
[20:23:18.149] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:18.149] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:36:0) after 1m0s
[20:24:18.167] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:36:0)
[20:24:18.167] Timer tick, asking Buildbucket for the build status
[20:24:18.244] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:18.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:37:0) after 1m0s
[20:25:18.285] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:37:0)
[20:25:18.285] Timer tick, asking Buildbucket for the build status
[20:25:18.401] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:18.401] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:38:0) after 1m0s
[20:26:18.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:38:0)
[20:26:18.438] Timer tick, asking Buildbucket for the build status
[20:26:18.494] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:18.494] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:39:0) after 1m0s
[20:27:18.523] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:39:0)
[20:27:18.523] Timer tick, asking Buildbucket for the build status
[20:27:18.571] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:18.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:40:0) after 1m0s
[20:28:18.605] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:40:0)
[20:28:18.605] Timer tick, asking Buildbucket for the build status
[20:28:18.819] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:18.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:41:0) after 1m0s
[20:29:18.842] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:41:0)
[20:29:18.842] Timer tick, asking Buildbucket for the build status
[20:29:18.970] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:18.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:42:0) after 1m0s
[20:30:18.990] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:42:0)
[20:30:18.990] Timer tick, asking Buildbucket for the build status
[20:30:19.046] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:19.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:43:0) after 1m0s
[20:31:19.024] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:43:0)
[20:31:19.024] Timer tick, asking Buildbucket for the build status
[20:31:19.268] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:19.268] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:44:0) after 1m0s
[20:32:19.276] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:44:0)
[20:32:19.276] Timer tick, asking Buildbucket for the build status
[20:32:19.345] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:19.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:45:0) after 1m0s
[20:33:19.339] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:45:0)
[20:33:19.339] Timer tick, asking Buildbucket for the build status
[20:33:19.499] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:19.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:46:0) after 1m0s
[20:34:19.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:46:0)
[20:34:19.497] Timer tick, asking Buildbucket for the build status
[20:34:19.554] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:19.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:47:0) after 1m0s
[20:35:19.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:47:0)
[20:35:19.569] Timer tick, asking Buildbucket for the build status
[20:35:19.649] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:19.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:48:0) after 1m0s
[20:36:19.625] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:48:0)
[20:36:19.625] Timer tick, asking Buildbucket for the build status
[20:36:19.685] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:19.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:49:0) after 1m0s
[20:37:19.693] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:49:0)
[20:37:19.693] Timer tick, asking Buildbucket for the build status
[20:37:19.893] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:19.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:50:0) after 1m0s
[20:38:19.991] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:50:0)
[20:38:19.991] Timer tick, asking Buildbucket for the build status
[20:38:20.105] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:38:20.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:51:0) after 1m0s
[20:39:20.139] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:51:0)
[20:39:20.139] Timer tick, asking Buildbucket for the build status
[20:39:20.285] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:20.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:52:0) after 1m0s
[20:40:20.290] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:52:0)
[20:40:20.290] Timer tick, asking Buildbucket for the build status
[20:40:20.368] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:40:20.368] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:53:0) after 1m0s
[20:41:20.351] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:53:0)
[20:41:20.351] Timer tick, asking Buildbucket for the build status
[20:41:20.468] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:20.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:54:0) after 1m0s
[20:42:20.490] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:54:0)
[20:42:20.490] Timer tick, asking Buildbucket for the build status
[20:42:20.785] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:20.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:55:0) after 1m0s
[20:43:20.807] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:55:0)
[20:43:20.808] Timer tick, asking Buildbucket for the build status
[20:43:20.858] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:20.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:56:0) after 1m0s
[20:44:20.877] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:56:0)
[20:44:20.877] Timer tick, asking Buildbucket for the build status
[20:44:20.992] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:20.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:57:0) after 1m0s
[20:45:21.015] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:57:0)
[20:45:21.015] Timer tick, asking Buildbucket for the build status
[20:45:21.097] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:21.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:58:0) after 1m0s
[20:46:21.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:58:0)
[20:46:21.119] Timer tick, asking Buildbucket for the build status
[20:46:21.168] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:21.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:59:0) after 1m0s
[20:47:21.192] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:59:0)
[20:47:21.192] Timer tick, asking Buildbucket for the build status
[20:47:21.266] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:21.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:60:0) after 1m0s
[20:48:21.298] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:60:0)
[20:48:21.298] Timer tick, asking Buildbucket for the build status
[20:48:21.390] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:21.390] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:61:0) after 1m0s
[20:49:21.420] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:61:0)
[20:49:21.420] Timer tick, asking Buildbucket for the build status
[20:49:21.476] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:21.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:62:0) after 1m0s
[20:50:21.494] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:62:0)
[20:50:21.494] Timer tick, asking Buildbucket for the build status
[20:50:21.652] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:21.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:63:0) after 1m0s
[20:51:21.731] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:63:0)
[20:51:21.731] Timer tick, asking Buildbucket for the build status
[20:51:21.800] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:21.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:64:0) after 1m0s
[20:52:21.797] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:64:0)
[20:52:21.797] Timer tick, asking Buildbucket for the build status
[20:52:21.876] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:21.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:65:0) after 1m0s
[20:53:21.873] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:65:0)
[20:53:21.873] Timer tick, asking Buildbucket for the build status
[20:53:21.942] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:21.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:66:0) after 1m0s
[20:54:21.964] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:66:0)
[20:54:21.964] Timer tick, asking Buildbucket for the build status
[20:54:22.089] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:22.089] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:67:0) after 1m0s
[20:55:22.153] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:67:0)
[20:55:22.153] Timer tick, asking Buildbucket for the build status
[20:55:22.218] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:22.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:68:0) after 1m0s
[20:56:22.307] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:68:0)
[20:56:22.307] Timer tick, asking Buildbucket for the build status
[20:56:22.390] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:22.390] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:69:0) after 1m0s
[20:57:22.413] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:69:0)
[20:57:22.413] Timer tick, asking Buildbucket for the build status
[20:57:22.635] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:22.635] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:70:0) after 1m0s
[20:58:22.630] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:70:0)
[20:58:22.630] Timer tick, asking Buildbucket for the build status
[20:58:22.692] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:22.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:71:0) after 1m0s
[20:59:22.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:71:0)
[20:59:22.722] Timer tick, asking Buildbucket for the build status
[20:59:22.805] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:22.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:72:0) after 1m0s
[21:00:22.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:72:0)
[21:00:22.808] Timer tick, asking Buildbucket for the build status
[21:00:22.874] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:22.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:73:0) after 1m0s
[21:01:22.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:73:0)
[21:01:22.967] Timer tick, asking Buildbucket for the build status
[21:01:23.049] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:23.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:74:0) after 1m0s
[21:02:23.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:74:0)
[21:02:23.072] Timer tick, asking Buildbucket for the build status
[21:02:23.258] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:23.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:75:0) after 1m0s
[21:03:23.281] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:75:0)
[21:03:23.281] Timer tick, asking Buildbucket for the build status
[21:03:23.382] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:23.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:76:0) after 1m0s
[21:04:23.375] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:76:0)
[21:04:23.376] Timer tick, asking Buildbucket for the build status
[21:04:23.473] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:23.473] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:77:0) after 1m0s
[21:05:23.506] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:77:0)
[21:05:23.506] Timer tick, asking Buildbucket for the build status
[21:05:23.614] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:23.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:78:0) after 1m0s
[21:06:23.634] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:78:0)
[21:06:23.634] Timer tick, asking Buildbucket for the build status
[21:06:23.766] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:23.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:79:0) after 1m0s
[21:07:23.790] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:79:0)
[21:07:23.790] Timer tick, asking Buildbucket for the build status
[21:07:23.994] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:23.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:80:0) after 1m0s
[21:08:24.036] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:80:0)
[21:08:24.036] Timer tick, asking Buildbucket for the build status
[21:08:24.109] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:24.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:81:0) after 1m0s
[21:09:24.096] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:81:0)
[21:09:24.096] Timer tick, asking Buildbucket for the build status
[21:09:24.179] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:24.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:82:0) after 1m0s
[21:10:24.213] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:82:0)
[21:10:24.213] Timer tick, asking Buildbucket for the build status
[21:10:24.266] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:24.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:83:0) after 1m0s
[21:11:24.290] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:83:0)
[21:11:24.290] Timer tick, asking Buildbucket for the build status
[21:11:24.455] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:24.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:84:0) after 1m0s
[21:12:24.476] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:84:0)
[21:12:24.476] Timer tick, asking Buildbucket for the build status
[21:12:24.534] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:24.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:85:0) after 1m0s
[21:13:24.557] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:85:0)
[21:13:24.557] Timer tick, asking Buildbucket for the build status
[21:13:24.622] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:24.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:86:0) after 1m0s
[21:14:24.681] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:86:0)
[21:14:24.681] Timer tick, asking Buildbucket for the build status
[21:14:24.792] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:24.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:87:0) after 1m0s
[21:15:24.830] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:87:0)
[21:15:24.830] Timer tick, asking Buildbucket for the build status
[21:15:24.934] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:24.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:88:0) after 1m0s
[21:16:24.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:88:0)
[21:16:24.962] Timer tick, asking Buildbucket for the build status
[21:16:25.104] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:25.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:89:0) after 1m0s
[21:17:25.101] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:89:0)
[21:17:25.101] Timer tick, asking Buildbucket for the build status
[21:17:25.237] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:25.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:90:0) after 1m0s
[21:18:25.260] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:90:0)
[21:18:25.260] Timer tick, asking Buildbucket for the build status
[21:18:25.360] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:25.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:91:0) after 1m0s
[21:19:25.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:91:0)
[21:19:25.398] Timer tick, asking Buildbucket for the build status
[21:19:25.584] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:25.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:92:0) after 1m0s
[21:20:25.625] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:92:0)
[21:20:25.625] Timer tick, asking Buildbucket for the build status
[21:20:25.738] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:25.738] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:93:0) after 1m0s
[21:21:25.764] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:93:0)
[21:21:25.764] Timer tick, asking Buildbucket for the build status
[21:21:26.044] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:26.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:94:0) after 1m0s
[21:22:26.086] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:94:0)
[21:22:26.086] Timer tick, asking Buildbucket for the build status
[21:22:26.336] Build 8917079472771220544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:26.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:95:0) after 1m0s
[21:22:41.283] Received PubSub notification, asking Buildbucket for the build status
[21:22:41.407] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:26.357] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:95:0)
[21:23:26.357] Timer tick, asking Buildbucket for the build status
[21:23:26.460] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:26.460] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:97:0) after 1m0s
[21:24:26.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:97:0)
[21:24:26.491] Timer tick, asking Buildbucket for the build status
[21:24:26.548] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:26.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:98:0) after 1m0s
[21:25:26.571] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:98:0)
[21:25:26.571] Timer tick, asking Buildbucket for the build status
[21:25:26.679] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:26.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:99:0) after 1m0s
[21:26:26.698] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:99:0)
[21:26:26.698] Timer tick, asking Buildbucket for the build status
[21:26:26.883] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:26.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:100:0) after 1m0s
[21:27:26.995] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:100:0)
[21:27:26.995] Timer tick, asking Buildbucket for the build status
[21:27:27.091] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:27.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:101:0) after 1m0s
[21:28:27.081] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:101:0)
[21:28:27.081] Timer tick, asking Buildbucket for the build status
[21:28:27.196] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:27.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:102:0) after 1m0s
[21:29:27.200] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:102:0)
[21:29:27.200] Timer tick, asking Buildbucket for the build status
[21:29:27.303] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:27.303] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:103:0) after 1m0s
[21:30:27.335] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:103:0)
[21:30:27.335] Timer tick, asking Buildbucket for the build status
[21:30:27.403] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:27.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:104:0) after 1m0s
[21:31:27.427] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:104:0)
[21:31:27.427] Timer tick, asking Buildbucket for the build status
[21:31:27.471] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:27.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:105:0) after 1m0s
[21:32:27.480] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:105:0)
[21:32:27.480] Timer tick, asking Buildbucket for the build status
[21:32:27.531] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:27.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:106:0) after 1m0s
[21:33:27.563] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:106:0)
[21:33:27.563] Timer tick, asking Buildbucket for the build status
[21:33:27.612] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:27.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:107:0) after 1m0s
[21:34:27.632] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:107:0)
[21:34:27.632] Timer tick, asking Buildbucket for the build status
[21:34:27.687] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:27.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:108:0) after 1m0s
[21:35:27.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:108:0)
[21:35:27.722] Timer tick, asking Buildbucket for the build status
[21:35:27.807] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:27.807] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:109:0) after 1m0s
[21:36:27.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:109:0)
[21:36:27.843] Timer tick, asking Buildbucket for the build status
[21:36:27.905] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:27.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:110:0) after 1m0s
[21:37:27.917] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:110:0)
[21:37:27.917] Timer tick, asking Buildbucket for the build status
[21:37:27.976] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:27.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:111:0) after 1m0s
[21:38:27.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:111:0)
[21:38:27.971] Timer tick, asking Buildbucket for the build status
[21:38:28.095] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:28.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:112:0) after 1m0s
[21:39:28.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:112:0)
[21:39:28.119] Timer tick, asking Buildbucket for the build status
[21:39:28.252] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:28.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:113:0) after 1m0s
[21:40:28.278] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:113:0)
[21:40:28.278] Timer tick, asking Buildbucket for the build status
[21:40:28.391] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:28.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:114:0) after 1m0s
[21:41:28.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:114:0)
[21:41:28.397] Timer tick, asking Buildbucket for the build status
[21:41:28.440] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:28.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:115:0) after 1m0s
[21:42:28.464] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:115:0)
[21:42:28.464] Timer tick, asking Buildbucket for the build status
[21:42:28.521] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:28.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:116:0) after 1m0s
[21:43:28.543] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:116:0)
[21:43:28.543] Timer tick, asking Buildbucket for the build status
[21:43:28.644] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:28.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:117:0) after 1m0s
[21:44:28.665] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:117:0)
[21:44:28.665] Timer tick, asking Buildbucket for the build status
[21:44:28.819] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:28.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:118:0) after 1m0s
[21:45:28.848] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:118:0)
[21:45:28.848] Timer tick, asking Buildbucket for the build status
[21:45:28.949] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:28.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:119:0) after 1m0s
[21:46:28.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:119:0)
[21:46:28.971] Timer tick, asking Buildbucket for the build status
[21:46:29.112] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:29.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:120:0) after 1m0s
[21:47:29.132] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:120:0)
[21:47:29.132] Timer tick, asking Buildbucket for the build status
[21:47:29.251] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:29.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:121:0) after 1m0s
[21:48:29.281] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:121:0)
[21:48:29.281] Timer tick, asking Buildbucket for the build status
[21:48:29.407] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:29.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:122:0) after 1m0s
[21:49:29.429] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:122:0)
[21:49:29.429] Timer tick, asking Buildbucket for the build status
[21:49:29.524] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:29.524] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:123:0) after 1m0s
[21:50:29.546] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:123:0)
[21:50:29.546] Timer tick, asking Buildbucket for the build status
[21:50:29.653] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:29.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:124:0) after 1m0s
[21:51:29.677] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:124:0)
[21:51:29.677] Timer tick, asking Buildbucket for the build status
[21:51:29.905] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:29.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:125:0) after 1m0s
[21:52:29.913] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:125:0)
[21:52:29.913] Timer tick, asking Buildbucket for the build status
[21:52:30.128] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:30.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:126:0) after 1m0s
[21:53:30.150] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:126:0)
[21:53:30.150] Timer tick, asking Buildbucket for the build status
[21:53:30.293] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:30.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:127:0) after 1m0s
[21:54:30.314] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:127:0)
[21:54:30.314] Timer tick, asking Buildbucket for the build status
[21:54:30.384] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:30.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:128:0) after 1m0s
[21:55:30.416] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:128:0)
[21:55:30.416] Timer tick, asking Buildbucket for the build status
[21:55:30.770] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:30.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:129:0) after 1m0s
[21:56:30.792] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:129:0)
[21:56:30.792] Timer tick, asking Buildbucket for the build status
[21:56:31.295] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:31.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:130:0) after 1m0s
[21:57:31.321] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:130:0)
[21:57:31.321] Timer tick, asking Buildbucket for the build status
[21:57:31.428] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:31.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:131:0) after 1m0s
[21:58:31.442] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:131:0)
[21:58:31.442] Timer tick, asking Buildbucket for the build status
[21:58:31.657] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:31.657] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:132:0) after 1m0s
[21:59:31.688] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:132:0)
[21:59:31.688] Timer tick, asking Buildbucket for the build status
[21:59:31.899] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:31.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:133:0) after 1m0s
[22:00:31.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:133:0)
[22:00:31.921] Timer tick, asking Buildbucket for the build status
[22:00:31.973] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:31.973] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:134:0) after 1m0s
[22:01:31.998] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:134:0)
[22:01:31.998] Timer tick, asking Buildbucket for the build status
[22:01:32.103] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:32.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:135:0) after 1m0s
[22:02:32.125] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:135:0)
[22:02:32.125] Timer tick, asking Buildbucket for the build status
[22:02:32.205] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:32.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:136:0) after 1m0s
[22:03:32.226] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:136:0)
[22:03:32.226] Timer tick, asking Buildbucket for the build status
[22:03:32.265] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:32.265] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:137:0) after 1m0s
[22:04:32.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:137:0)
[22:04:32.280] Timer tick, asking Buildbucket for the build status
[22:04:32.335] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:32.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:138:0) after 1m0s
[22:05:32.371] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:138:0)
[22:05:32.371] Timer tick, asking Buildbucket for the build status
[22:05:32.472] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:32.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:139:0) after 1m0s
[22:06:32.475] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:139:0)
[22:06:32.475] Timer tick, asking Buildbucket for the build status
[22:06:32.523] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:32.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:140:0) after 1m0s
[22:07:32.506] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:140:0)
[22:07:32.506] Timer tick, asking Buildbucket for the build status
[22:07:32.573] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:32.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:141:0) after 1m0s
[22:08:32.702] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:141:0)
[22:08:32.702] Timer tick, asking Buildbucket for the build status
[22:08:32.802] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:32.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:142:0) after 1m0s
[22:09:32.812] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:142:0)
[22:09:32.812] Timer tick, asking Buildbucket for the build status
[22:09:32.888] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:32.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:143:0) after 1m0s
[22:10:32.912] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:143:0)
[22:10:32.912] Timer tick, asking Buildbucket for the build status
[22:10:32.955] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:32.955] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:144:0) after 1m0s
[22:11:32.980] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:144:0)
[22:11:32.980] Timer tick, asking Buildbucket for the build status
[22:11:33.076] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:33.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:145:0) after 1m0s
[22:12:33.073] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:145:0)
[22:12:33.073] Timer tick, asking Buildbucket for the build status
[22:12:33.214] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:33.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:146:0) after 1m0s
[22:13:33.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:146:0)
[22:13:33.203] Timer tick, asking Buildbucket for the build status
[22:13:33.250] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:33.250] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:147:0) after 1m0s
[22:14:33.276] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:147:0)
[22:14:33.276] Timer tick, asking Buildbucket for the build status
[22:14:33.318] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:33.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:148:0) after 1m0s
[22:15:33.330] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:148:0)
[22:15:33.330] Timer tick, asking Buildbucket for the build status
[22:15:33.387] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:33.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:149:0) after 1m0s
[22:16:33.371] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:149:0)
[22:16:33.371] Timer tick, asking Buildbucket for the build status
[22:16:33.412] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:33.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:150:0) after 1m0s
[22:17:33.435] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:150:0)
[22:17:33.435] Timer tick, asking Buildbucket for the build status
[22:17:33.642] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:33.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:151:0) after 1m0s
[22:18:33.623] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:151:0)
[22:18:33.623] Timer tick, asking Buildbucket for the build status
[22:18:33.698] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:33.698] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:152:0) after 1m0s
[22:19:33.716] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:152:0)
[22:19:33.716] Timer tick, asking Buildbucket for the build status
[22:19:33.781] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:33.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:153:0) after 1m0s
[22:20:33.796] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:153:0)
[22:20:33.796] Timer tick, asking Buildbucket for the build status
[22:20:33.938] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:33.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:154:0) after 1m0s
[22:21:33.914] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:154:0)
[22:21:33.914] Timer tick, asking Buildbucket for the build status
[22:21:33.992] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:33.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:155:0) after 1m0s
[22:22:34.015] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:155:0)
[22:22:34.016] Timer tick, asking Buildbucket for the build status
[22:22:34.064] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:34.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:156:0) after 1m0s
[22:23:34.116] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:156:0)
[22:23:34.116] Timer tick, asking Buildbucket for the build status
[22:23:34.182] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:34.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:157:0) after 1m0s
[22:24:34.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:157:0)
[22:24:34.202] Timer tick, asking Buildbucket for the build status
[22:24:34.365] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:34.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:158:0) after 1m0s
[22:25:34.392] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:158:0)
[22:25:34.392] Timer tick, asking Buildbucket for the build status
[22:25:34.534] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:34.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:159:0) after 1m0s
[22:26:34.559] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:159:0)
[22:26:34.559] Timer tick, asking Buildbucket for the build status
[22:26:34.869] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:34.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:160:0) after 1m0s
[22:27:34.883] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:160:0)
[22:27:34.883] Timer tick, asking Buildbucket for the build status
[22:27:35.032] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:35.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:161:0) after 1m0s
[22:28:35.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:161:0)
[22:28:35.035] Timer tick, asking Buildbucket for the build status
[22:28:35.103] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:35.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:162:0) after 1m0s
[22:29:35.129] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:162:0)
[22:29:35.129] Timer tick, asking Buildbucket for the build status
[22:29:35.171] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:35.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:163:0) after 1m0s
[22:30:35.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:163:0)
[22:30:35.168] Timer tick, asking Buildbucket for the build status
[22:30:35.276] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:35.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:164:0) after 1m0s
[22:31:35.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:164:0)
[22:31:35.300] Timer tick, asking Buildbucket for the build status
[22:31:35.604] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:35.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:165:0) after 1m0s
[22:32:35.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:165:0)
[22:32:35.616] Timer tick, asking Buildbucket for the build status
[22:32:35.828] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:35.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:166:0) after 1m0s
[22:33:35.851] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:166:0)
[22:33:35.851] Timer tick, asking Buildbucket for the build status
[22:33:36.194] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:36.194] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:167:0) after 1m0s
[22:34:36.174] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:167:0)
[22:34:36.174] Timer tick, asking Buildbucket for the build status
[22:34:36.215] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:36.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:168:0) after 1m0s
[22:35:36.236] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:168:0)
[22:35:36.236] Timer tick, asking Buildbucket for the build status
[22:35:36.425] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:36.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:169:0) after 1m0s
[22:36:36.436] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:169:0)
[22:36:36.436] Timer tick, asking Buildbucket for the build status
[22:36:36.594] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:36.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:170:0) after 1m0s
[22:37:36.606] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:170:0)
[22:37:36.606] Timer tick, asking Buildbucket for the build status
[22:37:36.668] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:36.668] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:171:0) after 1m0s
[22:38:36.712] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:171:0)
[22:38:36.712] Timer tick, asking Buildbucket for the build status
[22:38:36.910] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:36.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:172:0) after 1m0s
[22:39:36.912] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:172:0)
[22:39:36.912] Timer tick, asking Buildbucket for the build status
[22:39:36.999] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:36.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:173:0) after 1m0s
[22:40:37.030] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:173:0)
[22:40:37.030] Timer tick, asking Buildbucket for the build status
[22:40:37.119] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:37.119] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:174:0) after 1m0s
[22:41:37.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:174:0)
[22:41:37.147] Timer tick, asking Buildbucket for the build status
[22:41:37.271] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:37.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:175:0) after 1m0s
[22:42:37.313] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:175:0)
[22:42:37.313] Timer tick, asking Buildbucket for the build status
[22:42:37.452] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:37.452] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:176:0) after 1m0s
[22:43:37.471] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:176:0)
[22:43:37.471] Timer tick, asking Buildbucket for the build status
[22:43:37.710] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:37.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:177:0) after 1m0s
[22:44:37.734] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:177:0)
[22:44:37.734] Timer tick, asking Buildbucket for the build status
[22:44:37.993] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:37.993] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:178:0) after 1m0s
[22:45:37.987] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:178:0)
[22:45:37.987] Timer tick, asking Buildbucket for the build status
[22:45:38.055] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:38.056] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:179:0) after 1m0s
[22:46:38.053] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:179:0)
[22:46:38.053] Timer tick, asking Buildbucket for the build status
[22:46:38.109] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:38.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:180:0) after 1m0s
[22:47:38.097] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:180:0)
[22:47:38.097] Timer tick, asking Buildbucket for the build status
[22:47:38.192] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:38.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:181:0) after 1m0s
[22:48:38.215] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:181:0)
[22:48:38.215] Timer tick, asking Buildbucket for the build status
[22:48:38.494] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:38.494] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:182:0) after 1m0s
[22:49:38.511] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:182:0)
[22:49:38.511] Timer tick, asking Buildbucket for the build status
[22:49:38.696] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:38.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:183:0) after 1m0s
[22:50:38.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:183:0)
[22:50:38.721] Timer tick, asking Buildbucket for the build status
[22:50:38.967] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:38.967] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:184:0) after 1m0s
[22:51:38.992] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:184:0)
[22:51:38.992] Timer tick, asking Buildbucket for the build status
[22:51:39.095] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:39.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:185:0) after 1m0s
[22:52:39.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:185:0)
[22:52:39.119] Timer tick, asking Buildbucket for the build status
[22:52:39.173] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:39.173] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:186:0) after 1m0s
[22:53:39.198] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:186:0)
[22:53:39.199] Timer tick, asking Buildbucket for the build status
[22:53:39.476] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:39.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:187:0) after 1m0s
[22:54:39.519] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:187:0)
[22:54:39.519] Timer tick, asking Buildbucket for the build status
[22:54:39.566] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:39.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:188:0) after 1m0s
[22:55:39.590] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:188:0)
[22:55:39.590] Timer tick, asking Buildbucket for the build status
[22:55:39.643] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:39.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:189:0) after 1m0s
[22:56:39.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:189:0)
[22:56:39.722] Timer tick, asking Buildbucket for the build status
[22:56:39.777] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:39.777] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:190:0) after 1m0s
[22:57:39.833] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:190:0)
[22:57:39.833] Timer tick, asking Buildbucket for the build status
[22:57:39.872] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:39.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:191:0) after 1m0s
[22:58:39.885] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:191:0)
[22:58:39.885] Timer tick, asking Buildbucket for the build status
[22:58:39.990] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:39.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:192:0) after 1m0s
[22:59:39.985] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:192:0)
[22:59:39.985] Timer tick, asking Buildbucket for the build status
[22:59:40.089] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:40.089] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:193:0) after 1m0s
[23:00:40.122] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:193:0)
[23:00:40.122] Timer tick, asking Buildbucket for the build status
[23:00:40.168] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:40.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:194:0) after 1m0s
[23:01:40.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:194:0)
[23:01:40.185] Timer tick, asking Buildbucket for the build status
[23:01:40.234] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:40.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:195:0) after 1m0s
[23:02:40.259] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:195:0)
[23:02:40.259] Timer tick, asking Buildbucket for the build status
[23:02:40.314] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:40.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:196:0) after 1m0s
[23:03:40.338] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:196:0)
[23:03:40.338] Timer tick, asking Buildbucket for the build status
[23:03:42.411] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:42.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:197:0) after 1m0s
[23:04:42.445] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:197:0)
[23:04:42.445] Timer tick, asking Buildbucket for the build status
[23:04:42.538] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:42.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:198:0) after 1m0s
[23:05:42.561] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:198:0)
[23:05:42.561] Timer tick, asking Buildbucket for the build status
[23:05:42.806] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:42.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:199:0) after 1m0s
[23:06:42.833] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:199:0)
[23:06:42.833] Timer tick, asking Buildbucket for the build status
[23:06:42.888] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:42.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:200:0) after 1m0s
[23:07:42.917] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:200:0)
[23:07:42.917] Timer tick, asking Buildbucket for the build status
[23:07:42.958] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:42.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:201:0) after 1m0s
[23:08:42.985] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:201:0)
[23:08:42.985] Timer tick, asking Buildbucket for the build status
[23:08:43.036] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:43.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:202:0) after 1m0s
[23:09:43.103] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:202:0)
[23:09:43.103] Timer tick, asking Buildbucket for the build status
[23:09:43.141] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:43.141] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:203:0) after 1m0s
[23:10:43.166] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:203:0)
[23:10:43.166] Timer tick, asking Buildbucket for the build status
[23:10:43.258] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:43.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:204:0) after 1m0s
[23:11:43.282] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:204:0)
[23:11:43.282] Timer tick, asking Buildbucket for the build status
[23:11:43.340] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:43.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:205:0) after 1m0s
[23:12:43.366] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:205:0)
[23:12:43.366] Timer tick, asking Buildbucket for the build status
[23:12:43.411] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:43.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:206:0) after 1m0s
[23:13:43.435] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:206:0)
[23:13:43.435] Timer tick, asking Buildbucket for the build status
[23:13:43.490] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:43.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:207:0) after 1m0s
[23:14:43.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:207:0)
[23:14:43.497] Timer tick, asking Buildbucket for the build status
[23:14:43.766] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:43.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:208:0) after 1m0s
[23:15:43.791] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:208:0)
[23:15:43.791] Timer tick, asking Buildbucket for the build status
[23:15:44.067] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:44.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:209:0) after 1m0s
[23:16:44.051] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:209:0)
[23:16:44.051] Timer tick, asking Buildbucket for the build status
[23:16:44.100] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:44.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:210:0) after 1m0s
[23:17:44.139] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:210:0)
[23:17:44.139] Timer tick, asking Buildbucket for the build status
[23:17:44.215] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:44.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:211:0) after 1m0s
[23:18:44.241] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:211:0)
[23:18:44.241] Timer tick, asking Buildbucket for the build status
[23:18:44.292] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:44.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:212:0) after 1m0s
[23:19:44.267] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:212:0)
[23:19:44.267] Timer tick, asking Buildbucket for the build status
[23:19:44.408] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:44.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:213:0) after 1m0s
[23:20:44.484] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:213:0)
[23:20:44.484] Timer tick, asking Buildbucket for the build status
[23:20:44.529] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:44.529] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:214:0) after 1m0s
[23:21:44.574] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:214:0)
[23:21:44.574] Timer tick, asking Buildbucket for the build status
[23:21:44.626] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:44.627] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:215:0) after 1m0s
[23:22:44.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:215:0)
[23:22:44.652] Timer tick, asking Buildbucket for the build status
[23:22:44.694] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:44.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:216:0) after 1m0s
[23:23:44.703] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:216:0)
[23:23:44.703] Timer tick, asking Buildbucket for the build status
[23:23:44.878] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:44.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:217:0) after 1m0s
[23:24:44.909] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:217:0)
[23:24:44.909] Timer tick, asking Buildbucket for the build status
[23:24:44.949] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:44.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:218:0) after 1m0s
[23:25:44.973] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:218:0)
[23:25:44.973] Timer tick, asking Buildbucket for the build status
[23:25:45.088] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:45.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:219:0) after 1m0s
[23:26:45.126] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:219:0)
[23:26:45.126] Timer tick, asking Buildbucket for the build status
[23:26:45.572] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:45.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:220:0) after 1m0s
[23:27:45.606] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:220:0)
[23:27:45.606] Timer tick, asking Buildbucket for the build status
[23:27:45.691] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:45.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:221:0) after 1m0s
[23:28:45.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:221:0)
[23:28:45.715] Timer tick, asking Buildbucket for the build status
[23:28:45.869] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:45.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:222:0) after 1m0s
[23:29:45.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:222:0)
[23:29:45.906] Timer tick, asking Buildbucket for the build status
[23:29:46.015] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:46.015] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:223:0) after 1m0s
[23:30:46.013] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:223:0)
[23:30:46.013] Timer tick, asking Buildbucket for the build status
[23:30:46.076] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:46.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:224:0) after 1m0s
[23:31:46.108] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:224:0)
[23:31:46.108] Timer tick, asking Buildbucket for the build status
[23:31:46.207] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:46.207] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:225:0) after 1m0s
[23:32:46.235] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:225:0)
[23:32:46.235] Timer tick, asking Buildbucket for the build status
[23:32:46.429] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:46.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:226:0) after 1m0s
[23:33:46.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:226:0)
[23:33:46.455] Timer tick, asking Buildbucket for the build status
[23:33:46.500] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:46.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:227:0) after 1m0s
[23:34:46.492] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:227:0)
[23:34:46.492] Timer tick, asking Buildbucket for the build status
[23:34:46.535] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:46.535] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:228:0) after 1m0s
[23:35:46.614] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:228:0)
[23:35:46.614] Timer tick, asking Buildbucket for the build status
[23:35:46.684] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:46.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:229:0) after 1m0s
[23:36:46.694] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:229:0)
[23:36:46.694] Timer tick, asking Buildbucket for the build status
[23:36:46.735] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:46.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:230:0) after 1m0s
[23:37:46.718] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:230:0)
[23:37:46.718] Timer tick, asking Buildbucket for the build status
[23:37:46.970] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:46.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:231:0) after 1m0s
[23:38:46.997] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:231:0)
[23:38:46.997] Timer tick, asking Buildbucket for the build status
[23:38:47.114] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:47.114] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:232:0) after 1m0s
[23:39:47.141] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:232:0)
[23:39:47.142] Timer tick, asking Buildbucket for the build status
[23:39:47.226] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:47.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:233:0) after 1m0s
[23:40:47.252] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:233:0)
[23:40:47.252] Timer tick, asking Buildbucket for the build status
[23:40:47.376] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:47.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:234:0) after 1m0s
[23:41:47.421] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:234:0)
[23:41:47.421] Timer tick, asking Buildbucket for the build status
[23:41:47.564] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:47.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:235:0) after 1m0s
[23:42:47.605] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:235:0)
[23:42:47.605] Timer tick, asking Buildbucket for the build status
[23:42:47.656] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:47.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:236:0) after 1m0s
[23:43:47.681] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:236:0)
[23:43:47.681] Timer tick, asking Buildbucket for the build status
[23:43:47.796] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:47.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:237:0) after 1m0s
[23:44:47.819] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:237:0)
[23:44:47.819] Timer tick, asking Buildbucket for the build status
[23:44:47.864] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:47.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:238:0) after 1m0s
[23:45:47.889] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:238:0)
[23:45:47.889] Timer tick, asking Buildbucket for the build status
[23:45:48.100] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:48.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:239:0) after 1m0s
[23:46:48.124] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:239:0)
[23:46:48.124] Timer tick, asking Buildbucket for the build status
[23:46:48.409] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:48.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:240:0) after 1m0s
[23:47:48.435] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:240:0)
[23:47:48.435] Timer tick, asking Buildbucket for the build status
[23:47:48.476] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:48.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:241:0) after 1m0s
[23:48:48.520] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:241:0)
[23:48:48.520] Timer tick, asking Buildbucket for the build status
[23:48:48.631] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:48.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:242:0) after 1m0s
[23:49:48.634] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:242:0)
[23:49:48.634] Timer tick, asking Buildbucket for the build status
[23:49:48.669] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:48.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:243:0) after 1m0s
[23:50:48.750] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:243:0)
[23:50:48.750] Timer tick, asking Buildbucket for the build status
[23:50:48.813] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:48.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:244:0) after 1m0s
[23:51:48.833] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:244:0)
[23:51:48.833] Timer tick, asking Buildbucket for the build status
[23:51:48.918] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:48.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:245:0) after 1m0s
[23:52:48.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:245:0)
[23:52:48.900] Timer tick, asking Buildbucket for the build status
[23:52:48.982] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:48.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:246:0) after 1m0s
[23:53:49.016] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:246:0)
[23:53:49.016] Timer tick, asking Buildbucket for the build status
[23:53:49.267] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:49.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:247:0) after 1m0s
[23:54:49.263] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:247:0)
[23:54:49.263] Timer tick, asking Buildbucket for the build status
[23:54:49.368] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:49.368] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:248:0) after 1m0s
[23:55:49.377] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:248:0)
[23:55:49.377] Timer tick, asking Buildbucket for the build status
[23:55:49.422] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:49.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:249:0) after 1m0s
[23:56:49.446] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:249:0)
[23:56:49.446] Timer tick, asking Buildbucket for the build status
[23:56:49.581] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:49.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:250:0) after 1m0s
[23:57:49.627] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:250:0)
[23:57:49.627] Timer tick, asking Buildbucket for the build status
[23:57:50.078] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:50.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:251:0) after 1m0s
[23:58:50.102] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:251:0)
[23:58:50.102] Timer tick, asking Buildbucket for the build status
[23:58:50.153] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:50.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:252:0) after 1m0s
[23:59:50.183] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:252:0)
[23:59:50.183] Timer tick, asking Buildbucket for the build status
[23:59:50.226] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:50.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:253:0) after 1m0s
[00:00:50.255] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:253:0)
[00:00:50.255] Timer tick, asking Buildbucket for the build status
[00:00:50.348] Build 8917079472771220544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:50.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9082509535510455280:254:0) after 1m0s
[00:01:26.429] Received PubSub notification, asking Buildbucket for the build status
[00:01:26.783] Build 8917079472771220544: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:01:26.783] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1554422485852981",
    "created_by": "project:nacl",
    "created_ts": "1554407351672188",
    "failure_reason": "BUILD_FAILURE",
    "id": "8917079472771220544",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"2c300847c7700af6948ad78e79ccd21bd7ba0c14\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"Step('annotated steps') failed with return_code 1\"}, \"properties\": {\"$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}, \"bot_id\": \"gce-trusty-16-145e5bab-us-west1-c-p02c\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-pnacl-x86_64-tests-arm\", \"buildnumber\": 4705, \"got_revision\": \"2c300847c7700af6948ad78e79ccd21bd7ba0c14\", \"mastername\": \"client.nacl.toolchain\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"2c300847c7700af6948ad78e79ccd21bd7ba0c14\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"16\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"gce-trusty-16-145e5bab-us-west1-c-p02c\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.nacl.toolchain\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4243-f38882f\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"Step('annotated steps') failed with return_code 1\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1554412960640312",
    "status": "COMPLETED",
    "status_changed_ts": "1554412961075565",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4705",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/2c300847c7700af6948ad78e79ccd21bd7ba0c14",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/2c300847c7700af6948ad78e79ccd21bd7ba0c14",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9082509535510455280",
      "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/8917079472771220544/+/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:4402b77390e4b010",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1554422486161140",
    "url": "https://ci.chromium.org/b/8917079472771220544",
    "utcnow_ts": "1554422486769015"
  }
}
[00:01:26.783] Invocation finished in 4h12m17.107308462s with status FAILED