buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.nacl.ci"
  builder: "linux-64-validator-opt"
>

• fd20fafa8ec19700e12daa031bf792bae8b6bb21 (4 years ago)

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

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

[11:35:42.340] New invocation is queued and will start shortly
[11:35:43.596] Starting the invocation (attempt 1)
[11:35:43.646] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:35:43.646] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:35:43.647] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9042134334063165936",
  "parameters_json": "{\"builder_name\":\"linux-64-validator-opt\",\"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\":\"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@fd20fafa8ec19700e12daa031bf792bae8b6bb21\",\"title\":\"fd20fafa8ec19700e12daa031bf792bae8b6bb21\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-64-validator-opt",
    "scheduler_invocation_id:9042134334063165936",
    "scheduler_job_id:nacl/linux-64-validator-opt",
    "user_agent:luci-scheduler",
    "buildset:commit/git/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
    "gitiles_ref:refs/heads/master"
  ]
}
[11:35:44.688] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1592912143751984",
    "id": "8876704271912072272",
    "parameters_json": "{\"builder_name\": \"linux-64-validator-opt\", \"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\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"title\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1592912144403770",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/146",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9042134334063165936",
      "scheduler_job_id:nacl/linux-64-validator-opt",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8876704271912072272/+/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": "1592912144403967",
    "url": "https://ci.chromium.org/b/8876704271912072272",
    "utcnow_ts": "1592912144664031"
  }
}
[11:35:44.688] Task URL: https://ci.chromium.org/b/8876704271912072272
[11:35:44.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:2:0) after 1m0s
[11:36:44.689] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:2:0)
[11:36:44.689] Timer tick, asking Buildbucket for the build status
[11:36:45.137] Build 8876704271912072272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:36:45.137] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:3:0) after 1m0s
[11:37:45.159] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:3:0)
[11:37:45.159] Timer tick, asking Buildbucket for the build status
[11:37:45.255] Build 8876704271912072272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:37:45.255] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:4:0) after 1m0s
[11:38:45.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:4:0)
[11:38:45.272] Timer tick, asking Buildbucket for the build status
[11:38:48.940] Build 8876704271912072272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:38:48.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:5:0) after 1m0s
[11:39:33.933] Received PubSub notification, asking Buildbucket for the build status
[11:39:34.261] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:48.953] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:5:0)
[11:39:48.953] Timer tick, asking Buildbucket for the build status
[11:39:49.128] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:49.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:7:0) after 1m0s
[11:40:49.148] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:7:0)
[11:40:49.148] Timer tick, asking Buildbucket for the build status
[11:40:49.289] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:49.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:8:0) after 1m0s
[11:41:49.341] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:8:0)
[11:41:49.341] Timer tick, asking Buildbucket for the build status
[11:41:49.486] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:49.486] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:9:0) after 1m0s
[11:42:49.509] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:9:0)
[11:42:49.509] Timer tick, asking Buildbucket for the build status
[11:42:49.718] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:49.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:10:0) after 1m0s
[11:43:49.736] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:10:0)
[11:43:49.736] Timer tick, asking Buildbucket for the build status
[11:43:50.364] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:50.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:11:0) after 1m0s
[11:44:50.392] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:11:0)
[11:44:50.392] Timer tick, asking Buildbucket for the build status
[11:44:50.568] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:50.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:12:0) after 1m0s
[11:45:50.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:12:0)
[11:45:50.544] Timer tick, asking Buildbucket for the build status
[11:45:50.695] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:50.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:13:0) after 1m0s
[11:46:50.721] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:13:0)
[11:46:50.721] Timer tick, asking Buildbucket for the build status
[11:46:51.224] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:51.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:14:0) after 1m0s
[11:47:51.213] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:14:0)
[11:47:51.213] Timer tick, asking Buildbucket for the build status
[11:47:51.757] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:51.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:15:0) after 1m0s
[11:48:51.780] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:15:0)
[11:48:51.780] Timer tick, asking Buildbucket for the build status
[11:48:52.990] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:52.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:16:0) after 1m0s
[11:49:53.003] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:16:0)
[11:49:53.003] Timer tick, asking Buildbucket for the build status
[11:49:54.426] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:54.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:17:0) after 1m0s
[11:50:54.423] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:17:0)
[11:50:54.423] Timer tick, asking Buildbucket for the build status
[11:50:54.593] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:54.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:18:0) after 1m0s
[11:51:54.629] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:18:0)
[11:51:54.629] Timer tick, asking Buildbucket for the build status
[11:51:54.779] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:54.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:19:0) after 1m0s
[11:52:54.814] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:19:0)
[11:52:54.814] Timer tick, asking Buildbucket for the build status
[11:52:55.124] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:55.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:20:0) after 1m0s
[11:53:55.117] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:20:0)
[11:53:55.117] Timer tick, asking Buildbucket for the build status
[11:54:01.874] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:01.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:21:0) after 1m0s
[11:55:02.209] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:21:0)
[11:55:02.209] Timer tick, asking Buildbucket for the build status
[11:55:02.432] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:02.432] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:22:0) after 1m0s
[11:56:02.569] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:22:0)
[11:56:02.569] Timer tick, asking Buildbucket for the build status
[11:56:02.869] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:02.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:23:0) after 1m0s
[11:57:02.987] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:23:0)
[11:57:02.987] Timer tick, asking Buildbucket for the build status
[11:57:03.132] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:03.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:24:0) after 1m0s
[11:58:03.212] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:24:0)
[11:58:03.212] Timer tick, asking Buildbucket for the build status
[11:58:03.458] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:03.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:25:0) after 1m0s
[11:59:03.484] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:25:0)
[11:59:03.484] Timer tick, asking Buildbucket for the build status
[11:59:03.842] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:03.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:26:0) after 1m0s
[12:00:03.931] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:26:0)
[12:00:03.931] Timer tick, asking Buildbucket for the build status
[12:00:04.675] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:04.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:27:0) after 1m0s
[12:01:04.696] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:27:0)
[12:01:04.696] Timer tick, asking Buildbucket for the build status
[12:01:04.988] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:04.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:28:0) after 1m0s
[12:02:05.005] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:28:0)
[12:02:05.005] Timer tick, asking Buildbucket for the build status
[12:02:05.361] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:05.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:29:0) after 1m0s
[12:03:05.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:29:0)
[12:03:05.394] Timer tick, asking Buildbucket for the build status
[12:03:05.762] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:05.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:30:0) after 1m0s
[12:04:05.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:30:0)
[12:04:05.793] Timer tick, asking Buildbucket for the build status
[12:04:06.224] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:06.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:31:0) after 1m0s
[12:05:06.323] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:31:0)
[12:05:06.323] Timer tick, asking Buildbucket for the build status
[12:05:06.734] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:06.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:32:0) after 1m0s
[12:06:06.800] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:32:0)
[12:06:06.800] Timer tick, asking Buildbucket for the build status
[12:06:06.900] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:06.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:33:0) after 1m0s
[12:07:06.916] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:33:0)
[12:07:06.916] Timer tick, asking Buildbucket for the build status
[12:07:07.055] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:07.055] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:34:0) after 1m0s
[12:08:07.069] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:34:0)
[12:08:07.069] Timer tick, asking Buildbucket for the build status
[12:08:07.153] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:07.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:35:0) after 1m0s
[12:09:07.208] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:35:0)
[12:09:07.208] Timer tick, asking Buildbucket for the build status
[12:09:07.389] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:07.389] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:36:0) after 1m0s
[12:10:07.411] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:36:0)
[12:10:07.411] Timer tick, asking Buildbucket for the build status
[12:10:07.524] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:07.524] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:37:0) after 1m0s
[12:11:07.575] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:37:0)
[12:11:07.575] Timer tick, asking Buildbucket for the build status
[12:11:07.661] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:07.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:38:0) after 1m0s
[12:12:07.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:38:0)
[12:12:07.793] Timer tick, asking Buildbucket for the build status
[12:12:07.891] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:07.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:39:0) after 1m0s
[12:13:08.005] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:39:0)
[12:13:08.005] Timer tick, asking Buildbucket for the build status
[12:13:09.499] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:09.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:40:0) after 1m0s
[12:14:09.521] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:40:0)
[12:14:09.521] Timer tick, asking Buildbucket for the build status
[12:14:09.660] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:09.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:41:0) after 1m0s
[12:15:09.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:41:0)
[12:15:09.737] Timer tick, asking Buildbucket for the build status
[12:15:09.840] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:09.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:42:0) after 1m0s
[12:16:09.957] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:42:0)
[12:16:09.957] Timer tick, asking Buildbucket for the build status
[12:16:10.027] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:10.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:43:0) after 1m0s
[12:17:10.147] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:43:0)
[12:17:10.147] Timer tick, asking Buildbucket for the build status
[12:17:10.255] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:10.255] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:44:0) after 1m0s
[12:18:10.443] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:44:0)
[12:18:10.443] Timer tick, asking Buildbucket for the build status
[12:18:10.633] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:10.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:45:0) after 1m0s
[12:19:10.696] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:45:0)
[12:19:10.696] Timer tick, asking Buildbucket for the build status
[12:19:10.785] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:10.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:46:0) after 1m0s
[12:20:10.856] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:46:0)
[12:20:10.856] Timer tick, asking Buildbucket for the build status
[12:20:11.318] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:11.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:47:0) after 1m0s
[12:21:11.349] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:47:0)
[12:21:11.349] Timer tick, asking Buildbucket for the build status
[12:21:11.581] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:11.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:48:0) after 1m0s
[12:22:11.645] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:48:0)
[12:22:11.645] Timer tick, asking Buildbucket for the build status
[12:22:12.728] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:12.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:49:0) after 1m0s
[12:23:12.784] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:49:0)
[12:23:12.784] Timer tick, asking Buildbucket for the build status
[12:23:13.162] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:13.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:50:0) after 1m0s
[12:24:13.271] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:50:0)
[12:24:13.271] Timer tick, asking Buildbucket for the build status
[12:24:13.346] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:13.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:51:0) after 1m0s
[12:25:13.421] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:51:0)
[12:25:13.421] Timer tick, asking Buildbucket for the build status
[12:25:13.555] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:13.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:52:0) after 1m0s
[12:26:13.614] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:52:0)
[12:26:13.614] Timer tick, asking Buildbucket for the build status
[12:26:14.580] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:14.580] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:53:0) after 1m0s
[12:27:14.591] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:53:0)
[12:27:14.591] Timer tick, asking Buildbucket for the build status
[12:27:14.694] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:14.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:54:0) after 1m0s
[12:28:14.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:54:0)
[12:28:14.737] Timer tick, asking Buildbucket for the build status
[12:28:15.068] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:15.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:55:0) after 1m0s
[12:29:15.103] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:55:0)
[12:29:15.103] Timer tick, asking Buildbucket for the build status
[12:29:15.205] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:15.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:56:0) after 1m0s
[12:30:15.232] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:56:0)
[12:30:15.232] Timer tick, asking Buildbucket for the build status
[12:30:15.801] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:15.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:57:0) after 1m0s
[12:31:15.843] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:57:0)
[12:31:15.843] Timer tick, asking Buildbucket for the build status
[12:31:16.628] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:16.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:58:0) after 1m0s
[12:32:16.662] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:58:0)
[12:32:16.662] Timer tick, asking Buildbucket for the build status
[12:32:16.747] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:16.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:59:0) after 1m0s
[12:33:16.801] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:59:0)
[12:33:16.801] Timer tick, asking Buildbucket for the build status
[12:33:17.047] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:17.047] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:60:0) after 1m0s
[12:34:17.145] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:60:0)
[12:34:17.145] Timer tick, asking Buildbucket for the build status
[12:34:17.476] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:17.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:61:0) after 1m0s
[12:35:17.537] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:61:0)
[12:35:17.537] Timer tick, asking Buildbucket for the build status
[12:35:17.605] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:17.605] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:62:0) after 1m0s
[12:36:19.042] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:62:0)
[12:36:19.042] Timer tick, asking Buildbucket for the build status
[12:36:19.159] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:19.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:63:0) after 1m0s
[12:37:19.396] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:63:0)
[12:37:19.396] Timer tick, asking Buildbucket for the build status
[12:37:19.517] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:19.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:64:0) after 1m0s
[12:38:19.562] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:64:0)
[12:38:19.562] Timer tick, asking Buildbucket for the build status
[12:38:20.225] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:20.225] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:65:0) after 1m0s
[12:39:20.280] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:65:0)
[12:39:20.281] Timer tick, asking Buildbucket for the build status
[12:39:20.401] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:20.401] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:66:0) after 1m0s
[12:40:20.577] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:66:0)
[12:40:20.577] Timer tick, asking Buildbucket for the build status
[12:40:20.759] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:20.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:67:0) after 1m0s
[12:41:20.922] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:67:0)
[12:41:20.922] Timer tick, asking Buildbucket for the build status
[12:41:21.085] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:21.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:68:0) after 1m0s
[12:42:21.219] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:68:0)
[12:42:21.219] Timer tick, asking Buildbucket for the build status
[12:42:21.400] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:21.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:69:0) after 1m0s
[12:43:21.454] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:69:0)
[12:43:21.454] Timer tick, asking Buildbucket for the build status
[12:43:21.620] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:21.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:70:0) after 1m0s
[12:44:21.776] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:70:0)
[12:44:21.776] Timer tick, asking Buildbucket for the build status
[12:44:21.899] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:21.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:71:0) after 1m0s
[12:45:21.953] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:71:0)
[12:45:21.953] Timer tick, asking Buildbucket for the build status
[12:45:22.013] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:22.013] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:72:0) after 1m0s
[12:46:22.231] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:72:0)
[12:46:22.231] Timer tick, asking Buildbucket for the build status
[12:46:22.667] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:22.667] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:73:0) after 1m0s
[12:47:22.777] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:73:0)
[12:47:22.777] Timer tick, asking Buildbucket for the build status
[12:47:22.836] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:22.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:74:0) after 1m0s
[12:48:22.861] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:74:0)
[12:48:22.861] Timer tick, asking Buildbucket for the build status
[12:48:23.112] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:23.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:75:0) after 1m0s
[12:49:23.235] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:75:0)
[12:49:23.235] Timer tick, asking Buildbucket for the build status
[12:49:23.492] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:23.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:76:0) after 1m0s
[12:50:23.571] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:76:0)
[12:50:23.571] Timer tick, asking Buildbucket for the build status
[12:50:23.891] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:23.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:77:0) after 1m0s
[12:51:24.003] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:77:0)
[12:51:24.003] Timer tick, asking Buildbucket for the build status
[12:51:24.113] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:24.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:78:0) after 1m0s
[12:52:24.205] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:78:0)
[12:52:24.205] Timer tick, asking Buildbucket for the build status
[12:52:24.528] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:24.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:79:0) after 1m0s
[12:53:24.550] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:79:0)
[12:53:24.550] Timer tick, asking Buildbucket for the build status
[12:53:24.647] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:24.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:80:0) after 1m0s
[12:54:24.744] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:80:0)
[12:54:24.744] Timer tick, asking Buildbucket for the build status
[12:54:24.828] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:24.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:81:0) after 1m0s
[12:55:24.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:81:0)
[12:55:24.920] Timer tick, asking Buildbucket for the build status
[12:55:25.063] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:25.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:82:0) after 1m0s
[12:56:25.147] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:82:0)
[12:56:25.147] Timer tick, asking Buildbucket for the build status
[12:56:25.257] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:25.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:83:0) after 1m0s
[12:57:25.302] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:83:0)
[12:57:25.302] Timer tick, asking Buildbucket for the build status
[12:57:25.543] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:25.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:84:0) after 1m0s
[12:58:25.624] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:84:0)
[12:58:25.624] Timer tick, asking Buildbucket for the build status
[12:58:26.483] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:26.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:85:0) after 1m0s
[12:59:26.514] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:85:0)
[12:59:26.514] Timer tick, asking Buildbucket for the build status
[12:59:27.005] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:27.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:86:0) after 1m0s
[13:00:27.052] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:86:0)
[13:00:27.052] Timer tick, asking Buildbucket for the build status
[13:00:27.113] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:27.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:87:0) after 1m0s
[13:01:27.363] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:87:0)
[13:01:27.363] Timer tick, asking Buildbucket for the build status
[13:01:27.438] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:27.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:88:0) after 1m0s
[13:02:27.639] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:88:0)
[13:02:27.639] Timer tick, asking Buildbucket for the build status
[13:02:27.879] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:27.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:89:0) after 1m0s
[13:03:27.916] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:89:0)
[13:03:27.916] Timer tick, asking Buildbucket for the build status
[13:03:28.359] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:28.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:90:0) after 1m0s
[13:04:28.419] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:90:0)
[13:04:28.419] Timer tick, asking Buildbucket for the build status
[13:04:28.487] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:28.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:91:0) after 1m0s
[13:05:28.571] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:91:0)
[13:05:28.571] Timer tick, asking Buildbucket for the build status
[13:05:28.769] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:28.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:92:0) after 1m0s
[13:06:28.827] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:92:0)
[13:06:28.827] Timer tick, asking Buildbucket for the build status
[13:06:29.086] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:29.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:93:0) after 1m0s
[13:07:30.356] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:93:0)
[13:07:30.356] Timer tick, asking Buildbucket for the build status
[13:07:30.525] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:30.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:94:0) after 1m0s
[13:08:30.889] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:94:0)
[13:08:30.889] Timer tick, asking Buildbucket for the build status
[13:08:34.224] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:34.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:95:0) after 1m0s
[13:09:34.622] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:95:0)
[13:09:34.622] Timer tick, asking Buildbucket for the build status
[13:09:34.771] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:34.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:96:0) after 1m0s
[13:10:34.848] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:96:0)
[13:10:34.848] Timer tick, asking Buildbucket for the build status
[13:10:35.554] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:35.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:97:0) after 1m0s
[13:11:35.593] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:97:0)
[13:11:35.593] Timer tick, asking Buildbucket for the build status
[13:11:36.546] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:36.546] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:98:0) after 1m0s
[13:12:36.562] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:98:0)
[13:12:36.562] Timer tick, asking Buildbucket for the build status
[13:12:36.678] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:36.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:99:0) after 1m0s
[13:13:36.735] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:99:0)
[13:13:36.735] Timer tick, asking Buildbucket for the build status
[13:13:37.745] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:37.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:100:0) after 1m0s
[13:14:37.840] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:100:0)
[13:14:37.840] Timer tick, asking Buildbucket for the build status
[13:14:37.944] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:37.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:101:0) after 1m0s
[13:15:38.062] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:101:0)
[13:15:38.062] Timer tick, asking Buildbucket for the build status
[13:15:38.256] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:38.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:102:0) after 1m0s
[13:16:38.322] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:102:0)
[13:16:38.322] Timer tick, asking Buildbucket for the build status
[13:16:38.451] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:38.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:103:0) after 1m0s
[13:17:38.662] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:103:0)
[13:17:38.662] Timer tick, asking Buildbucket for the build status
[13:17:38.744] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:38.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:104:0) after 1m0s
[13:18:38.849] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:104:0)
[13:18:38.849] Timer tick, asking Buildbucket for the build status
[13:18:39.002] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:39.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:105:0) after 1m0s
[13:19:39.197] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:105:0)
[13:19:39.197] Timer tick, asking Buildbucket for the build status
[13:19:40.474] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:40.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:106:0) after 1m0s
[13:20:40.534] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:106:0)
[13:20:40.534] Timer tick, asking Buildbucket for the build status
[13:20:40.608] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:40.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:107:0) after 1m0s
[13:21:40.677] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:107:0)
[13:21:40.677] Timer tick, asking Buildbucket for the build status
[13:21:40.773] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:40.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:108:0) after 1m0s
[13:22:40.817] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:108:0)
[13:22:40.817] Timer tick, asking Buildbucket for the build status
[13:22:40.947] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:40.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:109:0) after 1m0s
[13:23:41.082] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:109:0)
[13:23:41.082] Timer tick, asking Buildbucket for the build status
[13:23:46.129] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:46.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:110:0) after 1m0s
[13:24:46.242] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:110:0)
[13:24:46.242] Timer tick, asking Buildbucket for the build status
[13:24:46.391] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:46.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:111:0) after 1m0s
[13:25:46.442] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:111:0)
[13:25:46.442] Timer tick, asking Buildbucket for the build status
[13:25:46.528] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:46.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:112:0) after 1m0s
[13:26:46.627] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:112:0)
[13:26:46.628] Timer tick, asking Buildbucket for the build status
[13:26:46.791] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:46.791] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:113:0) after 1m0s
[13:27:46.939] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:113:0)
[13:27:46.939] Timer tick, asking Buildbucket for the build status
[13:27:47.158] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:47.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:114:0) after 1m0s
[13:28:47.229] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:114:0)
[13:28:47.229] Timer tick, asking Buildbucket for the build status
[13:28:47.416] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:47.416] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:115:0) after 1m0s
[13:29:47.601] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:115:0)
[13:29:47.601] Timer tick, asking Buildbucket for the build status
[13:29:47.971] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:47.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:116:0) after 1m0s
[13:30:48.063] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:116:0)
[13:30:48.063] Timer tick, asking Buildbucket for the build status
[13:30:48.251] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:48.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:117:0) after 1m0s
[13:31:48.260] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:117:0)
[13:31:48.260] Timer tick, asking Buildbucket for the build status
[13:31:48.328] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:48.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:118:0) after 1m0s
[13:32:48.400] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:118:0)
[13:32:48.400] Timer tick, asking Buildbucket for the build status
[13:32:49.043] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:49.043] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:119:0) after 1m0s
[13:33:49.183] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:119:0)
[13:33:49.183] Timer tick, asking Buildbucket for the build status
[13:33:51.768] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:51.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:120:0) after 1m0s
[13:34:51.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:120:0)
[13:34:51.793] Timer tick, asking Buildbucket for the build status
[13:34:52.205] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:52.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:121:0) after 1m0s
[13:35:52.256] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:121:0)
[13:35:52.256] Timer tick, asking Buildbucket for the build status
[13:35:52.335] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:52.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:122:0) after 1m0s
[13:36:52.403] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:122:0)
[13:36:52.403] Timer tick, asking Buildbucket for the build status
[13:36:52.629] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:52.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:123:0) after 1m0s
[13:37:52.661] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:123:0)
[13:37:52.661] Timer tick, asking Buildbucket for the build status
[13:37:52.938] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:52.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:124:0) after 1m0s
[13:38:53.001] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:124:0)
[13:38:53.001] Timer tick, asking Buildbucket for the build status
[13:39:00.552] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:00.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:125:0) after 1m0s
[13:40:01.924] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:125:0)
[13:40:01.924] Timer tick, asking Buildbucket for the build status
[13:40:02.091] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:02.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:126:0) after 1m0s
[13:41:02.283] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:126:0)
[13:41:02.283] Timer tick, asking Buildbucket for the build status
[13:41:03.549] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:03.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:127:0) after 1m0s
[13:42:03.680] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:127:0)
[13:42:03.680] Timer tick, asking Buildbucket for the build status
[13:42:04.860] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:04.860] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:128:0) after 1m0s
[13:43:04.949] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:128:0)
[13:43:04.949] Timer tick, asking Buildbucket for the build status
[13:43:05.273] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:05.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:129:0) after 1m0s
[13:44:05.497] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:129:0)
[13:44:05.497] Timer tick, asking Buildbucket for the build status
[13:44:05.687] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:05.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:130:0) after 1m0s
[13:45:05.774] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:130:0)
[13:45:05.774] Timer tick, asking Buildbucket for the build status
[13:45:10.762] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:10.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:131:0) after 1m0s
[13:46:10.913] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:131:0)
[13:46:10.913] Timer tick, asking Buildbucket for the build status
[13:46:11.037] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:11.037] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:132:0) after 1m0s
[13:47:11.168] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:132:0)
[13:47:11.168] Timer tick, asking Buildbucket for the build status
[13:47:11.321] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:11.321] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:133:0) after 1m0s
[13:48:11.455] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:133:0)
[13:48:11.455] Timer tick, asking Buildbucket for the build status
[13:48:11.579] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:11.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:134:0) after 1m0s
[13:49:11.877] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:134:0)
[13:49:11.877] Timer tick, asking Buildbucket for the build status
[13:49:12.329] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:12.329] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:135:0) after 1m0s
[13:50:12.620] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:135:0)
[13:50:12.620] Timer tick, asking Buildbucket for the build status
[13:50:13.194] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:13.194] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:136:0) after 1m0s
[13:51:13.558] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:136:0)
[13:51:13.558] Timer tick, asking Buildbucket for the build status
[13:51:13.668] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:13.668] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:137:0) after 1m0s
[13:52:13.837] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:137:0)
[13:52:13.837] Timer tick, asking Buildbucket for the build status
[13:52:14.102] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:14.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:138:0) after 1m0s
[13:53:14.115] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:138:0)
[13:53:14.115] Timer tick, asking Buildbucket for the build status
[13:53:14.279] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:14.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:139:0) after 1m0s
[13:54:14.378] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:139:0)
[13:54:14.378] Timer tick, asking Buildbucket for the build status
[13:54:14.640] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:14.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:140:0) after 1m0s
[13:55:14.717] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:140:0)
[13:55:14.717] Timer tick, asking Buildbucket for the build status
[13:55:14.956] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:14.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:141:0) after 1m0s
[13:56:14.974] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:141:0)
[13:56:14.974] Timer tick, asking Buildbucket for the build status
[13:56:15.192] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:15.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:142:0) after 1m0s
[13:57:15.288] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:142:0)
[13:57:15.288] Timer tick, asking Buildbucket for the build status
[13:57:15.453] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:15.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:143:0) after 1m0s
[13:58:15.586] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:143:0)
[13:58:15.586] Timer tick, asking Buildbucket for the build status
[13:58:15.726] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:15.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:144:0) after 1m0s
[13:59:15.826] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:144:0)
[13:59:15.826] Timer tick, asking Buildbucket for the build status
[13:59:15.912] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:15.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:145:0) after 1m0s
[14:00:15.981] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:145:0)
[14:00:15.981] Timer tick, asking Buildbucket for the build status
[14:00:16.961] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:16.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:146:0) after 1m0s
[14:01:17.175] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:146:0)
[14:01:17.175] Timer tick, asking Buildbucket for the build status
[14:01:17.616] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:17.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:147:0) after 1m0s
[14:02:17.893] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:147:0)
[14:02:17.893] Timer tick, asking Buildbucket for the build status
[14:02:19.030] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:19.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:148:0) after 1m0s
[14:03:19.070] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:148:0)
[14:03:19.070] Timer tick, asking Buildbucket for the build status
[14:03:19.257] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:19.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:149:0) after 1m0s
[14:04:19.289] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:149:0)
[14:04:19.289] Timer tick, asking Buildbucket for the build status
[14:04:19.404] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:19.404] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:150:0) after 1m0s
[14:05:19.431] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:150:0)
[14:05:19.431] Timer tick, asking Buildbucket for the build status
[14:05:19.651] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:19.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:151:0) after 1m0s
[14:06:19.827] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:151:0)
[14:06:19.827] Timer tick, asking Buildbucket for the build status
[14:06:20.157] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:20.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:152:0) after 1m0s
[14:07:20.479] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:152:0)
[14:07:20.479] Timer tick, asking Buildbucket for the build status
[14:07:20.668] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:20.668] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:153:0) after 1m0s
[14:08:22.254] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:153:0)
[14:08:22.254] Timer tick, asking Buildbucket for the build status
[14:08:22.819] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:22.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:154:0) after 1m0s
[14:09:22.879] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:154:0)
[14:09:22.879] Timer tick, asking Buildbucket for the build status
[14:09:23.266] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:23.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:155:0) after 1m0s
[14:10:23.299] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:155:0)
[14:10:23.299] Timer tick, asking Buildbucket for the build status
[14:10:23.788] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:23.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:156:0) after 1m0s
[14:11:23.899] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:156:0)
[14:11:23.899] Timer tick, asking Buildbucket for the build status
[14:11:24.000] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:24.000] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:157:0) after 1m0s
[14:12:24.315] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:157:0)
[14:12:24.315] Timer tick, asking Buildbucket for the build status
[14:12:24.576] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:24.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:158:0) after 1m0s
[14:13:24.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:158:0)
[14:13:24.745] Timer tick, asking Buildbucket for the build status
[14:13:25.731] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:25.731] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:159:0) after 1m0s
[14:14:25.801] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:159:0)
[14:14:25.801] Timer tick, asking Buildbucket for the build status
[14:14:25.921] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:25.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:160:0) after 1m0s
[14:15:26.255] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:160:0)
[14:15:26.255] Timer tick, asking Buildbucket for the build status
[14:15:26.344] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:26.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:161:0) after 1m0s
[14:16:26.624] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:161:0)
[14:16:26.624] Timer tick, asking Buildbucket for the build status
[14:16:26.779] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:26.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:162:0) after 1m0s
[14:17:26.848] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:162:0)
[14:17:26.848] Timer tick, asking Buildbucket for the build status
[14:17:27.145] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:27.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:163:0) after 1m0s
[14:18:27.240] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:163:0)
[14:18:27.240] Timer tick, asking Buildbucket for the build status
[14:18:28.500] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:28.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:164:0) after 1m0s
[14:19:28.535] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:164:0)
[14:19:28.535] Timer tick, asking Buildbucket for the build status
[14:19:28.762] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:28.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:165:0) after 1m0s
[14:20:28.811] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:165:0)
[14:20:28.811] Timer tick, asking Buildbucket for the build status
[14:20:28.966] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:28.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:166:0) after 1m0s
[14:21:29.002] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:166:0)
[14:21:29.002] Timer tick, asking Buildbucket for the build status
[14:21:29.202] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:29.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:167:0) after 1m0s
[14:22:29.204] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:167:0)
[14:22:29.204] Timer tick, asking Buildbucket for the build status
[14:22:29.470] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:29.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:168:0) after 1m0s
[14:23:29.461] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:168:0)
[14:23:29.461] Timer tick, asking Buildbucket for the build status
[14:23:30.114] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:30.114] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:169:0) after 1m0s
[14:24:30.146] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:169:0)
[14:24:30.146] Timer tick, asking Buildbucket for the build status
[14:24:30.378] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:30.378] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:170:0) after 1m0s
[14:25:30.416] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:170:0)
[14:25:30.416] Timer tick, asking Buildbucket for the build status
[14:25:30.602] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:30.602] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:171:0) after 1m0s
[14:26:30.633] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:171:0)
[14:26:30.633] Timer tick, asking Buildbucket for the build status
[14:26:31.008] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:31.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:172:0) after 1m0s
[14:27:31.023] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:172:0)
[14:27:31.023] Timer tick, asking Buildbucket for the build status
[14:27:31.457] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:31.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:173:0) after 1m0s
[14:28:31.489] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:173:0)
[14:28:31.489] Timer tick, asking Buildbucket for the build status
[14:28:31.988] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:31.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:174:0) after 1m0s
[14:29:32.086] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:174:0)
[14:29:32.086] Timer tick, asking Buildbucket for the build status
[14:29:32.944] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:32.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:175:0) after 1m0s
[14:30:32.973] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:175:0)
[14:30:32.973] Timer tick, asking Buildbucket for the build status
[14:30:33.088] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:33.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:176:0) after 1m0s
[14:31:33.147] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:176:0)
[14:31:33.147] Timer tick, asking Buildbucket for the build status
[14:31:33.232] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:33.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:177:0) after 1m0s
[14:32:33.278] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:177:0)
[14:32:33.278] Timer tick, asking Buildbucket for the build status
[14:32:33.723] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:33.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:178:0) after 1m0s
[14:33:34.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:178:0)
[14:33:34.844] Timer tick, asking Buildbucket for the build status
[14:33:35.031] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:35.031] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:179:0) after 1m0s
[14:34:35.071] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:179:0)
[14:34:35.071] Timer tick, asking Buildbucket for the build status
[14:34:35.257] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:35.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:180:0) after 1m0s
[14:35:35.318] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:180:0)
[14:35:35.318] Timer tick, asking Buildbucket for the build status
[14:35:35.484] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:35.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:181:0) after 1m0s
[14:36:35.549] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:181:0)
[14:36:35.549] Timer tick, asking Buildbucket for the build status
[14:36:35.676] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:35.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:182:0) after 1m0s
[14:37:35.768] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:182:0)
[14:37:35.768] Timer tick, asking Buildbucket for the build status
[14:37:35.870] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:35.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:183:0) after 1m0s
[14:38:35.937] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:183:0)
[14:38:35.937] Timer tick, asking Buildbucket for the build status
[14:38:36.418] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:36.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:184:0) after 1m0s
[14:39:36.515] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:184:0)
[14:39:36.515] Timer tick, asking Buildbucket for the build status
[14:39:36.595] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:36.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:185:0) after 1m0s
[14:40:36.782] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:185:0)
[14:40:36.782] Timer tick, asking Buildbucket for the build status
[14:40:37.132] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:37.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:186:0) after 1m0s
[14:41:37.326] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:186:0)
[14:41:37.326] Timer tick, asking Buildbucket for the build status
[14:41:37.411] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:37.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:187:0) after 1m0s
[14:42:37.516] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:187:0)
[14:42:37.516] Timer tick, asking Buildbucket for the build status
[14:42:37.611] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:37.611] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:188:0) after 1m0s
[14:43:37.681] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:188:0)
[14:43:37.681] Timer tick, asking Buildbucket for the build status
[14:43:39.436] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:39.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:189:0) after 1m0s
[14:44:39.473] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:189:0)
[14:44:39.473] Timer tick, asking Buildbucket for the build status
[14:44:39.934] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:39.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:190:0) after 1m0s
[14:45:39.928] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:190:0)
[14:45:39.928] Timer tick, asking Buildbucket for the build status
[14:45:40.022] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:40.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:191:0) after 1m0s
[14:46:40.095] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:191:0)
[14:46:40.095] Timer tick, asking Buildbucket for the build status
[14:46:40.205] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:40.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:192:0) after 1m0s
[14:47:40.321] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:192:0)
[14:47:40.321] Timer tick, asking Buildbucket for the build status
[14:47:40.687] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:40.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:193:0) after 1m0s
[14:48:40.774] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:193:0)
[14:48:40.774] Timer tick, asking Buildbucket for the build status
[14:48:43.825] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:43.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:194:0) after 1m0s
[14:49:43.931] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:194:0)
[14:49:43.933] Timer tick, asking Buildbucket for the build status
[14:49:44.007] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:44.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:195:0) after 1m0s
[14:50:44.143] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:195:0)
[14:50:44.143] Timer tick, asking Buildbucket for the build status
[14:50:44.220] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:44.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:196:0) after 1m0s
[14:51:44.369] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:196:0)
[14:51:44.369] Timer tick, asking Buildbucket for the build status
[14:51:44.491] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:44.491] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:197:0) after 1m0s
[14:52:44.722] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:197:0)
[14:52:44.722] Timer tick, asking Buildbucket for the build status
[14:52:44.890] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:44.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:198:0) after 1m0s
[14:53:45.011] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:198:0)
[14:53:45.011] Timer tick, asking Buildbucket for the build status
[14:53:48.818] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:48.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:199:0) after 1m0s
[14:54:48.819] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:199:0)
[14:54:48.819] Timer tick, asking Buildbucket for the build status
[14:54:48.994] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:48.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:200:0) after 1m0s
[14:55:49.025] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:200:0)
[14:55:49.025] Timer tick, asking Buildbucket for the build status
[14:55:49.262] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:49.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:201:0) after 1m0s
[14:56:49.300] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:201:0)
[14:56:49.300] Timer tick, asking Buildbucket for the build status
[14:56:49.446] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:49.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:202:0) after 1m0s
[14:57:49.474] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:202:0)
[14:57:49.474] Timer tick, asking Buildbucket for the build status
[14:57:49.544] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:49.545] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:203:0) after 1m0s
[14:58:49.553] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:203:0)
[14:58:49.553] Timer tick, asking Buildbucket for the build status
[14:58:51.535] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:51.535] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:204:0) after 1m0s
[14:59:51.591] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:204:0)
[14:59:51.591] Timer tick, asking Buildbucket for the build status
[14:59:51.735] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:51.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:205:0) after 1m0s
[15:00:51.825] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:205:0)
[15:00:51.825] Timer tick, asking Buildbucket for the build status
[15:00:53.771] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:53.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:206:0) after 1m0s
[15:01:53.866] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:206:0)
[15:01:53.866] Timer tick, asking Buildbucket for the build status
[15:01:54.202] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:54.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:207:0) after 1m0s
[15:02:54.329] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:207:0)
[15:02:54.329] Timer tick, asking Buildbucket for the build status
[15:02:55.904] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:55.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:208:0) after 1m0s
[15:03:55.935] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:208:0)
[15:03:55.935] Timer tick, asking Buildbucket for the build status
[15:03:57.209] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:57.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:209:0) after 1m0s
[15:04:57.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:209:0)
[15:04:57.330] Timer tick, asking Buildbucket for the build status
[15:04:57.505] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:57.505] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:210:0) after 1m0s
[15:05:57.581] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:210:0)
[15:05:57.581] Timer tick, asking Buildbucket for the build status
[15:05:57.829] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:57.829] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:211:0) after 1m0s
[15:06:57.938] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:211:0)
[15:06:57.938] Timer tick, asking Buildbucket for the build status
[15:06:58.229] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:58.229] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:212:0) after 1m0s
[15:07:58.226] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:212:0)
[15:07:58.227] Timer tick, asking Buildbucket for the build status
[15:07:58.345] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:58.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:213:0) after 1m0s
[15:08:58.449] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:213:0)
[15:08:58.449] Timer tick, asking Buildbucket for the build status
[15:09:01.924] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:01.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:214:0) after 1m0s
[15:10:02.278] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:214:0)
[15:10:02.279] Timer tick, asking Buildbucket for the build status
[15:10:02.440] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:02.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:215:0) after 1m0s
[15:11:02.596] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:215:0)
[15:11:02.596] Timer tick, asking Buildbucket for the build status
[15:11:02.668] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:02.668] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:216:0) after 1m0s
[15:12:03.215] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:216:0)
[15:12:03.216] Timer tick, asking Buildbucket for the build status
[15:12:04.024] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:04.024] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:217:0) after 1m0s
[15:13:04.149] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:217:0)
[15:13:04.149] Timer tick, asking Buildbucket for the build status
[15:13:04.443] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:04.443] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:218:0) after 1m0s
[15:14:04.536] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:218:0)
[15:14:04.536] Timer tick, asking Buildbucket for the build status
[15:14:05.747] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:05.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:219:0) after 1m0s
[15:15:05.799] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:219:0)
[15:15:05.799] Timer tick, asking Buildbucket for the build status
[15:15:06.390] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:06.390] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:220:0) after 1m0s
[15:16:06.432] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:220:0)
[15:16:06.432] Timer tick, asking Buildbucket for the build status
[15:16:06.494] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:06.494] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:221:0) after 1m0s
[15:17:06.535] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:221:0)
[15:17:06.535] Timer tick, asking Buildbucket for the build status
[15:17:06.876] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:06.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:222:0) after 1m0s
[15:18:06.951] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:222:0)
[15:18:06.951] Timer tick, asking Buildbucket for the build status
[15:18:07.213] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:07.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:223:0) after 1m0s
[15:19:07.239] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:223:0)
[15:19:07.239] Timer tick, asking Buildbucket for the build status
[15:19:07.519] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:07.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:224:0) after 1m0s
[15:20:07.553] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:224:0)
[15:20:07.553] Timer tick, asking Buildbucket for the build status
[15:20:07.656] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:07.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:225:0) after 1m0s
[15:21:07.665] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:225:0)
[15:21:07.665] Timer tick, asking Buildbucket for the build status
[15:21:07.812] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:07.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:226:0) after 1m0s
[15:22:08.106] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:226:0)
[15:22:08.106] Timer tick, asking Buildbucket for the build status
[15:22:08.547] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:08.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:227:0) after 1m0s
[15:23:08.810] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:227:0)
[15:23:08.810] Timer tick, asking Buildbucket for the build status
[15:23:08.893] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:08.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:228:0) after 1m0s
[15:24:09.199] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:228:0)
[15:24:09.199] Timer tick, asking Buildbucket for the build status
[15:24:10.998] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:10.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:229:0) after 1m0s
[15:25:11.281] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:229:0)
[15:25:11.281] Timer tick, asking Buildbucket for the build status
[15:25:11.806] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:11.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:230:0) after 1m0s
[15:26:12.049] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:230:0)
[15:26:12.049] Timer tick, asking Buildbucket for the build status
[15:26:12.283] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:12.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:231:0) after 1m0s
[15:27:12.569] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:231:0)
[15:27:12.569] Timer tick, asking Buildbucket for the build status
[15:27:12.664] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:12.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:232:0) after 1m0s
[15:28:12.805] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:232:0)
[15:28:12.805] Timer tick, asking Buildbucket for the build status
[15:28:12.949] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:12.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:233:0) after 1m0s
[15:29:13.010] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:233:0)
[15:29:13.010] Timer tick, asking Buildbucket for the build status
[15:29:16.318] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:16.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:234:0) after 1m0s
[15:30:17.568] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:234:0)
[15:30:17.568] Timer tick, asking Buildbucket for the build status
[15:30:18.596] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:18.596] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:235:0) after 1m0s
[15:31:19.355] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:235:0)
[15:31:19.355] Timer tick, asking Buildbucket for the build status
[15:31:19.438] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:19.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:236:0) after 1m0s
[15:32:19.634] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:236:0)
[15:32:19.634] Timer tick, asking Buildbucket for the build status
[15:32:20.273] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:20.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:237:0) after 1m0s
[15:33:20.436] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:237:0)
[15:33:20.436] Timer tick, asking Buildbucket for the build status
[15:33:20.841] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:20.841] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:238:0) after 1m0s
[15:34:20.914] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:238:0)
[15:34:20.914] Timer tick, asking Buildbucket for the build status
[15:34:21.026] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:21.026] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:239:0) after 1m0s
[15:35:21.111] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:239:0)
[15:35:21.111] Timer tick, asking Buildbucket for the build status
[15:35:22.261] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:22.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:240:0) after 1m0s
[15:36:22.263] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:240:0)
[15:36:22.263] Timer tick, asking Buildbucket for the build status
[15:36:22.465] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:22.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:241:0) after 1m0s
[15:37:22.567] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:241:0)
[15:37:22.567] Timer tick, asking Buildbucket for the build status
[15:37:22.959] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:22.959] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:242:0) after 1m0s
[15:38:23.085] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:242:0)
[15:38:23.085] Timer tick, asking Buildbucket for the build status
[15:38:23.964] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:23.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:243:0) after 1m0s
[15:39:24.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:243:0)
[15:39:24.008] Timer tick, asking Buildbucket for the build status
[15:39:24.245] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:24.245] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:244:0) after 1m0s
[15:40:24.337] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:244:0)
[15:40:24.337] Timer tick, asking Buildbucket for the build status
[15:40:24.533] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:24.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:245:0) after 1m0s
[15:41:24.733] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:245:0)
[15:41:24.733] Timer tick, asking Buildbucket for the build status
[15:41:24.880] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:24.880] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:246:0) after 1m0s
[15:42:24.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:246:0)
[15:42:24.934] Timer tick, asking Buildbucket for the build status
[15:42:25.100] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:25.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:247:0) after 1m0s
[15:43:25.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:247:0)
[15:43:25.156] Timer tick, asking Buildbucket for the build status
[15:43:25.579] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:25.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:248:0) after 1m0s
[15:44:25.620] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:248:0)
[15:44:25.620] Timer tick, asking Buildbucket for the build status
[15:44:25.688] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:25.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:249:0) after 1m0s
[15:45:25.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:249:0)
[15:45:25.745] Timer tick, asking Buildbucket for the build status
[15:45:26.282] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:26.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:250:0) after 1m0s
[15:46:26.369] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:250:0)
[15:46:26.369] Timer tick, asking Buildbucket for the build status
[15:46:26.496] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:26.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:251:0) after 1m0s
[15:47:26.671] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:251:0)
[15:47:26.671] Timer tick, asking Buildbucket for the build status
[15:47:26.833] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:26.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:252:0) after 1m0s
[15:48:26.992] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:252:0)
[15:48:26.992] Timer tick, asking Buildbucket for the build status
[15:48:27.273] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:27.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:253:0) after 1m0s
[15:49:27.308] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:253:0)
[15:49:27.308] Timer tick, asking Buildbucket for the build status
[15:49:27.499] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:27.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:254:0) after 1m0s
[15:50:27.572] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:254:0)
[15:50:27.572] Timer tick, asking Buildbucket for the build status
[15:50:27.722] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:27.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:255:0) after 1m0s
[15:51:27.728] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:255:0)
[15:51:27.728] Timer tick, asking Buildbucket for the build status
[15:51:27.801] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:27.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:256:0) after 1m0s
[15:52:27.841] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:256:0)
[15:52:27.841] Timer tick, asking Buildbucket for the build status
[15:52:29.164] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:29.164] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:257:0) after 1m0s
[15:53:29.698] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:257:0)
[15:53:29.698] Timer tick, asking Buildbucket for the build status
[15:53:29.933] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:29.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:258:0) after 1m0s
[15:54:30.007] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:258:0)
[15:54:30.007] Timer tick, asking Buildbucket for the build status
[15:54:30.857] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:30.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:259:0) after 1m0s
[15:55:31.052] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:259:0)
[15:55:31.052] Timer tick, asking Buildbucket for the build status
[15:55:31.188] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:31.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:260:0) after 1m0s
[15:56:31.334] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:260:0)
[15:56:31.334] Timer tick, asking Buildbucket for the build status
[15:56:31.451] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:31.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:261:0) after 1m0s
[15:57:31.574] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:261:0)
[15:57:31.574] Timer tick, asking Buildbucket for the build status
[15:57:31.773] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:31.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:262:0) after 1m0s
[15:58:31.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:262:0)
[15:58:31.808] Timer tick, asking Buildbucket for the build status
[15:58:32.608] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:32.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:263:0) after 1m0s
[15:59:32.959] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:263:0)
[15:59:32.959] Timer tick, asking Buildbucket for the build status
[15:59:33.437] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:33.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:264:0) after 1m0s
[16:00:33.653] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:264:0)
[16:00:33.653] Timer tick, asking Buildbucket for the build status
[16:00:34.607] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:34.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:265:0) after 1m0s
[16:01:34.771] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:265:0)
[16:01:34.771] Timer tick, asking Buildbucket for the build status
[16:01:34.977] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:34.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:266:0) after 1m0s
[16:02:35.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:266:0)
[16:02:35.156] Timer tick, asking Buildbucket for the build status
[16:02:36.356] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:36.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:267:0) after 1m0s
[16:03:36.396] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:267:0)
[16:03:36.396] Timer tick, asking Buildbucket for the build status
[16:03:39.723] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:39.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:268:0) after 1m0s
[16:04:39.755] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:268:0)
[16:04:39.755] Timer tick, asking Buildbucket for the build status
[16:04:39.838] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:39.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:269:0) after 1m0s
[16:05:39.850] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:269:0)
[16:05:39.850] Timer tick, asking Buildbucket for the build status
[16:05:40.070] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:40.070] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:270:0) after 1m0s
[16:06:40.175] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:270:0)
[16:06:40.175] Timer tick, asking Buildbucket for the build status
[16:06:40.447] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:40.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:271:0) after 1m0s
[16:07:40.616] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:271:0)
[16:07:40.616] Timer tick, asking Buildbucket for the build status
[16:07:40.732] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:40.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:272:0) after 1m0s
[16:08:40.791] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:272:0)
[16:08:40.791] Timer tick, asking Buildbucket for the build status
[16:08:42.679] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:42.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:273:0) after 1m0s
[16:09:42.744] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:273:0)
[16:09:42.744] Timer tick, asking Buildbucket for the build status
[16:09:42.814] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:42.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:274:0) after 1m0s
[16:10:42.821] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:274:0)
[16:10:42.821] Timer tick, asking Buildbucket for the build status
[16:10:43.015] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:43.015] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:275:0) after 1m0s
[16:11:43.096] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:275:0)
[16:11:43.096] Timer tick, asking Buildbucket for the build status
[16:11:43.239] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:43.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:276:0) after 1m0s
[16:12:43.346] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:276:0)
[16:12:43.346] Timer tick, asking Buildbucket for the build status
[16:12:43.577] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:43.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:277:0) after 1m0s
[16:13:43.758] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:277:0)
[16:13:43.758] Timer tick, asking Buildbucket for the build status
[16:13:43.905] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:43.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:278:0) after 1m0s
[16:14:43.963] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:278:0)
[16:14:43.963] Timer tick, asking Buildbucket for the build status
[16:14:44.066] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:44.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:279:0) after 1m0s
[16:15:44.196] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:279:0)
[16:15:44.196] Timer tick, asking Buildbucket for the build status
[16:15:44.285] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:44.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:280:0) after 1m0s
[16:16:44.351] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:280:0)
[16:16:44.351] Timer tick, asking Buildbucket for the build status
[16:16:44.535] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:44.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:281:0) after 1m0s
[16:17:44.644] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:281:0)
[16:17:44.644] Timer tick, asking Buildbucket for the build status
[16:17:44.884] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:44.884] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:282:0) after 1m0s
[16:18:44.925] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:282:0)
[16:18:44.925] Timer tick, asking Buildbucket for the build status
[16:18:46.808] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:46.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:283:0) after 1m0s
[16:19:46.884] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:283:0)
[16:19:46.884] Timer tick, asking Buildbucket for the build status
[16:19:47.050] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:47.050] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:284:0) after 1m0s
[16:20:47.171] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:284:0)
[16:20:47.171] Timer tick, asking Buildbucket for the build status
[16:20:47.541] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:47.541] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:285:0) after 1m0s
[16:21:47.574] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:285:0)
[16:21:47.574] Timer tick, asking Buildbucket for the build status
[16:21:47.831] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:47.831] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:286:0) after 1m0s
[16:22:47.831] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:286:0)
[16:22:47.831] Timer tick, asking Buildbucket for the build status
[16:22:48.001] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:48.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:287:0) after 1m0s
[16:23:48.190] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:287:0)
[16:23:48.190] Timer tick, asking Buildbucket for the build status
[16:23:49.480] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:49.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:288:0) after 1m0s
[16:24:49.559] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:288:0)
[16:24:49.559] Timer tick, asking Buildbucket for the build status
[16:24:49.646] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:49.646] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:289:0) after 1m0s
[16:25:49.697] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:289:0)
[16:25:49.697] Timer tick, asking Buildbucket for the build status
[16:25:49.828] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:49.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:290:0) after 1m0s
[16:26:49.837] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:290:0)
[16:26:49.837] Timer tick, asking Buildbucket for the build status
[16:26:50.019] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:50.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:291:0) after 1m0s
[16:27:50.051] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:291:0)
[16:27:50.051] Timer tick, asking Buildbucket for the build status
[16:27:50.448] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:50.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:292:0) after 1m0s
[16:28:50.570] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:292:0)
[16:28:50.570] Timer tick, asking Buildbucket for the build status
[16:28:52.735] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:52.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:293:0) after 1m0s
[16:29:52.727] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:293:0)
[16:29:52.727] Timer tick, asking Buildbucket for the build status
[16:29:52.810] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:52.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:294:0) after 1m0s
[16:30:53.023] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:294:0)
[16:30:53.023] Timer tick, asking Buildbucket for the build status
[16:30:53.258] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:53.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:295:0) after 1m0s
[16:31:53.395] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:295:0)
[16:31:53.395] Timer tick, asking Buildbucket for the build status
[16:31:53.679] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:53.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:296:0) after 1m0s
[16:32:53.775] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:296:0)
[16:32:53.775] Timer tick, asking Buildbucket for the build status
[16:32:54.239] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:54.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:297:0) after 1m0s
[16:33:54.302] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:297:0)
[16:33:54.302] Timer tick, asking Buildbucket for the build status
[16:33:57.183] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:57.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:298:0) after 1m0s
[16:34:57.286] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:298:0)
[16:34:57.286] Timer tick, asking Buildbucket for the build status
[16:34:57.459] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:57.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:299:0) after 1m0s
[16:35:57.535] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:299:0)
[16:35:57.535] Timer tick, asking Buildbucket for the build status
[16:35:57.796] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:57.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:300:0) after 1m0s
[16:36:57.837] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:300:0)
[16:36:57.837] Timer tick, asking Buildbucket for the build status
[16:36:58.086] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:58.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:301:0) after 1m0s
[16:37:58.144] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:301:0)
[16:37:58.144] Timer tick, asking Buildbucket for the build status
[16:37:59.769] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:59.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:302:0) after 1m0s
[16:38:59.847] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:302:0)
[16:38:59.847] Timer tick, asking Buildbucket for the build status
[16:38:59.973] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:59.973] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:303:0) after 1m0s
[16:40:00.047] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:303:0)
[16:40:00.047] Timer tick, asking Buildbucket for the build status
[16:40:00.455] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:00.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:304:0) after 1m0s
[16:41:01.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:304:0)
[16:41:01.290] Timer tick, asking Buildbucket for the build status
[16:41:01.384] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:01.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:305:0) after 1m0s
[16:42:02.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:305:0)
[16:42:02.929] Timer tick, asking Buildbucket for the build status
[16:42:03.086] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:03.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:306:0) after 1m0s
[16:43:03.191] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:306:0)
[16:43:03.191] Timer tick, asking Buildbucket for the build status
[16:43:03.578] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:03.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:307:0) after 1m0s
[16:44:03.651] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:307:0)
[16:44:03.651] Timer tick, asking Buildbucket for the build status
[16:44:03.809] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:03.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:308:0) after 1m0s
[16:45:03.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:308:0)
[16:45:03.920] Timer tick, asking Buildbucket for the build status
[16:45:04.112] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:04.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:309:0) after 1m0s
[16:46:04.198] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:309:0)
[16:46:04.198] Timer tick, asking Buildbucket for the build status
[16:46:05.010] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:05.010] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:310:0) after 1m0s
[16:47:05.149] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:310:0)
[16:47:05.149] Timer tick, asking Buildbucket for the build status
[16:47:05.232] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:05.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:311:0) after 1m0s
[16:48:05.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:311:0)
[16:48:05.238] Timer tick, asking Buildbucket for the build status
[16:48:07.891] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:07.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:312:0) after 1m0s
[16:49:07.968] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:312:0)
[16:49:07.968] Timer tick, asking Buildbucket for the build status
[16:49:08.149] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:08.149] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:313:0) after 1m0s
[16:50:08.215] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:313:0)
[16:50:08.215] Timer tick, asking Buildbucket for the build status
[16:50:08.978] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:08.978] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:314:0) after 1m0s
[16:51:09.676] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:314:0)
[16:51:09.676] Timer tick, asking Buildbucket for the build status
[16:51:10.308] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:10.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:315:0) after 1m0s
[16:52:10.670] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:315:0)
[16:52:10.670] Timer tick, asking Buildbucket for the build status
[16:52:10.794] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:10.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:316:0) after 1m0s
[16:53:10.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:316:0)
[16:53:10.935] Timer tick, asking Buildbucket for the build status
[16:53:11.108] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:11.108] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:317:0) after 1m0s
[16:54:11.231] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:317:0)
[16:54:11.231] Timer tick, asking Buildbucket for the build status
[16:54:11.319] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:11.319] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:318:0) after 1m0s
[16:55:11.490] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:318:0)
[16:55:11.490] Timer tick, asking Buildbucket for the build status
[16:55:12.917] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:12.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:319:0) after 1m0s
[16:56:13.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:319:0)
[16:56:13.156] Timer tick, asking Buildbucket for the build status
[16:56:13.325] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:13.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:320:0) after 1m0s
[16:57:13.498] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:320:0)
[16:57:13.498] Timer tick, asking Buildbucket for the build status
[16:57:13.874] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:13.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:321:0) after 1m0s
[16:58:14.000] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:321:0)
[16:58:14.000] Timer tick, asking Buildbucket for the build status
[16:58:15.264] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:15.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:322:0) after 1m0s
[16:59:15.358] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:322:0)
[16:59:15.358] Timer tick, asking Buildbucket for the build status
[16:59:15.433] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:15.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:323:0) after 1m0s
[17:00:15.953] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:323:0)
[17:00:15.953] Timer tick, asking Buildbucket for the build status
[17:00:16.543] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:16.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:324:0) after 1m0s
[17:01:17.057] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:324:0)
[17:01:17.057] Timer tick, asking Buildbucket for the build status
[17:01:17.276] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:17.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:325:0) after 1m0s
[17:02:18.240] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:325:0)
[17:02:18.240] Timer tick, asking Buildbucket for the build status
[17:02:18.699] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:18.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:326:0) after 1m0s
[17:03:18.797] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:326:0)
[17:03:18.797] Timer tick, asking Buildbucket for the build status
[17:03:19.198] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:19.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:327:0) after 1m0s
[17:04:19.543] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:327:0)
[17:04:19.543] Timer tick, asking Buildbucket for the build status
[17:04:19.651] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:19.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:328:0) after 1m0s
[17:05:19.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:328:0)
[17:05:19.960] Timer tick, asking Buildbucket for the build status
[17:05:20.150] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:20.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:329:0) after 1m0s
[17:06:20.257] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:329:0)
[17:06:20.257] Timer tick, asking Buildbucket for the build status
[17:06:20.362] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:20.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:330:0) after 1m0s
[17:07:20.675] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:330:0)
[17:07:20.675] Timer tick, asking Buildbucket for the build status
[17:07:20.882] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:20.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:331:0) after 1m0s
[17:08:21.116] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:331:0)
[17:08:21.116] Timer tick, asking Buildbucket for the build status
[17:08:22.692] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:22.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:332:0) after 1m0s
[17:09:22.826] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:332:0)
[17:09:22.826] Timer tick, asking Buildbucket for the build status
[17:09:22.910] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:22.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:333:0) after 1m0s
[17:10:23.000] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:333:0)
[17:10:23.000] Timer tick, asking Buildbucket for the build status
[17:10:23.075] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:23.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:334:0) after 1m0s
[17:11:23.164] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:334:0)
[17:11:23.164] Timer tick, asking Buildbucket for the build status
[17:11:24.754] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:24.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:335:0) after 1m0s
[17:12:24.933] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:335:0)
[17:12:24.933] Timer tick, asking Buildbucket for the build status
[17:12:25.019] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:25.020] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:336:0) after 1m0s
[17:13:25.101] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:336:0)
[17:13:25.101] Timer tick, asking Buildbucket for the build status
[17:13:25.198] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:25.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:337:0) after 1m0s
[17:14:25.472] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:337:0)
[17:14:25.472] Timer tick, asking Buildbucket for the build status
[17:14:25.775] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:25.775] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:338:0) after 1m0s
[17:15:25.936] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:338:0)
[17:15:25.936] Timer tick, asking Buildbucket for the build status
[17:15:26.133] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:26.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:339:0) after 1m0s
[17:16:26.212] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:339:0)
[17:16:26.212] Timer tick, asking Buildbucket for the build status
[17:16:26.420] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:26.420] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:340:0) after 1m0s
[17:17:26.617] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:340:0)
[17:17:26.617] Timer tick, asking Buildbucket for the build status
[17:17:26.838] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:26.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:341:0) after 1m0s
[17:18:26.907] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:341:0)
[17:18:26.907] Timer tick, asking Buildbucket for the build status
[17:18:29.280] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:29.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:342:0) after 1m0s
[17:19:29.389] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:342:0)
[17:19:29.389] Timer tick, asking Buildbucket for the build status
[17:19:29.538] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:29.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:343:0) after 1m0s
[17:20:29.614] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:343:0)
[17:20:29.614] Timer tick, asking Buildbucket for the build status
[17:20:29.711] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:29.711] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:344:0) after 1m0s
[17:21:29.777] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:344:0)
[17:21:29.777] Timer tick, asking Buildbucket for the build status
[17:21:29.845] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:29.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:345:0) after 1m0s
[17:22:29.880] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:345:0)
[17:22:29.880] Timer tick, asking Buildbucket for the build status
[17:22:30.437] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:30.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:346:0) after 1m0s
[17:23:30.500] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:346:0)
[17:23:30.500] Timer tick, asking Buildbucket for the build status
[17:23:30.626] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:30.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:347:0) after 1m0s
[17:24:30.676] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:347:0)
[17:24:30.676] Timer tick, asking Buildbucket for the build status
[17:24:30.726] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:30.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:348:0) after 1m0s
[17:25:30.802] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:348:0)
[17:25:30.802] Timer tick, asking Buildbucket for the build status
[17:25:30.958] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:30.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:349:0) after 1m0s
[17:26:31.233] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:349:0)
[17:26:31.233] Timer tick, asking Buildbucket for the build status
[17:26:31.342] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:31.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:350:0) after 1m0s
[17:27:31.380] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:350:0)
[17:27:31.380] Timer tick, asking Buildbucket for the build status
[17:27:31.591] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:31.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:351:0) after 1m0s
[17:28:31.690] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:351:0)
[17:28:31.690] Timer tick, asking Buildbucket for the build status
[17:28:31.886] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:31.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:352:0) after 1m0s
[17:29:31.942] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:352:0)
[17:29:31.942] Timer tick, asking Buildbucket for the build status
[17:29:32.213] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:32.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:353:0) after 1m0s
[17:30:32.327] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:353:0)
[17:30:32.327] Timer tick, asking Buildbucket for the build status
[17:30:32.621] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:32.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:354:0) after 1m0s
[17:31:32.763] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:354:0)
[17:31:32.763] Timer tick, asking Buildbucket for the build status
[17:31:32.861] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:32.861] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:355:0) after 1m0s
[17:32:32.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:355:0)
[17:32:32.960] Timer tick, asking Buildbucket for the build status
[17:32:33.095] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:33.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:356:0) after 1m0s
[17:33:33.195] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:356:0)
[17:33:33.195] Timer tick, asking Buildbucket for the build status
[17:33:33.423] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:33.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:357:0) after 1m0s
[17:34:33.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:357:0)
[17:34:33.487] Timer tick, asking Buildbucket for the build status
[17:34:33.625] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:33.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:358:0) after 1m0s
[17:35:33.771] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:358:0)
[17:35:33.771] Timer tick, asking Buildbucket for the build status
[17:35:33.857] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:33.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:359:0) after 1m0s
[17:36:33.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:359:0)
[17:36:33.934] Timer tick, asking Buildbucket for the build status
[17:36:34.297] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:34.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:360:0) after 1m0s
[17:37:34.489] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:360:0)
[17:37:34.489] Timer tick, asking Buildbucket for the build status
[17:37:34.576] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:34.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:361:0) after 1m0s
[17:38:34.754] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:361:0)
[17:38:34.754] Timer tick, asking Buildbucket for the build status
[17:38:35.486] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:35.486] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:362:0) after 1m0s
[17:39:35.576] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:362:0)
[17:39:35.576] Timer tick, asking Buildbucket for the build status
[17:39:35.728] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:35.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:363:0) after 1m0s
[17:40:35.796] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:363:0)
[17:40:35.797] Timer tick, asking Buildbucket for the build status
[17:40:36.131] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:36.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:364:0) after 1m0s
[17:41:36.187] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:364:0)
[17:41:36.187] Timer tick, asking Buildbucket for the build status
[17:41:36.292] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:36.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:365:0) after 1m0s
[17:42:36.654] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:365:0)
[17:42:36.654] Timer tick, asking Buildbucket for the build status
[17:42:36.976] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:36.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:366:0) after 1m0s
[17:43:37.245] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:366:0)
[17:43:37.245] Timer tick, asking Buildbucket for the build status
[17:43:42.739] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:42.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:367:0) after 1m0s
[17:44:42.874] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:367:0)
[17:44:42.874] Timer tick, asking Buildbucket for the build status
[17:44:43.046] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:43.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:368:0) after 1m0s
[17:45:43.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:368:0)
[17:45:43.272] Timer tick, asking Buildbucket for the build status
[17:45:43.348] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:43.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:369:0) after 1m0s
[17:46:43.392] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:369:0)
[17:46:43.392] Timer tick, asking Buildbucket for the build status
[17:46:43.471] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:43.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:370:0) after 1m0s
[17:47:43.555] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:370:0)
[17:47:43.555] Timer tick, asking Buildbucket for the build status
[17:47:43.721] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:43.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:371:0) after 1m0s
[17:48:43.952] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:371:0)
[17:48:43.952] Timer tick, asking Buildbucket for the build status
[17:48:44.722] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:44.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:372:0) after 1m0s
[17:49:44.837] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:372:0)
[17:49:44.837] Timer tick, asking Buildbucket for the build status
[17:49:45.168] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:45.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:373:0) after 1m0s
[17:50:45.411] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:373:0)
[17:50:45.411] Timer tick, asking Buildbucket for the build status
[17:50:45.756] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:45.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:374:0) after 1m0s
[17:51:45.876] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:374:0)
[17:51:45.876] Timer tick, asking Buildbucket for the build status
[17:51:46.082] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:46.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:375:0) after 1m0s
[17:52:46.182] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:375:0)
[17:52:46.182] Timer tick, asking Buildbucket for the build status
[17:52:46.278] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:46.278] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:376:0) after 1m0s
[17:53:46.331] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:376:0)
[17:53:46.331] Timer tick, asking Buildbucket for the build status
[17:53:49.103] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:49.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:377:0) after 1m0s
[17:54:49.152] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:377:0)
[17:54:49.152] Timer tick, asking Buildbucket for the build status
[17:54:49.376] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:49.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:378:0) after 1m0s
[17:55:49.434] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:378:0)
[17:55:49.434] Timer tick, asking Buildbucket for the build status
[17:55:49.685] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:49.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:379:0) after 1m0s
[17:56:49.751] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:379:0)
[17:56:49.751] Timer tick, asking Buildbucket for the build status
[17:56:49.895] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:49.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:380:0) after 1m0s
[17:57:49.961] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:380:0)
[17:57:49.961] Timer tick, asking Buildbucket for the build status
[17:57:50.288] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:50.288] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:381:0) after 1m0s
[17:58:50.504] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:381:0)
[17:58:50.504] Timer tick, asking Buildbucket for the build status
[17:58:54.722] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:54.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:382:0) after 1m0s
[17:59:54.952] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:382:0)
[17:59:54.952] Timer tick, asking Buildbucket for the build status
[17:59:55.046] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:55.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:383:0) after 1m0s
[18:00:55.212] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:383:0)
[18:00:55.212] Timer tick, asking Buildbucket for the build status
[18:00:55.518] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:55.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:384:0) after 1m0s
[18:01:55.602] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:384:0)
[18:01:55.602] Timer tick, asking Buildbucket for the build status
[18:01:55.732] Build 8876704271912072272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:55.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9042134334063165936:385:0) after 1m0s
[18:02:31.197] Received PubSub notification, asking Buildbucket for the build status
[18:02:31.284] Build 8876704271912072272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:02:31.284] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "completed_ts": "1592935350047934",
    "created_by": "project:nacl",
    "created_ts": "1592912143751984",
    "id": "8876704271912072272",
    "parameters_json": "{\"builder_name\": \"linux-64-validator-opt\", \"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\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"title\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}}",
    "project": "nacl",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$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\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"title\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-flex-ci-xenial-11-z9v9\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-64-validator-opt\", \"buildnumber\": 146, \"got_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"mastername\": \"client.nacl\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_78893cbd4c292ba203eb7a045a56252df7f14bd0ad3b7b91fac8bfee09f12c2b_v2\", \"builder_a00b1023121ea85e703f19c9cb4a0ba6469d60176e935a395f443f8a2c5759bb_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-flex-ci-xenial-11-z9v9\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.flex.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5218-123b763\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1592912370112675",
    "status": "COMPLETED",
    "status_changed_ts": "1592935350536097",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/146",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9042134334063165936",
      "scheduler_job_id:nacl/linux-64-validator-opt",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8876704271912072272/+/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:4cf9caf6b1684810",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1592935350647597",
    "url": "https://ci.chromium.org/b/8876704271912072272",
    "utcnow_ts": "1592935351273830"
  }
}
[18:02:31.284] Invocation finished in 6h26m48.968039733s with status SUCCEEDED