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

• f27b39dd0540f360e7d1277b63650b64ed4e09db (4 years ago)

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

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

[01:06:24.878] New invocation is queued and will start shortly
[01:06:30.266] Starting the invocation (attempt 1)
[01:06:30.302] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:06:30.302] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:06:30.302] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9049512279903783456",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-x86_64\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"f27b39dd0540f360e7d1277b63650b64ed4e09db\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f27b39dd0540f360e7d1277b63650b64ed4e09db\",\"title\":\"f27b39dd0540f360e7d1277b63650b64ed4e09db\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/f27b39dd0540f360e7d1277b63650b64ed4e09db\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"f27b39dd0540f360e7d1277b63650b64ed4e09db\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-pnacl-x86_64-tests-x86_64",
    "scheduler_invocation_id:9049512279903783456",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/f27b39dd0540f360e7d1277b63650b64ed4e09db",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f27b39dd0540f360e7d1277b63650b64ed4e09db",
    "gitiles_ref:refs/heads/master"
  ]
}
[01:06:31.846] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1585875990389550",
    "id": "8884082213460597184",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f27b39dd0540f360e7d1277b63650b64ed4e09db\", \"title\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/f27b39dd0540f360e7d1277b63650b64ed4e09db\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1585875991610351",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_64/5098",
      "builder:linux-pnacl-x86_64-tests-x86_64",
      "buildset:commit/git/f27b39dd0540f360e7d1277b63650b64ed4e09db",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f27b39dd0540f360e7d1277b63650b64ed4e09db",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9049512279903783456",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_64",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8884082213460597184/+/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": "1585875991610531",
    "url": "https://ci.chromium.org/b/8884082213460597184",
    "utcnow_ts": "1585875991823050"
  }
}
[01:06:31.846] Task URL: https://ci.chromium.org/b/8884082213460597184
[01:06:31.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:2:0) after 1m0s
[01:07:31.956] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:2:0)
[01:07:31.956] Timer tick, asking Buildbucket for the build status
[01:07:32.180] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:32.180] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:3:0) after 1m0s
[01:08:32.232] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:3:0)
[01:08:32.232] Timer tick, asking Buildbucket for the build status
[01:08:32.421] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:32.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:4:0) after 1m0s
[01:09:32.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:4:0)
[01:09:32.497] Timer tick, asking Buildbucket for the build status
[01:09:33.003] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:33.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:5:0) after 1m0s
[01:10:33.099] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:5:0)
[01:10:33.099] Timer tick, asking Buildbucket for the build status
[01:10:33.243] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:33.243] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:6:0) after 1m0s
[01:11:33.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:6:0)
[01:11:33.300] Timer tick, asking Buildbucket for the build status
[01:11:33.835] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:33.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:7:0) after 1m0s
[01:12:34.023] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:7:0)
[01:12:34.023] Timer tick, asking Buildbucket for the build status
[01:12:34.212] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:34.212] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:8:0) after 1m0s
[01:13:34.379] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:8:0)
[01:13:34.379] Timer tick, asking Buildbucket for the build status
[01:13:34.511] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:34.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:9:0) after 1m0s
[01:14:34.540] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:9:0)
[01:14:34.540] Timer tick, asking Buildbucket for the build status
[01:14:35.184] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:35.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:10:0) after 1m0s
[01:15:35.420] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:10:0)
[01:15:35.420] Timer tick, asking Buildbucket for the build status
[01:15:35.579] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:35.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:11:0) after 1m0s
[01:16:35.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:11:0)
[01:16:35.808] Timer tick, asking Buildbucket for the build status
[01:16:36.021] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:36.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:12:0) after 1m0s
[01:17:36.298] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:12:0)
[01:17:36.298] Timer tick, asking Buildbucket for the build status
[01:17:36.572] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:36.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:13:0) after 1m0s
[01:18:36.629] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:13:0)
[01:18:36.629] Timer tick, asking Buildbucket for the build status
[01:18:36.732] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:36.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:14:0) after 1m0s
[01:19:36.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:14:0)
[01:19:36.962] Timer tick, asking Buildbucket for the build status
[01:19:37.139] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:37.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:15:0) after 1m0s
[01:20:37.157] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:15:0)
[01:20:37.157] Timer tick, asking Buildbucket for the build status
[01:20:37.616] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:37.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:16:0) after 1m0s
[01:21:37.698] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:16:0)
[01:21:37.698] Timer tick, asking Buildbucket for the build status
[01:21:37.820] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:37.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:17:0) after 1m0s
[01:22:37.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:17:0)
[01:22:37.844] Timer tick, asking Buildbucket for the build status
[01:22:38.011] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:38.011] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:18:0) after 1m0s
[01:23:38.033] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:18:0)
[01:23:38.033] Timer tick, asking Buildbucket for the build status
[01:23:38.415] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:38.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:19:0) after 1m0s
[01:24:38.480] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:19:0)
[01:24:38.480] Timer tick, asking Buildbucket for the build status
[01:24:38.605] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:38.605] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:20:0) after 1m0s
[01:25:38.774] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:20:0)
[01:25:38.774] Timer tick, asking Buildbucket for the build status
[01:25:38.932] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:38.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:21:0) after 1m0s
[01:26:38.989] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:21:0)
[01:26:38.989] Timer tick, asking Buildbucket for the build status
[01:26:39.152] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:39.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:22:0) after 1m0s
[01:27:39.209] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:22:0)
[01:27:39.209] Timer tick, asking Buildbucket for the build status
[01:27:39.670] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:39.670] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:23:0) after 1m0s
[01:28:39.761] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:23:0)
[01:28:39.761] Timer tick, asking Buildbucket for the build status
[01:28:40.905] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:40.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:24:0) after 1m0s
[01:29:40.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:24:0)
[01:29:40.921] Timer tick, asking Buildbucket for the build status
[01:29:41.608] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:41.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:25:0) after 1m0s
[01:30:41.882] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:25:0)
[01:30:41.882] Timer tick, asking Buildbucket for the build status
[01:30:42.020] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:42.020] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:26:0) after 1m0s
[01:31:42.115] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:26:0)
[01:31:42.115] Timer tick, asking Buildbucket for the build status
[01:31:42.241] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:42.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:27:0) after 1m0s
[01:32:42.324] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:27:0)
[01:32:42.324] Timer tick, asking Buildbucket for the build status
[01:32:42.760] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:42.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:28:0) after 1m0s
[01:33:42.774] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:28:0)
[01:33:42.774] Timer tick, asking Buildbucket for the build status
[01:33:42.935] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:42.935] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:29:0) after 1m0s
[01:34:43.037] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:29:0)
[01:34:43.037] Timer tick, asking Buildbucket for the build status
[01:34:43.195] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:43.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:30:0) after 1m0s
[01:35:43.261] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:30:0)
[01:35:43.261] Timer tick, asking Buildbucket for the build status
[01:35:43.642] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:43.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:31:0) after 1m0s
[01:36:43.662] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:31:0)
[01:36:43.662] Timer tick, asking Buildbucket for the build status
[01:36:43.892] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:43.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:32:0) after 1m0s
[01:37:44.073] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:32:0)
[01:37:44.073] Timer tick, asking Buildbucket for the build status
[01:37:44.346] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:44.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:33:0) after 1m0s
[01:38:44.565] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:33:0)
[01:38:44.565] Timer tick, asking Buildbucket for the build status
[01:38:44.857] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:44.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:34:0) after 1m0s
[01:39:44.902] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:34:0)
[01:39:44.902] Timer tick, asking Buildbucket for the build status
[01:39:45.351] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:45.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:35:0) after 1m0s
[01:40:45.432] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:35:0)
[01:40:45.432] Timer tick, asking Buildbucket for the build status
[01:40:45.605] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:45.605] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:36:0) after 1m0s
[01:41:45.761] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:36:0)
[01:41:45.761] Timer tick, asking Buildbucket for the build status
[01:41:45.951] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:45.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:37:0) after 1m0s
[01:42:46.012] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:37:0)
[01:42:46.012] Timer tick, asking Buildbucket for the build status
[01:42:46.382] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:46.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:38:0) after 1m0s
[01:43:46.478] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:38:0)
[01:43:46.478] Timer tick, asking Buildbucket for the build status
[01:43:46.641] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:46.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:39:0) after 1m0s
[01:44:46.703] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:39:0)
[01:44:46.703] Timer tick, asking Buildbucket for the build status
[01:44:47.045] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:47.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:40:0) after 1m0s
[01:45:47.067] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:40:0)
[01:45:47.067] Timer tick, asking Buildbucket for the build status
[01:45:47.241] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:47.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:41:0) after 1m0s
[01:46:47.337] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:41:0)
[01:46:47.337] Timer tick, asking Buildbucket for the build status
[01:46:47.625] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:47.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:42:0) after 1m0s
[01:47:47.746] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:42:0)
[01:47:47.746] Timer tick, asking Buildbucket for the build status
[01:47:47.965] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:47.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:43:0) after 1m0s
[01:48:47.989] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:43:0)
[01:48:47.989] Timer tick, asking Buildbucket for the build status
[01:48:48.339] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:48.339] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:44:0) after 1m0s
[01:49:48.373] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:44:0)
[01:49:48.373] Timer tick, asking Buildbucket for the build status
[01:49:48.592] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:48.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:45:0) after 1m0s
[01:50:48.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:45:0)
[01:50:48.660] Timer tick, asking Buildbucket for the build status
[01:50:48.798] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:48.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:46:0) after 1m0s
[01:51:48.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:46:0)
[01:51:48.950] Timer tick, asking Buildbucket for the build status
[01:51:49.061] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:49.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:47:0) after 1m0s
[01:52:49.188] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:47:0)
[01:52:49.188] Timer tick, asking Buildbucket for the build status
[01:52:49.353] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:49.353] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:48:0) after 1m0s
[01:53:49.461] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:48:0)
[01:53:49.462] Timer tick, asking Buildbucket for the build status
[01:53:49.567] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:49.567] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:49:0) after 1m0s
[01:54:49.622] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:49:0)
[01:54:49.622] Timer tick, asking Buildbucket for the build status
[01:54:49.817] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:49.817] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:50:0) after 1m0s
[01:55:49.874] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:50:0)
[01:55:49.874] Timer tick, asking Buildbucket for the build status
[01:55:50.364] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:50.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:51:0) after 1m0s
[01:56:50.538] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:51:0)
[01:56:50.538] Timer tick, asking Buildbucket for the build status
[01:56:50.665] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:50.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:52:0) after 1m0s
[01:57:50.648] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:52:0)
[01:57:50.648] Timer tick, asking Buildbucket for the build status
[01:57:50.916] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:50.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:53:0) after 1m0s
[01:58:50.973] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:53:0)
[01:58:50.973] Timer tick, asking Buildbucket for the build status
[01:58:51.076] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:51.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:54:0) after 1m0s
[01:59:51.108] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:54:0)
[01:59:51.108] Timer tick, asking Buildbucket for the build status
[01:59:51.347] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:51.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:55:0) after 1m0s
[02:00:51.415] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:55:0)
[02:00:51.415] Timer tick, asking Buildbucket for the build status
[02:00:51.547] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:51.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:56:0) after 1m0s
[02:01:51.603] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:56:0)
[02:01:51.603] Timer tick, asking Buildbucket for the build status
[02:01:51.753] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:51.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:57:0) after 1m0s
[02:02:51.860] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:57:0)
[02:02:51.860] Timer tick, asking Buildbucket for the build status
[02:02:52.209] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:52.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:58:0) after 1m0s
[02:03:52.272] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:58:0)
[02:03:52.272] Timer tick, asking Buildbucket for the build status
[02:03:52.412] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:52.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:59:0) after 1m0s
[02:04:52.440] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:59:0)
[02:04:52.440] Timer tick, asking Buildbucket for the build status
[02:04:52.569] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:52.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:60:0) after 1m0s
[02:05:52.624] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:60:0)
[02:05:52.624] Timer tick, asking Buildbucket for the build status
[02:05:52.797] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:52.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:61:0) after 1m0s
[02:06:52.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:61:0)
[02:06:52.878] Timer tick, asking Buildbucket for the build status
[02:06:53.039] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:53.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:62:0) after 1m0s
[02:07:53.065] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:62:0)
[02:07:53.065] Timer tick, asking Buildbucket for the build status
[02:07:53.240] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:53.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:63:0) after 1m0s
[02:08:53.264] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:63:0)
[02:08:53.264] Timer tick, asking Buildbucket for the build status
[02:08:53.553] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:53.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:64:0) after 1m0s
[02:09:53.572] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:64:0)
[02:09:53.572] Timer tick, asking Buildbucket for the build status
[02:09:53.871] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:53.871] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:65:0) after 1m0s
[02:10:53.957] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:65:0)
[02:10:53.957] Timer tick, asking Buildbucket for the build status
[02:10:54.127] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:54.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:66:0) after 1m0s
[02:11:54.238] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:66:0)
[02:11:54.238] Timer tick, asking Buildbucket for the build status
[02:11:54.342] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:54.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:67:0) after 1m0s
[02:12:54.425] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:67:0)
[02:12:54.425] Timer tick, asking Buildbucket for the build status
[02:12:54.836] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:54.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:68:0) after 1m0s
[02:13:54.924] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:68:0)
[02:13:54.924] Timer tick, asking Buildbucket for the build status
[02:13:55.121] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:55.121] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:69:0) after 1m0s
[02:14:55.156] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:69:0)
[02:14:55.156] Timer tick, asking Buildbucket for the build status
[02:14:55.661] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:55.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:70:0) after 1m0s
[02:15:55.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:70:0)
[02:15:55.721] Timer tick, asking Buildbucket for the build status
[02:15:55.911] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:55.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:71:0) after 1m0s
[02:16:55.934] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:71:0)
[02:16:55.934] Timer tick, asking Buildbucket for the build status
[02:16:56.457] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:56.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:72:0) after 1m0s
[02:17:56.529] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:72:0)
[02:17:56.530] Timer tick, asking Buildbucket for the build status
[02:17:56.892] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:56.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:73:0) after 1m0s
[02:18:56.920] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:73:0)
[02:18:56.920] Timer tick, asking Buildbucket for the build status
[02:18:57.103] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:57.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:74:0) after 1m0s
[02:19:57.140] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:74:0)
[02:19:57.140] Timer tick, asking Buildbucket for the build status
[02:19:57.310] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:57.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:75:0) after 1m0s
[02:20:57.401] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:75:0)
[02:20:57.401] Timer tick, asking Buildbucket for the build status
[02:20:57.520] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:57.520] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:76:0) after 1m0s
[02:21:57.595] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:76:0)
[02:21:57.595] Timer tick, asking Buildbucket for the build status
[02:21:57.754] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:57.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:77:0) after 1m0s
[02:22:57.852] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:77:0)
[02:22:57.852] Timer tick, asking Buildbucket for the build status
[02:22:58.530] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:58.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:78:0) after 1m0s
[02:23:58.651] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:78:0)
[02:23:58.651] Timer tick, asking Buildbucket for the build status
[02:23:58.804] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:58.804] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:79:0) after 1m0s
[02:24:58.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:79:0)
[02:24:58.871] Timer tick, asking Buildbucket for the build status
[02:24:58.988] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:58.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:80:0) after 1m0s
[02:25:59.028] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:80:0)
[02:25:59.028] Timer tick, asking Buildbucket for the build status
[02:25:59.194] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:59.194] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:81:0) after 1m0s
[02:26:59.272] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:81:0)
[02:26:59.272] Timer tick, asking Buildbucket for the build status
[02:26:59.601] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:59.601] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:82:0) after 1m0s
[02:27:59.657] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:82:0)
[02:27:59.657] Timer tick, asking Buildbucket for the build status
[02:27:59.813] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:59.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:83:0) after 1m0s
[02:28:59.807] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:83:0)
[02:28:59.807] Timer tick, asking Buildbucket for the build status
[02:29:00.129] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:00.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:84:0) after 1m0s
[02:30:00.151] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:84:0)
[02:30:00.151] Timer tick, asking Buildbucket for the build status
[02:30:00.324] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:00.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:85:0) after 1m0s
[02:31:00.346] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:85:0)
[02:31:00.346] Timer tick, asking Buildbucket for the build status
[02:31:00.658] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:00.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:86:0) after 1m0s
[02:32:00.694] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:86:0)
[02:32:00.694] Timer tick, asking Buildbucket for the build status
[02:32:00.961] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:00.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:87:0) after 1m0s
[02:33:01.024] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:87:0)
[02:33:01.024] Timer tick, asking Buildbucket for the build status
[02:33:01.203] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:01.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:88:0) after 1m0s
[02:34:01.222] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:88:0)
[02:34:01.222] Timer tick, asking Buildbucket for the build status
[02:34:01.385] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:01.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:89:0) after 1m0s
[02:35:01.446] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:89:0)
[02:35:01.446] Timer tick, asking Buildbucket for the build status
[02:35:02.109] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:02.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:90:0) after 1m0s
[02:36:02.250] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:90:0)
[02:36:02.250] Timer tick, asking Buildbucket for the build status
[02:36:02.410] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:02.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:91:0) after 1m0s
[02:37:02.428] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:91:0)
[02:37:02.428] Timer tick, asking Buildbucket for the build status
[02:37:02.708] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:02.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:92:0) after 1m0s
[02:38:02.772] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:92:0)
[02:38:02.772] Timer tick, asking Buildbucket for the build status
[02:38:03.559] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:03.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:93:0) after 1m0s
[02:39:03.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:93:0)
[02:39:03.597] Timer tick, asking Buildbucket for the build status
[02:39:04.095] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:04.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:94:0) after 1m0s
[02:40:04.116] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:94:0)
[02:40:04.116] Timer tick, asking Buildbucket for the build status
[02:40:04.911] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:04.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:95:0) after 1m0s
[02:41:04.915] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:95:0)
[02:41:04.915] Timer tick, asking Buildbucket for the build status
[02:41:05.106] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:05.106] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:96:0) after 1m0s
[02:42:05.197] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:96:0)
[02:42:05.197] Timer tick, asking Buildbucket for the build status
[02:42:05.647] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:05.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:97:0) after 1m0s
[02:43:05.690] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:97:0)
[02:43:05.690] Timer tick, asking Buildbucket for the build status
[02:43:05.882] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:05.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:98:0) after 1m0s
[02:44:05.875] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:98:0)
[02:44:05.875] Timer tick, asking Buildbucket for the build status
[02:44:06.082] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:06.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:99:0) after 1m0s
[02:45:06.126] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:99:0)
[02:45:06.126] Timer tick, asking Buildbucket for the build status
[02:45:06.399] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:06.399] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:100:0) after 1m0s
[02:46:06.432] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:100:0)
[02:46:06.432] Timer tick, asking Buildbucket for the build status
[02:46:06.987] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:06.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:101:0) after 1m0s
[02:47:07.067] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:101:0)
[02:47:07.067] Timer tick, asking Buildbucket for the build status
[02:47:07.218] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:07.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:102:0) after 1m0s
[02:48:07.282] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:102:0)
[02:48:07.282] Timer tick, asking Buildbucket for the build status
[02:48:07.812] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:07.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:103:0) after 1m0s
[02:49:07.869] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:103:0)
[02:49:07.869] Timer tick, asking Buildbucket for the build status
[02:49:07.987] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:07.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:104:0) after 1m0s
[02:50:08.060] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:104:0)
[02:50:08.060] Timer tick, asking Buildbucket for the build status
[02:50:08.339] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:08.339] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:105:0) after 1m0s
[02:51:08.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:105:0)
[02:51:08.398] Timer tick, asking Buildbucket for the build status
[02:51:08.559] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:08.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:106:0) after 1m0s
[02:52:08.640] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:106:0)
[02:52:08.640] Timer tick, asking Buildbucket for the build status
[02:52:08.811] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:08.811] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:107:0) after 1m0s
[02:53:08.862] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:107:0)
[02:53:08.862] Timer tick, asking Buildbucket for the build status
[02:53:08.977] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:08.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:108:0) after 1m0s
[02:54:09.007] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:108:0)
[02:54:09.007] Timer tick, asking Buildbucket for the build status
[02:54:09.266] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:09.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:109:0) after 1m0s
[02:55:09.305] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:109:0)
[02:55:09.305] Timer tick, asking Buildbucket for the build status
[02:55:09.822] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:09.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:110:0) after 1m0s
[02:56:09.857] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:110:0)
[02:56:09.857] Timer tick, asking Buildbucket for the build status
[02:56:10.042] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:10.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:111:0) after 1m0s
[02:57:10.082] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:111:0)
[02:57:10.082] Timer tick, asking Buildbucket for the build status
[02:57:10.238] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:10.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:112:0) after 1m0s
[02:58:10.256] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:112:0)
[02:58:10.256] Timer tick, asking Buildbucket for the build status
[02:58:10.859] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:10.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:113:0) after 1m0s
[02:59:10.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:113:0)
[02:59:10.878] Timer tick, asking Buildbucket for the build status
[02:59:11.202] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:11.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:114:0) after 1m0s
[03:00:11.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:114:0)
[03:00:11.233] Timer tick, asking Buildbucket for the build status
[03:00:11.446] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:11.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:115:0) after 1m0s
[03:01:11.508] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:115:0)
[03:01:11.508] Timer tick, asking Buildbucket for the build status
[03:01:11.716] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:11.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:116:0) after 1m0s
[03:02:11.834] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:116:0)
[03:02:11.834] Timer tick, asking Buildbucket for the build status
[03:02:11.961] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:11.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:117:0) after 1m0s
[03:03:12.022] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:117:0)
[03:03:12.022] Timer tick, asking Buildbucket for the build status
[03:03:12.121] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:12.121] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:118:0) after 1m0s
[03:04:12.301] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:118:0)
[03:04:12.301] Timer tick, asking Buildbucket for the build status
[03:04:12.434] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:12.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:119:0) after 1m0s
[03:05:12.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:119:0)
[03:05:12.577] Timer tick, asking Buildbucket for the build status
[03:05:12.798] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:12.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:120:0) after 1m0s
[03:06:12.884] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:120:0)
[03:06:12.884] Timer tick, asking Buildbucket for the build status
[03:06:13.249] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:13.249] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:121:0) after 1m0s
[03:07:13.294] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:121:0)
[03:07:13.294] Timer tick, asking Buildbucket for the build status
[03:07:13.454] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:13.454] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:122:0) after 1m0s
[03:08:13.508] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:122:0)
[03:08:13.508] Timer tick, asking Buildbucket for the build status
[03:08:13.791] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:13.791] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:123:0) after 1m0s
[03:09:13.841] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:123:0)
[03:09:13.841] Timer tick, asking Buildbucket for the build status
[03:09:14.071] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:14.071] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:124:0) after 1m0s
[03:10:14.107] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:124:0)
[03:10:14.107] Timer tick, asking Buildbucket for the build status
[03:10:14.452] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:10:14.452] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:125:0) after 1m0s
[03:11:14.547] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:125:0)
[03:11:14.547] Timer tick, asking Buildbucket for the build status
[03:11:14.650] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:14.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:126:0) after 1m0s
[03:12:14.661] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:126:0)
[03:12:14.661] Timer tick, asking Buildbucket for the build status
[03:12:14.810] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:14.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:127:0) after 1m0s
[03:13:14.887] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:127:0)
[03:13:14.887] Timer tick, asking Buildbucket for the build status
[03:13:15.047] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:15.047] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:128:0) after 1m0s
[03:14:15.065] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:128:0)
[03:14:15.065] Timer tick, asking Buildbucket for the build status
[03:14:15.352] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:15.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:129:0) after 1m0s
[03:15:15.443] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:129:0)
[03:15:15.443] Timer tick, asking Buildbucket for the build status
[03:15:15.762] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:15.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:130:0) after 1m0s
[03:16:15.849] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:130:0)
[03:16:15.849] Timer tick, asking Buildbucket for the build status
[03:16:16.059] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:16.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:131:0) after 1m0s
[03:17:16.152] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:131:0)
[03:17:16.152] Timer tick, asking Buildbucket for the build status
[03:17:16.496] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:16.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:132:0) after 1m0s
[03:18:16.559] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:132:0)
[03:18:16.559] Timer tick, asking Buildbucket for the build status
[03:18:16.658] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:16.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:133:0) after 1m0s
[03:19:16.734] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:133:0)
[03:19:16.734] Timer tick, asking Buildbucket for the build status
[03:19:17.323] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:17.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:134:0) after 1m0s
[03:20:17.349] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:134:0)
[03:20:17.349] Timer tick, asking Buildbucket for the build status
[03:20:17.870] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:17.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:135:0) after 1m0s
[03:21:17.920] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:135:0)
[03:21:17.920] Timer tick, asking Buildbucket for the build status
[03:21:18.337] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:18.337] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:136:0) after 1m0s
[03:22:18.379] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:136:0)
[03:22:18.379] Timer tick, asking Buildbucket for the build status
[03:22:18.847] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:18.847] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:137:0) after 1m0s
[03:23:18.884] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:137:0)
[03:23:18.884] Timer tick, asking Buildbucket for the build status
[03:23:19.169] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:23:19.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:138:0) after 1m0s
[03:24:19.199] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:138:0)
[03:24:19.199] Timer tick, asking Buildbucket for the build status
[03:24:19.420] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:24:19.420] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:139:0) after 1m0s
[03:25:19.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:139:0)
[03:25:19.473] Timer tick, asking Buildbucket for the build status
[03:25:19.733] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:19.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:140:0) after 1m0s
[03:26:19.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:140:0)
[03:26:19.843] Timer tick, asking Buildbucket for the build status
[03:26:19.984] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:19.984] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:141:0) after 1m0s
[03:27:20.021] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:141:0)
[03:27:20.021] Timer tick, asking Buildbucket for the build status
[03:27:20.174] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:27:20.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:142:0) after 1m0s
[03:28:20.269] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:142:0)
[03:28:20.269] Timer tick, asking Buildbucket for the build status
[03:28:20.447] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:28:20.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:143:0) after 1m0s
[03:29:20.506] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:143:0)
[03:29:20.506] Timer tick, asking Buildbucket for the build status
[03:29:20.633] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:20.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:144:0) after 1m0s
[03:30:20.688] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:144:0)
[03:30:20.689] Timer tick, asking Buildbucket for the build status
[03:30:20.986] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:20.986] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:145:0) after 1m0s
[03:31:20.988] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:145:0)
[03:31:20.988] Timer tick, asking Buildbucket for the build status
[03:31:21.188] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:21.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:146:0) after 1m0s
[03:32:21.246] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:146:0)
[03:32:21.246] Timer tick, asking Buildbucket for the build status
[03:32:21.470] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:21.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:147:0) after 1m0s
[03:33:21.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:147:0)
[03:33:21.496] Timer tick, asking Buildbucket for the build status
[03:33:21.642] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:33:21.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:148:0) after 1m0s
[03:34:21.701] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:148:0)
[03:34:21.701] Timer tick, asking Buildbucket for the build status
[03:34:21.830] Build 8884082213460597184: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:21.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:149:0) after 1m0s
[03:35:13.005] Received PubSub notification, asking Buildbucket for the build status
[03:35:13.109] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:21.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:149:0)
[03:35:21.871] Timer tick, asking Buildbucket for the build status
[03:35:21.996] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:21.996] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:151:0) after 1m0s
[03:36:22.024] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:151:0)
[03:36:22.024] Timer tick, asking Buildbucket for the build status
[03:36:22.292] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:22.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:152:0) after 1m0s
[03:37:22.332] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:152:0)
[03:37:22.332] Timer tick, asking Buildbucket for the build status
[03:37:22.465] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:22.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:153:0) after 1m0s
[03:38:22.531] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:153:0)
[03:38:22.531] Timer tick, asking Buildbucket for the build status
[03:38:22.839] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:22.839] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:154:0) after 1m0s
[03:39:22.898] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:154:0)
[03:39:22.898] Timer tick, asking Buildbucket for the build status
[03:39:23.072] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:23.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:155:0) after 1m0s
[03:40:23.078] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:155:0)
[03:40:23.078] Timer tick, asking Buildbucket for the build status
[03:40:23.385] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:23.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:156:0) after 1m0s
[03:41:23.452] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:156:0)
[03:41:23.452] Timer tick, asking Buildbucket for the build status
[03:41:23.813] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:23.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:157:0) after 1m0s
[03:42:23.827] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:157:0)
[03:42:23.827] Timer tick, asking Buildbucket for the build status
[03:42:23.940] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:23.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:158:0) after 1m0s
[03:43:23.987] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:158:0)
[03:43:23.987] Timer tick, asking Buildbucket for the build status
[03:43:24.127] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:24.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:159:0) after 1m0s
[03:44:24.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:159:0)
[03:44:24.177] Timer tick, asking Buildbucket for the build status
[03:44:24.301] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:24.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:160:0) after 1m0s
[03:45:24.364] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:160:0)
[03:45:24.364] Timer tick, asking Buildbucket for the build status
[03:45:24.521] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:24.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:161:0) after 1m0s
[03:46:24.558] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:161:0)
[03:46:24.558] Timer tick, asking Buildbucket for the build status
[03:46:24.706] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:24.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:162:0) after 1m0s
[03:47:24.737] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:162:0)
[03:47:24.738] Timer tick, asking Buildbucket for the build status
[03:47:24.903] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:24.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:163:0) after 1m0s
[03:48:24.941] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:163:0)
[03:48:24.941] Timer tick, asking Buildbucket for the build status
[03:48:25.075] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:25.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:164:0) after 1m0s
[03:49:25.098] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:164:0)
[03:49:25.098] Timer tick, asking Buildbucket for the build status
[03:49:25.299] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:25.299] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:165:0) after 1m0s
[03:50:25.355] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:165:0)
[03:50:25.355] Timer tick, asking Buildbucket for the build status
[03:50:25.524] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:25.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:166:0) after 1m0s
[03:51:25.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:166:0)
[03:51:25.556] Timer tick, asking Buildbucket for the build status
[03:51:25.666] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:25.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:167:0) after 1m0s
[03:52:25.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:167:0)
[03:52:25.735] Timer tick, asking Buildbucket for the build status
[03:52:25.882] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:25.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:168:0) after 1m0s
[03:53:25.889] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:168:0)
[03:53:25.889] Timer tick, asking Buildbucket for the build status
[03:53:26.115] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:26.115] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:169:0) after 1m0s
[03:54:26.239] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:169:0)
[03:54:26.239] Timer tick, asking Buildbucket for the build status
[03:54:26.389] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:26.389] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:170:0) after 1m0s
[03:55:26.452] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:170:0)
[03:55:26.452] Timer tick, asking Buildbucket for the build status
[03:55:26.623] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:26.623] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:171:0) after 1m0s
[03:56:26.707] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:171:0)
[03:56:26.707] Timer tick, asking Buildbucket for the build status
[03:56:26.878] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:26.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:172:0) after 1m0s
[03:57:26.940] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:172:0)
[03:57:26.940] Timer tick, asking Buildbucket for the build status
[03:57:27.714] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:27.714] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:173:0) after 1m0s
[03:58:27.892] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:173:0)
[03:58:27.892] Timer tick, asking Buildbucket for the build status
[03:58:28.061] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:28.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:174:0) after 1m0s
[03:59:28.277] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:174:0)
[03:59:28.277] Timer tick, asking Buildbucket for the build status
[03:59:28.405] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:28.405] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:175:0) after 1m0s
[04:00:28.594] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:175:0)
[04:00:28.594] Timer tick, asking Buildbucket for the build status
[04:00:29.310] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:29.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:176:0) after 1m0s
[04:01:29.372] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:176:0)
[04:01:29.372] Timer tick, asking Buildbucket for the build status
[04:01:29.689] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:29.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:177:0) after 1m0s
[04:02:29.719] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:177:0)
[04:02:29.719] Timer tick, asking Buildbucket for the build status
[04:02:29.818] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:29.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:178:0) after 1m0s
[04:03:29.961] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:178:0)
[04:03:29.961] Timer tick, asking Buildbucket for the build status
[04:03:30.525] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:30.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:179:0) after 1m0s
[04:04:30.522] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:179:0)
[04:04:30.522] Timer tick, asking Buildbucket for the build status
[04:04:30.777] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:30.777] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:180:0) after 1m0s
[04:05:30.804] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:180:0)
[04:05:30.804] Timer tick, asking Buildbucket for the build status
[04:05:31.112] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:31.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:181:0) after 1m0s
[04:06:31.339] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:181:0)
[04:06:31.339] Timer tick, asking Buildbucket for the build status
[04:06:31.470] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:31.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:182:0) after 1m0s
[04:07:31.514] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:182:0)
[04:07:31.514] Timer tick, asking Buildbucket for the build status
[04:07:31.874] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:31.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:183:0) after 1m0s
[04:08:31.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:183:0)
[04:08:31.900] Timer tick, asking Buildbucket for the build status
[04:08:32.291] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:32.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:184:0) after 1m0s
[04:09:32.340] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:184:0)
[04:09:32.340] Timer tick, asking Buildbucket for the build status
[04:09:32.493] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:32.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:185:0) after 1m0s
[04:10:32.485] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:185:0)
[04:10:32.486] Timer tick, asking Buildbucket for the build status
[04:10:32.706] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:32.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:186:0) after 1m0s
[04:11:32.780] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:186:0)
[04:11:32.780] Timer tick, asking Buildbucket for the build status
[04:11:32.992] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:32.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:187:0) after 1m0s
[04:12:33.039] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:187:0)
[04:12:33.039] Timer tick, asking Buildbucket for the build status
[04:12:33.628] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:33.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:188:0) after 1m0s
[04:13:33.695] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:188:0)
[04:13:33.695] Timer tick, asking Buildbucket for the build status
[04:13:33.832] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:33.832] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:189:0) after 1m0s
[04:14:33.939] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:189:0)
[04:14:33.939] Timer tick, asking Buildbucket for the build status
[04:14:34.094] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:34.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:190:0) after 1m0s
[04:15:34.131] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:190:0)
[04:15:34.131] Timer tick, asking Buildbucket for the build status
[04:15:34.367] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:34.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:191:0) after 1m0s
[04:16:34.467] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:191:0)
[04:16:34.467] Timer tick, asking Buildbucket for the build status
[04:16:34.868] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:34.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:192:0) after 1m0s
[04:17:34.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:192:0)
[04:17:34.900] Timer tick, asking Buildbucket for the build status
[04:17:35.386] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:35.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:193:0) after 1m0s
[04:18:35.431] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:193:0)
[04:18:35.431] Timer tick, asking Buildbucket for the build status
[04:18:35.846] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:35.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:194:0) after 1m0s
[04:19:35.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:194:0)
[04:19:35.878] Timer tick, asking Buildbucket for the build status
[04:19:36.301] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:36.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:195:0) after 1m0s
[04:20:36.373] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:195:0)
[04:20:36.373] Timer tick, asking Buildbucket for the build status
[04:20:36.564] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:36.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:196:0) after 1m0s
[04:21:36.595] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:196:0)
[04:21:36.595] Timer tick, asking Buildbucket for the build status
[04:21:36.819] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:36.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:197:0) after 1m0s
[04:22:36.870] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:197:0)
[04:22:36.870] Timer tick, asking Buildbucket for the build status
[04:22:37.038] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:37.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:198:0) after 1m0s
[04:23:37.095] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:198:0)
[04:23:37.095] Timer tick, asking Buildbucket for the build status
[04:23:37.274] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:37.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:199:0) after 1m0s
[04:24:37.305] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:199:0)
[04:24:37.305] Timer tick, asking Buildbucket for the build status
[04:24:37.779] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:37.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:200:0) after 1m0s
[04:25:37.806] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:200:0)
[04:25:37.806] Timer tick, asking Buildbucket for the build status
[04:25:37.930] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:37.930] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:201:0) after 1m0s
[04:26:37.991] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:201:0)
[04:26:37.991] Timer tick, asking Buildbucket for the build status
[04:26:38.160] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:38.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:202:0) after 1m0s
[04:27:38.197] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:202:0)
[04:27:38.197] Timer tick, asking Buildbucket for the build status
[04:27:39.098] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:39.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:203:0) after 1m0s
[04:28:39.129] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:203:0)
[04:28:39.129] Timer tick, asking Buildbucket for the build status
[04:28:40.915] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:40.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:204:0) after 1m0s
[04:29:41.047] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:204:0)
[04:29:41.047] Timer tick, asking Buildbucket for the build status
[04:29:42.965] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:42.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:205:0) after 1m0s
[04:30:43.068] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:205:0)
[04:30:43.068] Timer tick, asking Buildbucket for the build status
[04:30:43.248] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:43.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:206:0) after 1m0s
[04:31:43.285] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:206:0)
[04:31:43.285] Timer tick, asking Buildbucket for the build status
[04:31:43.468] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:43.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:207:0) after 1m0s
[04:32:43.509] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:207:0)
[04:32:43.509] Timer tick, asking Buildbucket for the build status
[04:32:43.681] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:43.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:208:0) after 1m0s
[04:33:43.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:208:0)
[04:33:43.735] Timer tick, asking Buildbucket for the build status
[04:33:44.404] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:44.404] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:209:0) after 1m0s
[04:34:44.436] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:209:0)
[04:34:44.436] Timer tick, asking Buildbucket for the build status
[04:34:44.923] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:44.923] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:210:0) after 1m0s
[04:35:44.986] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:210:0)
[04:35:44.986] Timer tick, asking Buildbucket for the build status
[04:35:45.146] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:45.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:211:0) after 1m0s
[04:36:45.188] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:211:0)
[04:36:45.188] Timer tick, asking Buildbucket for the build status
[04:36:45.589] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:45.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:212:0) after 1m0s
[04:37:45.672] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:212:0)
[04:37:45.672] Timer tick, asking Buildbucket for the build status
[04:37:45.785] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:45.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:213:0) after 1m0s
[04:38:45.860] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:213:0)
[04:38:45.860] Timer tick, asking Buildbucket for the build status
[04:38:46.154] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:46.154] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:214:0) after 1m0s
[04:39:46.209] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:214:0)
[04:39:46.209] Timer tick, asking Buildbucket for the build status
[04:39:46.390] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:46.390] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:215:0) after 1m0s
[04:40:46.450] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:215:0)
[04:40:46.450] Timer tick, asking Buildbucket for the build status
[04:40:46.604] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:46.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:216:0) after 1m0s
[04:41:46.644] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:216:0)
[04:41:46.644] Timer tick, asking Buildbucket for the build status
[04:41:46.747] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:46.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:217:0) after 1m0s
[04:42:46.793] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:217:0)
[04:42:46.793] Timer tick, asking Buildbucket for the build status
[04:42:46.961] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:46.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:218:0) after 1m0s
[04:43:46.998] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:218:0)
[04:43:46.998] Timer tick, asking Buildbucket for the build status
[04:43:47.207] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:47.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:219:0) after 1m0s
[04:44:47.221] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:219:0)
[04:44:47.221] Timer tick, asking Buildbucket for the build status
[04:44:47.432] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:47.432] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:220:0) after 1m0s
[04:45:47.433] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:220:0)
[04:45:47.433] Timer tick, asking Buildbucket for the build status
[04:45:47.743] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:47.743] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:221:0) after 1m0s
[04:46:47.783] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:221:0)
[04:46:47.783] Timer tick, asking Buildbucket for the build status
[04:46:48.400] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:48.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:222:0) after 1m0s
[04:47:48.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:222:0)
[04:47:48.459] Timer tick, asking Buildbucket for the build status
[04:47:48.937] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:48.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:223:0) after 1m0s
[04:48:48.984] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:223:0)
[04:48:48.984] Timer tick, asking Buildbucket for the build status
[04:48:49.126] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:49.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:224:0) after 1m0s
[04:49:49.189] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:224:0)
[04:49:49.189] Timer tick, asking Buildbucket for the build status
[04:49:50.354] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:50.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:225:0) after 1m0s
[04:50:50.466] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:225:0)
[04:50:50.466] Timer tick, asking Buildbucket for the build status
[04:50:51.169] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:51.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:226:0) after 1m0s
[04:51:51.315] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:226:0)
[04:51:51.315] Timer tick, asking Buildbucket for the build status
[04:51:51.511] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:51.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:227:0) after 1m0s
[04:52:51.627] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:227:0)
[04:52:51.627] Timer tick, asking Buildbucket for the build status
[04:52:52.067] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:52.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:228:0) after 1m0s
[04:53:52.118] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:228:0)
[04:53:52.118] Timer tick, asking Buildbucket for the build status
[04:53:52.273] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:52.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:229:0) after 1m0s
[04:54:52.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:229:0)
[04:54:52.325] Timer tick, asking Buildbucket for the build status
[04:54:52.547] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:52.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:230:0) after 1m0s
[04:55:52.565] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:230:0)
[04:55:52.566] Timer tick, asking Buildbucket for the build status
[04:55:52.774] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:52.774] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:231:0) after 1m0s
[04:56:52.902] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:231:0)
[04:56:52.902] Timer tick, asking Buildbucket for the build status
[04:56:53.122] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:53.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:232:0) after 1m0s
[04:57:53.268] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:232:0)
[04:57:53.268] Timer tick, asking Buildbucket for the build status
[04:57:53.761] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:53.761] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:233:0) after 1m0s
[04:58:53.877] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:233:0)
[04:58:53.877] Timer tick, asking Buildbucket for the build status
[04:58:54.125] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:54.125] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:234:0) after 1m0s
[04:59:54.132] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:234:0)
[04:59:54.132] Timer tick, asking Buildbucket for the build status
[04:59:54.310] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:54.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:235:0) after 1m0s
[05:00:54.380] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:235:0)
[05:00:54.380] Timer tick, asking Buildbucket for the build status
[05:00:54.569] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:54.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:236:0) after 1m0s
[05:01:54.593] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:236:0)
[05:01:54.593] Timer tick, asking Buildbucket for the build status
[05:01:54.840] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:54.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:237:0) after 1m0s
[05:02:54.870] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:237:0)
[05:02:54.870] Timer tick, asking Buildbucket for the build status
[05:02:55.019] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:55.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:238:0) after 1m0s
[05:03:55.056] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:238:0)
[05:03:55.056] Timer tick, asking Buildbucket for the build status
[05:03:56.004] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:56.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:239:0) after 1m0s
[05:04:56.065] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:239:0)
[05:04:56.065] Timer tick, asking Buildbucket for the build status
[05:04:56.261] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:56.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:240:0) after 1m0s
[05:05:56.361] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:240:0)
[05:05:56.361] Timer tick, asking Buildbucket for the build status
[05:05:56.478] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:56.478] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:241:0) after 1m0s
[05:06:56.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:241:0)
[05:06:56.535] Timer tick, asking Buildbucket for the build status
[05:06:56.744] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:56.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:242:0) after 1m0s
[05:07:56.862] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:242:0)
[05:07:56.862] Timer tick, asking Buildbucket for the build status
[05:07:57.023] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:57.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:243:0) after 1m0s
[05:08:57.064] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:243:0)
[05:08:57.064] Timer tick, asking Buildbucket for the build status
[05:08:57.215] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:57.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:244:0) after 1m0s
[05:09:57.251] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:244:0)
[05:09:57.251] Timer tick, asking Buildbucket for the build status
[05:09:57.476] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:57.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:245:0) after 1m0s
[05:10:57.532] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:245:0)
[05:10:57.532] Timer tick, asking Buildbucket for the build status
[05:10:57.868] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:57.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:246:0) after 1m0s
[05:11:57.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:246:0)
[05:11:57.899] Timer tick, asking Buildbucket for the build status
[05:11:58.277] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:58.277] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:247:0) after 1m0s
[05:12:58.305] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:247:0)
[05:12:58.305] Timer tick, asking Buildbucket for the build status
[05:12:58.596] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:58.596] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:248:0) after 1m0s
[05:13:58.729] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:248:0)
[05:13:58.729] Timer tick, asking Buildbucket for the build status
[05:13:58.856] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:58.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:249:0) after 1m0s
[05:14:59.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:249:0)
[05:14:59.018] Timer tick, asking Buildbucket for the build status
[05:14:59.167] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:59.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:250:0) after 1m0s
[05:15:59.266] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:250:0)
[05:15:59.266] Timer tick, asking Buildbucket for the build status
[05:15:59.568] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:59.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:251:0) after 1m0s
[05:16:59.592] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:251:0)
[05:16:59.592] Timer tick, asking Buildbucket for the build status
[05:16:59.932] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:59.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:252:0) after 1m0s
[05:18:00.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:252:0)
[05:18:00.035] Timer tick, asking Buildbucket for the build status
[05:18:00.440] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:00.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:253:0) after 1m0s
[05:19:00.484] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:253:0)
[05:19:00.484] Timer tick, asking Buildbucket for the build status
[05:19:00.595] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:00.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:254:0) after 1m0s
[05:20:00.688] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:254:0)
[05:20:00.688] Timer tick, asking Buildbucket for the build status
[05:20:01.046] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:01.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:255:0) after 1m0s
[05:21:01.152] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:255:0)
[05:21:01.152] Timer tick, asking Buildbucket for the build status
[05:21:01.359] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:01.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:256:0) after 1m0s
[05:22:01.428] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:256:0)
[05:22:01.428] Timer tick, asking Buildbucket for the build status
[05:22:01.671] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:01.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:257:0) after 1m0s
[05:23:01.702] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:257:0)
[05:23:01.702] Timer tick, asking Buildbucket for the build status
[05:23:02.441] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:02.441] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:258:0) after 1m0s
[05:24:02.520] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:258:0)
[05:24:02.520] Timer tick, asking Buildbucket for the build status
[05:24:02.772] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:02.772] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:259:0) after 1m0s
[05:25:02.846] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:259:0)
[05:25:02.846] Timer tick, asking Buildbucket for the build status
[05:25:03.348] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:03.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:260:0) after 1m0s
[05:26:03.387] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:260:0)
[05:26:03.387] Timer tick, asking Buildbucket for the build status
[05:26:03.647] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:03.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:261:0) after 1m0s
[05:27:03.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:261:0)
[05:27:03.721] Timer tick, asking Buildbucket for the build status
[05:27:04.083] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:04.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:262:0) after 1m0s
[05:28:04.146] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:262:0)
[05:28:04.146] Timer tick, asking Buildbucket for the build status
[05:28:04.630] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:04.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:263:0) after 1m0s
[05:29:04.703] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:263:0)
[05:29:04.703] Timer tick, asking Buildbucket for the build status
[05:29:05.288] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:05.288] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:264:0) after 1m0s
[05:30:05.299] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:264:0)
[05:30:05.299] Timer tick, asking Buildbucket for the build status
[05:30:05.455] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:05.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:265:0) after 1m0s
[05:31:05.521] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:265:0)
[05:31:05.521] Timer tick, asking Buildbucket for the build status
[05:31:06.546] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:06.546] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:266:0) after 1m0s
[05:32:06.614] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:266:0)
[05:32:06.614] Timer tick, asking Buildbucket for the build status
[05:32:06.983] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:06.983] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:267:0) after 1m0s
[05:33:07.075] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:267:0)
[05:33:07.075] Timer tick, asking Buildbucket for the build status
[05:33:07.218] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:07.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:268:0) after 1m0s
[05:34:07.254] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:268:0)
[05:34:07.254] Timer tick, asking Buildbucket for the build status
[05:34:07.393] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:07.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:269:0) after 1m0s
[05:35:07.399] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:269:0)
[05:35:07.399] Timer tick, asking Buildbucket for the build status
[05:35:07.608] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:07.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:270:0) after 1m0s
[05:36:07.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:270:0)
[05:36:07.671] Timer tick, asking Buildbucket for the build status
[05:36:07.856] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:07.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:271:0) after 1m0s
[05:37:07.937] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:271:0)
[05:37:07.937] Timer tick, asking Buildbucket for the build status
[05:37:08.102] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:08.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:272:0) after 1m0s
[05:38:08.154] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:272:0)
[05:38:08.154] Timer tick, asking Buildbucket for the build status
[05:38:08.360] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:08.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:273:0) after 1m0s
[05:39:08.519] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:273:0)
[05:39:08.519] Timer tick, asking Buildbucket for the build status
[05:39:08.681] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:08.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:274:0) after 1m0s
[05:40:08.781] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:274:0)
[05:40:08.781] Timer tick, asking Buildbucket for the build status
[05:40:08.915] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:08.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:275:0) after 1m0s
[05:41:09.089] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:275:0)
[05:41:09.089] Timer tick, asking Buildbucket for the build status
[05:41:09.323] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:09.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:276:0) after 1m0s
[05:42:09.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:276:0)
[05:42:09.962] Timer tick, asking Buildbucket for the build status
[05:42:10.127] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:10.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:277:0) after 1m0s
[05:43:10.465] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:277:0)
[05:43:10.465] Timer tick, asking Buildbucket for the build status
[05:43:10.609] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:10.609] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:278:0) after 1m0s
[05:44:10.909] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:278:0)
[05:44:10.909] Timer tick, asking Buildbucket for the build status
[05:44:11.063] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:11.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:279:0) after 1m0s
[05:45:11.163] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:279:0)
[05:45:11.163] Timer tick, asking Buildbucket for the build status
[05:45:11.651] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:11.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:280:0) after 1m0s
[05:46:11.797] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:280:0)
[05:46:11.797] Timer tick, asking Buildbucket for the build status
[05:46:12.237] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:12.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:281:0) after 1m0s
[05:47:12.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:281:0)
[05:47:12.671] Timer tick, asking Buildbucket for the build status
[05:47:12.880] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:12.880] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:282:0) after 1m0s
[05:48:12.991] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:282:0)
[05:48:12.991] Timer tick, asking Buildbucket for the build status
[05:48:13.106] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:13.106] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:283:0) after 1m0s
[05:49:13.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:283:0)
[05:49:13.185] Timer tick, asking Buildbucket for the build status
[05:49:13.525] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:13.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:284:0) after 1m0s
[05:50:13.670] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:284:0)
[05:50:13.670] Timer tick, asking Buildbucket for the build status
[05:50:14.043] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:14.043] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:285:0) after 1m0s
[05:51:14.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:285:0)
[05:51:14.185] Timer tick, asking Buildbucket for the build status
[05:51:14.380] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:14.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:286:0) after 1m0s
[05:52:14.420] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:286:0)
[05:52:14.420] Timer tick, asking Buildbucket for the build status
[05:52:15.900] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:15.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:287:0) after 1m0s
[05:53:16.014] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:287:0)
[05:53:16.014] Timer tick, asking Buildbucket for the build status
[05:53:16.203] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:16.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:288:0) after 1m0s
[05:54:16.279] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:288:0)
[05:54:16.279] Timer tick, asking Buildbucket for the build status
[05:54:16.512] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:16.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:289:0) after 1m0s
[05:55:16.653] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:289:0)
[05:55:16.653] Timer tick, asking Buildbucket for the build status
[05:55:16.865] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:16.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:290:0) after 1m0s
[05:56:16.992] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:290:0)
[05:56:16.992] Timer tick, asking Buildbucket for the build status
[05:56:17.071] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:17.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:291:0) after 1m0s
[05:57:17.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:291:0)
[05:57:17.127] Timer tick, asking Buildbucket for the build status
[05:57:17.769] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:17.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:292:0) after 1m0s
[05:58:17.989] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:292:0)
[05:58:17.989] Timer tick, asking Buildbucket for the build status
[05:58:18.106] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:18.106] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:293:0) after 1m0s
[05:59:18.219] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:293:0)
[05:59:18.219] Timer tick, asking Buildbucket for the build status
[05:59:18.351] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:18.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:294:0) after 1m0s
[06:00:18.399] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:294:0)
[06:00:18.399] Timer tick, asking Buildbucket for the build status
[06:00:18.554] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:18.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:295:0) after 1m0s
[06:01:18.604] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:295:0)
[06:01:18.604] Timer tick, asking Buildbucket for the build status
[06:01:20.586] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:20.586] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:296:0) after 1m0s
[06:02:20.659] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:296:0)
[06:02:20.659] Timer tick, asking Buildbucket for the build status
[06:02:20.934] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:20.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:297:0) after 1m0s
[06:03:21.095] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:297:0)
[06:03:21.095] Timer tick, asking Buildbucket for the build status
[06:03:21.295] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:21.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:298:0) after 1m0s
[06:04:21.336] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:298:0)
[06:04:21.336] Timer tick, asking Buildbucket for the build status
[06:04:21.490] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:21.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:299:0) after 1m0s
[06:05:21.623] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:299:0)
[06:05:21.623] Timer tick, asking Buildbucket for the build status
[06:05:21.776] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:21.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:300:0) after 1m0s
[06:06:22.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:300:0)
[06:06:22.202] Timer tick, asking Buildbucket for the build status
[06:06:22.572] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:22.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:301:0) after 1m0s
[06:07:22.692] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:301:0)
[06:07:22.692] Timer tick, asking Buildbucket for the build status
[06:07:22.913] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:22.913] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:302:0) after 1m0s
[06:08:23.425] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:302:0)
[06:08:23.425] Timer tick, asking Buildbucket for the build status
[06:08:23.966] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:23.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:303:0) after 1m0s
[06:09:24.298] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:303:0)
[06:09:24.298] Timer tick, asking Buildbucket for the build status
[06:09:24.462] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:24.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:304:0) after 1m0s
[06:10:24.520] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:304:0)
[06:10:24.520] Timer tick, asking Buildbucket for the build status
[06:10:24.662] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:24.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:305:0) after 1m0s
[06:11:24.914] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:305:0)
[06:11:24.914] Timer tick, asking Buildbucket for the build status
[06:11:25.133] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:25.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:306:0) after 1m0s
[06:12:25.189] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:306:0)
[06:12:25.189] Timer tick, asking Buildbucket for the build status
[06:12:25.548] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:25.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:307:0) after 1m0s
[06:13:25.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:307:0)
[06:13:25.660] Timer tick, asking Buildbucket for the build status
[06:13:25.927] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:25.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:308:0) after 1m0s
[06:14:26.062] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:308:0)
[06:14:26.062] Timer tick, asking Buildbucket for the build status
[06:14:26.228] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:26.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:309:0) after 1m0s
[06:15:26.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:309:0)
[06:15:26.414] Timer tick, asking Buildbucket for the build status
[06:15:26.864] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:26.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:310:0) after 1m0s
[06:16:26.952] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:310:0)
[06:16:26.952] Timer tick, asking Buildbucket for the build status
[06:16:27.067] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:27.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:311:0) after 1m0s
[06:17:27.188] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:311:0)
[06:17:27.188] Timer tick, asking Buildbucket for the build status
[06:17:27.340] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:27.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:312:0) after 1m0s
[06:18:27.446] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:312:0)
[06:18:27.446] Timer tick, asking Buildbucket for the build status
[06:18:27.675] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:27.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:313:0) after 1m0s
[06:19:27.849] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:313:0)
[06:19:27.849] Timer tick, asking Buildbucket for the build status
[06:19:28.064] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:28.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:314:0) after 1m0s
[06:20:28.200] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:314:0)
[06:20:28.200] Timer tick, asking Buildbucket for the build status
[06:20:28.338] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:28.338] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:315:0) after 1m0s
[06:21:28.506] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:315:0)
[06:21:28.506] Timer tick, asking Buildbucket for the build status
[06:21:29.366] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:29.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:316:0) after 1m0s
[06:22:29.604] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:316:0)
[06:22:29.604] Timer tick, asking Buildbucket for the build status
[06:22:29.720] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:29.720] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:317:0) after 1m0s
[06:23:29.918] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:317:0)
[06:23:29.918] Timer tick, asking Buildbucket for the build status
[06:23:30.336] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:30.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:318:0) after 1m0s
[06:24:30.466] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:318:0)
[06:24:30.466] Timer tick, asking Buildbucket for the build status
[06:24:31.353] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:31.353] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:319:0) after 1m0s
[06:25:31.440] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:319:0)
[06:25:31.440] Timer tick, asking Buildbucket for the build status
[06:25:31.566] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:31.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:320:0) after 1m0s
[06:26:31.573] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:320:0)
[06:26:31.573] Timer tick, asking Buildbucket for the build status
[06:26:31.750] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:31.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:321:0) after 1m0s
[06:27:31.782] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:321:0)
[06:27:31.782] Timer tick, asking Buildbucket for the build status
[06:27:32.056] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:32.056] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:322:0) after 1m0s
[06:28:32.157] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:322:0)
[06:28:32.157] Timer tick, asking Buildbucket for the build status
[06:28:32.695] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:32.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:323:0) after 1m0s
[06:29:32.799] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:323:0)
[06:29:32.799] Timer tick, asking Buildbucket for the build status
[06:29:33.085] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:33.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:324:0) after 1m0s
[06:30:33.188] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:324:0)
[06:30:33.188] Timer tick, asking Buildbucket for the build status
[06:30:33.541] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:33.541] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:325:0) after 1m0s
[06:31:33.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:325:0)
[06:31:33.740] Timer tick, asking Buildbucket for the build status
[06:31:33.941] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:33.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:326:0) after 1m0s
[06:32:34.064] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:326:0)
[06:32:34.064] Timer tick, asking Buildbucket for the build status
[06:32:34.237] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:34.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:327:0) after 1m0s
[06:33:34.309] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:327:0)
[06:33:34.309] Timer tick, asking Buildbucket for the build status
[06:33:34.525] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:34.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:328:0) after 1m0s
[06:34:34.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:328:0)
[06:34:34.556] Timer tick, asking Buildbucket for the build status
[06:34:35.124] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:35.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:329:0) after 1m0s
[06:35:35.170] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:329:0)
[06:35:35.170] Timer tick, asking Buildbucket for the build status
[06:35:35.338] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:35.338] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:330:0) after 1m0s
[06:36:35.345] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:330:0)
[06:36:35.345] Timer tick, asking Buildbucket for the build status
[06:36:35.494] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:35.494] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:331:0) after 1m0s
[06:37:35.548] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:331:0)
[06:37:35.548] Timer tick, asking Buildbucket for the build status
[06:37:35.736] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:35.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:332:0) after 1m0s
[06:38:35.777] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:332:0)
[06:38:35.777] Timer tick, asking Buildbucket for the build status
[06:38:35.999] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:35.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:333:0) after 1m0s
[06:39:36.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:333:0)
[06:39:36.072] Timer tick, asking Buildbucket for the build status
[06:39:37.022] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:37.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:334:0) after 1m0s
[06:40:37.166] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:334:0)
[06:40:37.166] Timer tick, asking Buildbucket for the build status
[06:40:37.347] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:37.347] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:335:0) after 1m0s
[06:41:37.439] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:335:0)
[06:41:37.439] Timer tick, asking Buildbucket for the build status
[06:41:37.642] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:37.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:336:0) after 1m0s
[06:42:37.664] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:336:0)
[06:42:37.665] Timer tick, asking Buildbucket for the build status
[06:42:38.253] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:38.253] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:337:0) after 1m0s
[06:43:38.245] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:337:0)
[06:43:38.245] Timer tick, asking Buildbucket for the build status
[06:43:38.371] Build 8884082213460597184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:38.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:338:0) after 1m0s
[06:44:38.440] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_64:9049512279903783456:338:0)
[06:44:38.440] Timer tick, asking Buildbucket for the build status
[06:44:39.403] Build 8884082213460597184: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:44:39.403] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "completed_ts": "1585896279042717",
    "created_by": "project:nacl",
    "created_ts": "1585875990389550",
    "failure_reason": "BUILD_FAILURE",
    "id": "8884082213460597184",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f27b39dd0540f360e7d1277b63650b64ed4e09db\", \"title\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/f27b39dd0540f360e7d1277b63650b64ed4e09db\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"Step('annotated steps') (retcode: 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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f27b39dd0540f360e7d1277b63650b64ed4e09db\", \"title\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/f27b39dd0540f360e7d1277b63650b64ed4e09db\"}]}, \"bot_id\": \"luci-nacl-toolchain-xenial-1-huq9\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-pnacl-x86_64-tests-x86_64\", \"buildnumber\": 5098, \"got_revision\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\", \"mastername\": \"client.nacl.toolchain\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f27b39dd0540f360e7d1277b63650b64ed4e09db\", \"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\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-nacl-toolchain-xenial-1-huq9\"], \"image\": [\"chrome-xenial-20032900-6802ab9ce34\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.nacl.toolchain\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4926-84b94b1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}, \"ui\": {\"info\": \"Step('annotated steps') (retcode: 1)\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1585884911791496",
    "status": "COMPLETED",
    "status_changed_ts": "1585884912269582",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_64/5098",
      "builder:linux-pnacl-x86_64-tests-x86_64",
      "buildset:commit/git/f27b39dd0540f360e7d1277b63650b64ed4e09db",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f27b39dd0540f360e7d1277b63650b64ed4e09db",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9049512279903783456",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_64",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8884082213460597184/+/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:4b5664c7fee73410",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1585896279135307",
    "url": "https://ci.chromium.org/b/8884082213460597184",
    "utcnow_ts": "1585896279385701"
  }
}
[06:44:39.403] Invocation finished in 5h38m14.543122133s with status FAILED