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

• 4ad2ff292145e8613ec371302875f0eaf8b4fa14 (4 years ago)

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

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

[09:31:33.028] New invocation is queued and will start shortly
[09:31:34.348] Starting the invocation (attempt 1)
[09:31:34.381] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:31:34.381] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:31:34.381] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9020308276320496368",
  "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\":\"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4ad2ff292145e8613ec371302875f0eaf8b4fa14\",\"title\":\"4ad2ff292145e8613ec371302875f0eaf8b4fa14\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-64-validator-opt",
    "scheduler_invocation_id:9020308276320496368",
    "scheduler_job_id:nacl/linux-64-validator-opt",
    "user_agent:luci-scheduler",
    "buildset:commit/git/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
    "gitiles_ref:refs/heads/master"
  ]
}
[09:31:35.623] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1613727094483751",
    "id": "8854878214133640592",
    "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\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"title\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1613727095326108",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/166",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020308276320496368",
      "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/8854878214133640592/+/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": "1613727095326307",
    "url": "https://ci.chromium.org/b/8854878214133640592",
    "utcnow_ts": "1613727095609977"
  }
}
[09:31:35.623] Task URL: https://ci.chromium.org/b/8854878214133640592
[09:31:35.623] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:2:0) after 1m0s
[09:32:36.352] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:2:0)
[09:32:36.352] Timer tick, asking Buildbucket for the build status
[09:32:36.443] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:32:36.443] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:3:0) after 1m0s
[09:33:36.538] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:3:0)
[09:33:36.538] Timer tick, asking Buildbucket for the build status
[09:33:36.634] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:33:36.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:4:0) after 1m0s
[09:34:36.676] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:4:0)
[09:34:36.676] Timer tick, asking Buildbucket for the build status
[09:34:36.742] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:34:36.742] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:5:0) after 1m0s
[09:35:36.926] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:5:0)
[09:35:36.926] Timer tick, asking Buildbucket for the build status
[09:35:36.999] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:36.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:6:0) after 1m0s
[09:36:37.037] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:6:0)
[09:36:37.037] Timer tick, asking Buildbucket for the build status
[09:36:37.133] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:37.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:7:0) after 1m0s
[09:37:37.307] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:7:0)
[09:37:37.307] Timer tick, asking Buildbucket for the build status
[09:37:37.398] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:37.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:8:0) after 1m0s
[09:38:37.444] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:8:0)
[09:38:37.444] Timer tick, asking Buildbucket for the build status
[09:38:37.511] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:37.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:9:0) after 1m0s
[09:39:37.574] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:9:0)
[09:39:37.574] Timer tick, asking Buildbucket for the build status
[09:39:37.649] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:37.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:10:0) after 1m0s
[09:40:37.717] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:10:0)
[09:40:37.717] Timer tick, asking Buildbucket for the build status
[09:40:37.821] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:37.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:11:0) after 1m0s
[09:41:37.896] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:11:0)
[09:41:37.896] Timer tick, asking Buildbucket for the build status
[09:41:37.985] Build 8854878214133640592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:37.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:12:0) after 1m0s
[09:41:38.248] Received PubSub notification, asking Buildbucket for the build status
[09:41:38.323] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:38.074] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:12:0)
[09:42:38.074] Timer tick, asking Buildbucket for the build status
[09:42:38.325] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:38.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:14:0) after 1m0s
[09:43:38.340] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:14:0)
[09:43:38.340] Timer tick, asking Buildbucket for the build status
[09:43:38.458] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:38.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:15:0) after 1m0s
[09:44:38.474] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:15:0)
[09:44:38.474] Timer tick, asking Buildbucket for the build status
[09:44:38.621] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:38.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:16:0) after 1m0s
[09:45:39.393] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:16:0)
[09:45:39.393] Timer tick, asking Buildbucket for the build status
[09:45:39.473] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:39.473] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:17:0) after 1m0s
[09:46:39.779] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:17:0)
[09:46:39.779] Timer tick, asking Buildbucket for the build status
[09:46:39.862] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:39.862] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:18:0) after 1m0s
[09:47:39.976] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:18:0)
[09:47:39.976] Timer tick, asking Buildbucket for the build status
[09:47:40.222] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:40.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:19:0) after 1m0s
[09:48:40.268] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:19:0)
[09:48:40.268] Timer tick, asking Buildbucket for the build status
[09:48:40.354] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:40.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:20:0) after 1m0s
[09:49:40.379] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:20:0)
[09:49:40.379] Timer tick, asking Buildbucket for the build status
[09:49:40.477] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:40.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:21:0) after 1m0s
[09:50:40.619] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:21:0)
[09:50:40.619] Timer tick, asking Buildbucket for the build status
[09:50:41.048] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:41.048] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:22:0) after 1m0s
[09:51:41.138] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:22:0)
[09:51:41.138] Timer tick, asking Buildbucket for the build status
[09:51:41.296] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:41.296] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:23:0) after 1m0s
[09:52:41.382] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:23:0)
[09:52:41.382] Timer tick, asking Buildbucket for the build status
[09:52:41.454] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:41.454] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:24:0) after 1m0s
[09:53:41.431] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:24:0)
[09:53:41.431] Timer tick, asking Buildbucket for the build status
[09:53:41.554] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:41.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:25:0) after 1m0s
[09:54:41.583] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:25:0)
[09:54:41.583] Timer tick, asking Buildbucket for the build status
[09:54:41.746] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:41.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:26:0) after 1m0s
[09:55:41.755] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:26:0)
[09:55:41.755] Timer tick, asking Buildbucket for the build status
[09:55:41.898] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:41.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:27:0) after 1m0s
[09:56:42.811] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:27:0)
[09:56:42.811] Timer tick, asking Buildbucket for the build status
[09:56:42.900] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:42.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:28:0) after 1m0s
[09:57:43.017] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:28:0)
[09:57:43.017] Timer tick, asking Buildbucket for the build status
[09:57:43.105] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:43.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:29:0) after 1m0s
[09:58:43.239] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:29:0)
[09:58:43.239] Timer tick, asking Buildbucket for the build status
[09:58:43.311] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:43.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:30:0) after 1m0s
[09:59:43.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:30:0)
[09:59:43.486] Timer tick, asking Buildbucket for the build status
[09:59:43.569] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:43.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:31:0) after 1m0s
[10:00:43.892] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:31:0)
[10:00:43.892] Timer tick, asking Buildbucket for the build status
[10:00:44.062] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:44.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:32:0) after 1m0s
[10:01:44.244] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:32:0)
[10:01:44.244] Timer tick, asking Buildbucket for the build status
[10:01:44.337] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:44.337] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:33:0) after 1m0s
[10:02:44.649] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:33:0)
[10:02:44.649] Timer tick, asking Buildbucket for the build status
[10:02:44.723] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:44.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:34:0) after 1m0s
[10:03:44.792] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:34:0)
[10:03:44.792] Timer tick, asking Buildbucket for the build status
[10:03:44.921] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:44.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:35:0) after 1m0s
[10:04:45.007] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:35:0)
[10:04:45.007] Timer tick, asking Buildbucket for the build status
[10:04:45.095] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:45.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:36:0) after 1m0s
[10:05:45.256] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:36:0)
[10:05:45.256] Timer tick, asking Buildbucket for the build status
[10:05:45.377] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:45.377] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:37:0) after 1m0s
[10:06:45.722] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:37:0)
[10:06:45.722] Timer tick, asking Buildbucket for the build status
[10:06:45.837] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:45.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:38:0) after 1m0s
[10:07:45.981] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:38:0)
[10:07:45.981] Timer tick, asking Buildbucket for the build status
[10:07:46.397] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:46.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:39:0) after 1m0s
[10:08:46.452] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:39:0)
[10:08:46.452] Timer tick, asking Buildbucket for the build status
[10:08:46.522] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:46.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:40:0) after 1m0s
[10:09:46.758] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:40:0)
[10:09:46.758] Timer tick, asking Buildbucket for the build status
[10:09:47.031] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:47.031] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:41:0) after 1m0s
[10:10:47.017] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:41:0)
[10:10:47.017] Timer tick, asking Buildbucket for the build status
[10:10:48.293] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:48.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:42:0) after 1m0s
[10:11:48.485] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:42:0)
[10:11:48.485] Timer tick, asking Buildbucket for the build status
[10:11:48.583] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:48.583] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:43:0) after 1m0s
[10:12:48.602] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:43:0)
[10:12:48.602] Timer tick, asking Buildbucket for the build status
[10:12:48.679] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:48.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:44:0) after 1m0s
[10:13:48.699] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:44:0)
[10:13:48.699] Timer tick, asking Buildbucket for the build status
[10:13:49.763] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:49.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:45:0) after 1m0s
[10:14:50.333] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:45:0)
[10:14:50.333] Timer tick, asking Buildbucket for the build status
[10:14:50.403] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:50.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:46:0) after 1m0s
[10:15:50.663] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:46:0)
[10:15:50.663] Timer tick, asking Buildbucket for the build status
[10:15:50.752] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:50.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:47:0) after 1m0s
[10:16:50.821] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:47:0)
[10:16:50.821] Timer tick, asking Buildbucket for the build status
[10:16:50.921] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:50.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:48:0) after 1m0s
[10:17:51.193] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:48:0)
[10:17:51.193] Timer tick, asking Buildbucket for the build status
[10:17:51.287] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:51.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:49:0) after 1m0s
[10:18:51.329] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:49:0)
[10:18:51.329] Timer tick, asking Buildbucket for the build status
[10:18:51.414] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:51.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:50:0) after 1m0s
[10:19:51.443] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:50:0)
[10:19:51.443] Timer tick, asking Buildbucket for the build status
[10:19:51.523] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:51.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:51:0) after 1m0s
[10:20:51.543] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:51:0)
[10:20:51.543] Timer tick, asking Buildbucket for the build status
[10:20:51.614] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:51.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:52:0) after 1m0s
[10:21:51.672] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:52:0)
[10:21:51.672] Timer tick, asking Buildbucket for the build status
[10:21:51.774] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:51.774] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:53:0) after 1m0s
[10:22:51.795] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:53:0)
[10:22:51.795] Timer tick, asking Buildbucket for the build status
[10:22:51.915] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:51.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:54:0) after 1m0s
[10:23:51.949] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:54:0)
[10:23:51.950] Timer tick, asking Buildbucket for the build status
[10:23:52.164] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:52.164] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:55:0) after 1m0s
[10:24:52.146] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:55:0)
[10:24:52.146] Timer tick, asking Buildbucket for the build status
[10:24:52.216] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:52.216] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:56:0) after 1m0s
[10:25:52.231] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:56:0)
[10:25:52.231] Timer tick, asking Buildbucket for the build status
[10:25:52.302] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:52.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:57:0) after 1m0s
[10:26:52.359] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:57:0)
[10:26:52.359] Timer tick, asking Buildbucket for the build status
[10:26:52.901] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:52.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:58:0) after 1m0s
[10:27:52.927] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:58:0)
[10:27:52.927] Timer tick, asking Buildbucket for the build status
[10:27:53.150] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:53.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:59:0) after 1m0s
[10:28:53.130] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:59:0)
[10:28:53.130] Timer tick, asking Buildbucket for the build status
[10:28:53.243] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:53.243] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:60:0) after 1m0s
[10:29:53.268] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:60:0)
[10:29:53.268] Timer tick, asking Buildbucket for the build status
[10:29:53.334] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:53.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:61:0) after 1m0s
[10:30:53.358] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:61:0)
[10:30:53.358] Timer tick, asking Buildbucket for the build status
[10:30:53.441] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:53.441] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:62:0) after 1m0s
[10:31:53.468] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:62:0)
[10:31:53.468] Timer tick, asking Buildbucket for the build status
[10:31:53.588] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:53.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:63:0) after 1m0s
[10:32:53.603] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:63:0)
[10:32:53.603] Timer tick, asking Buildbucket for the build status
[10:32:53.915] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:53.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:64:0) after 1m0s
[10:33:53.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:64:0)
[10:33:53.934] Timer tick, asking Buildbucket for the build status
[10:33:54.004] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:54.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:65:0) after 1m0s
[10:34:54.054] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:65:0)
[10:34:54.054] Timer tick, asking Buildbucket for the build status
[10:34:54.134] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:54.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:66:0) after 1m0s
[10:35:54.185] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:66:0)
[10:35:54.185] Timer tick, asking Buildbucket for the build status
[10:35:54.656] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:54.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:67:0) after 1m0s
[10:36:54.720] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:67:0)
[10:36:54.720] Timer tick, asking Buildbucket for the build status
[10:36:54.921] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:54.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:68:0) after 1m0s
[10:37:54.954] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:68:0)
[10:37:54.954] Timer tick, asking Buildbucket for the build status
[10:37:55.023] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:55.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:69:0) after 1m0s
[10:38:55.019] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:69:0)
[10:38:55.019] Timer tick, asking Buildbucket for the build status
[10:38:55.084] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:55.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:70:0) after 1m0s
[10:39:55.105] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:70:0)
[10:39:55.105] Timer tick, asking Buildbucket for the build status
[10:39:55.179] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:55.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:71:0) after 1m0s
[10:40:55.203] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:71:0)
[10:40:55.203] Timer tick, asking Buildbucket for the build status
[10:40:55.318] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:55.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:72:0) after 1m0s
[10:41:55.311] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:72:0)
[10:41:55.311] Timer tick, asking Buildbucket for the build status
[10:41:58.203] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:58.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:73:0) after 1m0s
[10:42:58.256] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:73:0)
[10:42:58.256] Timer tick, asking Buildbucket for the build status
[10:42:58.375] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:58.375] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:74:0) after 1m0s
[10:43:58.400] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:74:0)
[10:43:58.400] Timer tick, asking Buildbucket for the build status
[10:43:58.737] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:58.738] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:75:0) after 1m0s
[10:44:58.795] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:75:0)
[10:44:58.795] Timer tick, asking Buildbucket for the build status
[10:44:58.874] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:58.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:76:0) after 1m0s
[10:45:58.901] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:76:0)
[10:45:58.901] Timer tick, asking Buildbucket for the build status
[10:45:58.981] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:58.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:77:0) after 1m0s
[10:46:59.066] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:77:0)
[10:46:59.066] Timer tick, asking Buildbucket for the build status
[10:46:59.333] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:59.333] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:78:0) after 1m0s
[10:47:59.379] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:78:0)
[10:47:59.379] Timer tick, asking Buildbucket for the build status
[10:47:59.462] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:59.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:79:0) after 1m0s
[10:48:59.504] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:79:0)
[10:48:59.504] Timer tick, asking Buildbucket for the build status
[10:48:59.910] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:59.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:80:0) after 1m0s
[10:49:59.990] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:80:0)
[10:49:59.990] Timer tick, asking Buildbucket for the build status
[10:50:00.203] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:00.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:81:0) after 1m0s
[10:51:00.384] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:81:0)
[10:51:00.384] Timer tick, asking Buildbucket for the build status
[10:51:00.514] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:00.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:82:0) after 1m0s
[10:52:00.582] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:82:0)
[10:52:00.582] Timer tick, asking Buildbucket for the build status
[10:52:00.739] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:00.739] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:83:0) after 1m0s
[10:53:02.346] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:83:0)
[10:53:02.346] Timer tick, asking Buildbucket for the build status
[10:53:02.484] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:02.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:84:0) after 1m0s
[10:54:02.872] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:84:0)
[10:54:02.872] Timer tick, asking Buildbucket for the build status
[10:54:03.496] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:03.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:85:0) after 1m0s
[10:55:03.558] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:85:0)
[10:55:03.558] Timer tick, asking Buildbucket for the build status
[10:55:04.001] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:04.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:86:0) after 1m0s
[10:56:04.021] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:86:0)
[10:56:04.021] Timer tick, asking Buildbucket for the build status
[10:56:04.509] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:04.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:87:0) after 1m0s
[10:57:04.525] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:87:0)
[10:57:04.525] Timer tick, asking Buildbucket for the build status
[10:57:04.612] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:04.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:88:0) after 1m0s
[10:58:04.632] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:88:0)
[10:58:04.632] Timer tick, asking Buildbucket for the build status
[10:58:04.711] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:04.711] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:89:0) after 1m0s
[10:59:04.743] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:89:0)
[10:59:04.743] Timer tick, asking Buildbucket for the build status
[10:59:04.844] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:04.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:90:0) after 1m0s
[11:00:04.877] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:90:0)
[11:00:04.877] Timer tick, asking Buildbucket for the build status
[11:00:04.951] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:04.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:91:0) after 1m0s
[11:01:05.004] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:91:0)
[11:01:05.004] Timer tick, asking Buildbucket for the build status
[11:01:05.323] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:05.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:92:0) after 1m0s
[11:02:05.345] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:92:0)
[11:02:05.345] Timer tick, asking Buildbucket for the build status
[11:02:05.935] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:05.935] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:93:0) after 1m0s
[11:03:05.977] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:93:0)
[11:03:05.977] Timer tick, asking Buildbucket for the build status
[11:03:06.398] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:06.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:94:0) after 1m0s
[11:04:06.465] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:94:0)
[11:04:06.465] Timer tick, asking Buildbucket for the build status
[11:04:06.823] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:06.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:95:0) after 1m0s
[11:05:06.893] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:95:0)
[11:05:06.893] Timer tick, asking Buildbucket for the build status
[11:05:06.972] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:06.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:96:0) after 1m0s
[11:06:06.952] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:96:0)
[11:06:06.952] Timer tick, asking Buildbucket for the build status
[11:06:07.280] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:07.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:97:0) after 1m0s
[11:07:07.307] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:97:0)
[11:07:07.307] Timer tick, asking Buildbucket for the build status
[11:07:07.460] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:07.460] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:98:0) after 1m0s
[11:08:07.597] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:98:0)
[11:08:07.597] Timer tick, asking Buildbucket for the build status
[11:08:07.670] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:07.670] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:99:0) after 1m0s
[11:09:07.718] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:99:0)
[11:09:07.718] Timer tick, asking Buildbucket for the build status
[11:09:07.820] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:07.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:100:0) after 1m0s
[11:10:07.827] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:100:0)
[11:10:07.827] Timer tick, asking Buildbucket for the build status
[11:10:07.923] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:07.923] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:101:0) after 1m0s
[11:11:08.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:101:0)
[11:11:08.008] Timer tick, asking Buildbucket for the build status
[11:11:08.081] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:08.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:102:0) after 1m0s
[11:12:08.118] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:102:0)
[11:12:08.118] Timer tick, asking Buildbucket for the build status
[11:12:08.246] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:08.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:103:0) after 1m0s
[11:13:08.398] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:103:0)
[11:13:08.398] Timer tick, asking Buildbucket for the build status
[11:13:08.481] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:08.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:104:0) after 1m0s
[11:14:08.546] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:104:0)
[11:14:08.546] Timer tick, asking Buildbucket for the build status
[11:14:08.792] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:08.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:105:0) after 1m0s
[11:15:08.853] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:105:0)
[11:15:08.853] Timer tick, asking Buildbucket for the build status
[11:15:08.952] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:08.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:106:0) after 1m0s
[11:16:09.019] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:106:0)
[11:16:09.019] Timer tick, asking Buildbucket for the build status
[11:16:09.119] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:09.119] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:107:0) after 1m0s
[11:17:09.188] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:107:0)
[11:17:09.188] Timer tick, asking Buildbucket for the build status
[11:17:09.277] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:09.277] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:108:0) after 1m0s
[11:18:09.341] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:108:0)
[11:18:09.341] Timer tick, asking Buildbucket for the build status
[11:18:09.431] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:09.431] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:109:0) after 1m0s
[11:19:09.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:109:0)
[11:19:09.486] Timer tick, asking Buildbucket for the build status
[11:19:09.581] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:09.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:110:0) after 1m0s
[11:20:09.644] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:110:0)
[11:20:09.644] Timer tick, asking Buildbucket for the build status
[11:20:09.719] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:09.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:111:0) after 1m0s
[11:21:09.855] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:111:0)
[11:21:09.855] Timer tick, asking Buildbucket for the build status
[11:21:09.951] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:09.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:112:0) after 1m0s
[11:22:10.388] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:112:0)
[11:22:10.388] Timer tick, asking Buildbucket for the build status
[11:22:10.481] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:10.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:113:0) after 1m0s
[11:23:10.708] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:113:0)
[11:23:10.708] Timer tick, asking Buildbucket for the build status
[11:23:11.050] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:11.050] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:114:0) after 1m0s
[11:24:11.102] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:114:0)
[11:24:11.102] Timer tick, asking Buildbucket for the build status
[11:24:11.548] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:11.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:115:0) after 1m0s
[11:25:11.583] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:115:0)
[11:25:11.583] Timer tick, asking Buildbucket for the build status
[11:25:11.910] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:11.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:116:0) after 1m0s
[11:26:12.161] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:116:0)
[11:26:12.161] Timer tick, asking Buildbucket for the build status
[11:26:12.250] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:12.250] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:117:0) after 1m0s
[11:27:12.271] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:117:0)
[11:27:12.271] Timer tick, asking Buildbucket for the build status
[11:27:12.397] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:12.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:118:0) after 1m0s
[11:28:12.498] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:118:0)
[11:28:12.498] Timer tick, asking Buildbucket for the build status
[11:28:12.583] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:12.583] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:119:0) after 1m0s
[11:29:12.687] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:119:0)
[11:29:12.687] Timer tick, asking Buildbucket for the build status
[11:29:12.770] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:12.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:120:0) after 1m0s
[11:30:12.829] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:120:0)
[11:30:12.829] Timer tick, asking Buildbucket for the build status
[11:30:12.918] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:12.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:121:0) after 1m0s
[11:31:14.023] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:121:0)
[11:31:14.023] Timer tick, asking Buildbucket for the build status
[11:31:14.155] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:14.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:122:0) after 1m0s
[11:32:14.614] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:122:0)
[11:32:14.614] Timer tick, asking Buildbucket for the build status
[11:32:14.711] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:14.711] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:123:0) after 1m0s
[11:33:15.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:123:0)
[11:33:15.009] Timer tick, asking Buildbucket for the build status
[11:33:15.403] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:15.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:124:0) after 1m0s
[11:34:15.525] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:124:0)
[11:34:15.525] Timer tick, asking Buildbucket for the build status
[11:34:15.605] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:15.605] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:125:0) after 1m0s
[11:35:15.648] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:125:0)
[11:35:15.648] Timer tick, asking Buildbucket for the build status
[11:35:15.720] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:15.720] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:126:0) after 1m0s
[11:36:16.078] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:126:0)
[11:36:16.078] Timer tick, asking Buildbucket for the build status
[11:36:16.160] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:16.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:127:0) after 1m0s
[11:37:16.305] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:127:0)
[11:37:16.305] Timer tick, asking Buildbucket for the build status
[11:37:16.620] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:16.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:128:0) after 1m0s
[11:38:16.831] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:128:0)
[11:38:16.831] Timer tick, asking Buildbucket for the build status
[11:38:16.911] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:16.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:129:0) after 1m0s
[11:39:17.148] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:129:0)
[11:39:17.148] Timer tick, asking Buildbucket for the build status
[11:39:17.239] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:17.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:130:0) after 1m0s
[11:40:17.403] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:130:0)
[11:40:17.403] Timer tick, asking Buildbucket for the build status
[11:40:17.477] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:17.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:131:0) after 1m0s
[11:41:17.608] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:131:0)
[11:41:17.608] Timer tick, asking Buildbucket for the build status
[11:41:18.168] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:18.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:132:0) after 1m0s
[11:42:18.226] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:132:0)
[11:42:18.226] Timer tick, asking Buildbucket for the build status
[11:42:18.328] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:18.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:133:0) after 1m0s
[11:43:18.389] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:133:0)
[11:43:18.389] Timer tick, asking Buildbucket for the build status
[11:43:18.470] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:18.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:134:0) after 1m0s
[11:44:18.668] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:134:0)
[11:44:18.668] Timer tick, asking Buildbucket for the build status
[11:44:18.767] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:18.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:135:0) after 1m0s
[11:45:18.999] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:135:0)
[11:45:18.999] Timer tick, asking Buildbucket for the build status
[11:45:19.117] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:19.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:136:0) after 1m0s
[11:46:19.867] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:136:0)
[11:46:19.867] Timer tick, asking Buildbucket for the build status
[11:46:19.950] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:19.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:137:0) after 1m0s
[11:47:20.041] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:137:0)
[11:47:20.041] Timer tick, asking Buildbucket for the build status
[11:47:20.159] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:20.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:138:0) after 1m0s
[11:48:20.187] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:138:0)
[11:48:20.187] Timer tick, asking Buildbucket for the build status
[11:48:20.262] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:20.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:139:0) after 1m0s
[11:49:20.282] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:139:0)
[11:49:20.282] Timer tick, asking Buildbucket for the build status
[11:49:20.356] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:20.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:140:0) after 1m0s
[11:50:20.378] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:140:0)
[11:50:20.378] Timer tick, asking Buildbucket for the build status
[11:50:21.290] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:21.290] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:141:0) after 1m0s
[11:51:21.313] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:141:0)
[11:51:21.313] Timer tick, asking Buildbucket for the build status
[11:51:21.515] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:21.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:142:0) after 1m0s
[11:52:21.538] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:142:0)
[11:52:21.538] Timer tick, asking Buildbucket for the build status
[11:52:21.628] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:21.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:143:0) after 1m0s
[11:53:21.699] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:143:0)
[11:53:21.699] Timer tick, asking Buildbucket for the build status
[11:53:21.770] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:21.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:144:0) after 1m0s
[11:54:21.812] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:144:0)
[11:54:21.812] Timer tick, asking Buildbucket for the build status
[11:54:21.936] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:21.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:145:0) after 1m0s
[11:55:21.963] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:145:0)
[11:55:21.963] Timer tick, asking Buildbucket for the build status
[11:55:22.041] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:22.041] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:146:0) after 1m0s
[11:56:22.128] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:146:0)
[11:56:22.128] Timer tick, asking Buildbucket for the build status
[11:56:22.483] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:22.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:147:0) after 1m0s
[11:57:22.531] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:147:0)
[11:57:22.531] Timer tick, asking Buildbucket for the build status
[11:57:22.651] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:22.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:148:0) after 1m0s
[11:58:22.735] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:148:0)
[11:58:22.735] Timer tick, asking Buildbucket for the build status
[11:58:22.842] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:22.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:149:0) after 1m0s
[11:59:23.027] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:149:0)
[11:59:23.027] Timer tick, asking Buildbucket for the build status
[11:59:23.101] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:23.101] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:150:0) after 1m0s
[12:00:23.097] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:150:0)
[12:00:23.097] Timer tick, asking Buildbucket for the build status
[12:00:23.190] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:23.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:151:0) after 1m0s
[12:01:23.187] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:151:0)
[12:01:23.187] Timer tick, asking Buildbucket for the build status
[12:01:23.758] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:23.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:152:0) after 1m0s
[12:02:23.775] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:152:0)
[12:02:23.775] Timer tick, asking Buildbucket for the build status
[12:02:23.883] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:23.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:153:0) after 1m0s
[12:03:23.908] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:153:0)
[12:03:23.908] Timer tick, asking Buildbucket for the build status
[12:03:24.131] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:24.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:154:0) after 1m0s
[12:04:24.141] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:154:0)
[12:04:24.141] Timer tick, asking Buildbucket for the build status
[12:04:24.223] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:24.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:155:0) after 1m0s
[12:05:24.250] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:155:0)
[12:05:24.250] Timer tick, asking Buildbucket for the build status
[12:05:24.334] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:24.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:156:0) after 1m0s
[12:06:24.345] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:156:0)
[12:06:24.345] Timer tick, asking Buildbucket for the build status
[12:06:24.482] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:24.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:157:0) after 1m0s
[12:07:24.581] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:157:0)
[12:07:24.581] Timer tick, asking Buildbucket for the build status
[12:07:24.797] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:24.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:158:0) after 1m0s
[12:08:24.938] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:158:0)
[12:08:24.938] Timer tick, asking Buildbucket for the build status
[12:08:25.047] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:25.047] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:159:0) after 1m0s
[12:09:25.098] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:159:0)
[12:09:25.098] Timer tick, asking Buildbucket for the build status
[12:09:25.304] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:25.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:160:0) after 1m0s
[12:10:25.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:160:0)
[12:10:25.360] Timer tick, asking Buildbucket for the build status
[12:10:25.492] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:25.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:161:0) after 1m0s
[12:11:25.894] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:161:0)
[12:11:25.894] Timer tick, asking Buildbucket for the build status
[12:11:25.995] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:25.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:162:0) after 1m0s
[12:12:26.115] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:162:0)
[12:12:26.115] Timer tick, asking Buildbucket for the build status
[12:12:26.428] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:26.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:163:0) after 1m0s
[12:13:26.504] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:163:0)
[12:13:26.504] Timer tick, asking Buildbucket for the build status
[12:13:26.583] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:26.583] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:164:0) after 1m0s
[12:14:26.803] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:164:0)
[12:14:26.803] Timer tick, asking Buildbucket for the build status
[12:14:26.888] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:26.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:165:0) after 1m0s
[12:15:26.962] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:165:0)
[12:15:26.962] Timer tick, asking Buildbucket for the build status
[12:15:27.037] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:27.037] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:166:0) after 1m0s
[12:16:27.093] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:166:0)
[12:16:27.093] Timer tick, asking Buildbucket for the build status
[12:16:27.706] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:27.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:167:0) after 1m0s
[12:17:27.762] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:167:0)
[12:17:27.762] Timer tick, asking Buildbucket for the build status
[12:17:27.857] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:27.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:168:0) after 1m0s
[12:18:27.883] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:168:0)
[12:18:27.883] Timer tick, asking Buildbucket for the build status
[12:18:27.956] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:27.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:169:0) after 1m0s
[12:19:27.979] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:169:0)
[12:19:27.979] Timer tick, asking Buildbucket for the build status
[12:19:28.062] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:28.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:170:0) after 1m0s
[12:20:28.141] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:170:0)
[12:20:28.141] Timer tick, asking Buildbucket for the build status
[12:20:28.236] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:28.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:171:0) after 1m0s
[12:21:28.381] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:171:0)
[12:21:28.381] Timer tick, asking Buildbucket for the build status
[12:21:28.509] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:28.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:172:0) after 1m0s
[12:22:28.889] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:172:0)
[12:22:28.889] Timer tick, asking Buildbucket for the build status
[12:22:29.044] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:29.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:173:0) after 1m0s
[12:23:29.070] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:173:0)
[12:23:29.070] Timer tick, asking Buildbucket for the build status
[12:23:29.447] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:29.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:174:0) after 1m0s
[12:24:29.496] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:174:0)
[12:24:29.496] Timer tick, asking Buildbucket for the build status
[12:24:29.958] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:29.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:175:0) after 1m0s
[12:25:29.997] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:175:0)
[12:25:29.997] Timer tick, asking Buildbucket for the build status
[12:25:30.088] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:30.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:176:0) after 1m0s
[12:26:30.303] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:176:0)
[12:26:30.303] Timer tick, asking Buildbucket for the build status
[12:26:30.411] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:30.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:177:0) after 1m0s
[12:27:30.469] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:177:0)
[12:27:30.469] Timer tick, asking Buildbucket for the build status
[12:27:30.641] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:30.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:178:0) after 1m0s
[12:28:30.680] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:178:0)
[12:28:30.680] Timer tick, asking Buildbucket for the build status
[12:28:30.758] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:30.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:179:0) after 1m0s
[12:29:30.853] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:179:0)
[12:29:30.853] Timer tick, asking Buildbucket for the build status
[12:29:31.295] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:31.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:180:0) after 1m0s
[12:30:31.296] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:180:0)
[12:30:31.296] Timer tick, asking Buildbucket for the build status
[12:30:31.380] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:31.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:181:0) after 1m0s
[12:31:31.398] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:181:0)
[12:31:31.399] Timer tick, asking Buildbucket for the build status
[12:31:31.486] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:31.486] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:182:0) after 1m0s
[12:32:31.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:182:0)
[12:32:31.517] Timer tick, asking Buildbucket for the build status
[12:32:31.619] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:31.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:183:0) after 1m0s
[12:33:31.643] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:183:0)
[12:33:31.643] Timer tick, asking Buildbucket for the build status
[12:33:31.718] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:31.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:184:0) after 1m0s
[12:34:31.778] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:184:0)
[12:34:31.778] Timer tick, asking Buildbucket for the build status
[12:34:31.845] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:31.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:185:0) after 1m0s
[12:35:32.755] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:185:0)
[12:35:32.755] Timer tick, asking Buildbucket for the build status
[12:35:32.888] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:32.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:186:0) after 1m0s
[12:36:33.106] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:186:0)
[12:36:33.106] Timer tick, asking Buildbucket for the build status
[12:36:33.257] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:33.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:187:0) after 1m0s
[12:37:33.714] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:187:0)
[12:37:33.714] Timer tick, asking Buildbucket for the build status
[12:37:33.796] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:33.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:188:0) after 1m0s
[12:38:33.922] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:188:0)
[12:38:33.922] Timer tick, asking Buildbucket for the build status
[12:38:33.994] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:33.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:189:0) after 1m0s
[12:39:34.014] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:189:0)
[12:39:34.014] Timer tick, asking Buildbucket for the build status
[12:39:34.103] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:34.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:190:0) after 1m0s
[12:40:34.194] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:190:0)
[12:40:34.195] Timer tick, asking Buildbucket for the build status
[12:40:34.409] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:34.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:191:0) after 1m0s
[12:41:34.452] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:191:0)
[12:41:34.452] Timer tick, asking Buildbucket for the build status
[12:41:34.693] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:34.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:192:0) after 1m0s
[12:42:34.721] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:192:0)
[12:42:34.721] Timer tick, asking Buildbucket for the build status
[12:42:34.916] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:34.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:193:0) after 1m0s
[12:43:35.102] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:193:0)
[12:43:35.102] Timer tick, asking Buildbucket for the build status
[12:43:35.188] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:35.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:194:0) after 1m0s
[12:44:35.415] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:194:0)
[12:44:35.415] Timer tick, asking Buildbucket for the build status
[12:44:35.483] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:35.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:195:0) after 1m0s
[12:45:35.503] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:195:0)
[12:45:35.503] Timer tick, asking Buildbucket for the build status
[12:45:35.812] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:35.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:196:0) after 1m0s
[12:46:35.839] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:196:0)
[12:46:35.839] Timer tick, asking Buildbucket for the build status
[12:46:35.922] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:35.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:197:0) after 1m0s
[12:47:35.999] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:197:0)
[12:47:36.000] Timer tick, asking Buildbucket for the build status
[12:47:36.094] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:36.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:198:0) after 1m0s
[12:48:36.159] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:198:0)
[12:48:36.159] Timer tick, asking Buildbucket for the build status
[12:48:36.239] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:36.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:199:0) after 1m0s
[12:49:36.280] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:199:0)
[12:49:36.280] Timer tick, asking Buildbucket for the build status
[12:49:36.684] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:36.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:200:0) after 1m0s
[12:50:36.722] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:200:0)
[12:50:36.722] Timer tick, asking Buildbucket for the build status
[12:50:36.827] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:36.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:201:0) after 1m0s
[12:51:36.954] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:201:0)
[12:51:36.954] Timer tick, asking Buildbucket for the build status
[12:51:37.073] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:37.073] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:202:0) after 1m0s
[12:52:37.128] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:202:0)
[12:52:37.128] Timer tick, asking Buildbucket for the build status
[12:52:37.218] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:37.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:203:0) after 1m0s
[12:53:37.228] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:203:0)
[12:53:37.228] Timer tick, asking Buildbucket for the build status
[12:53:37.527] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:37.527] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:204:0) after 1m0s
[12:54:37.643] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:204:0)
[12:54:37.643] Timer tick, asking Buildbucket for the build status
[12:54:37.727] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:37.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:205:0) after 1m0s
[12:55:37.869] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:205:0)
[12:55:37.869] Timer tick, asking Buildbucket for the build status
[12:55:38.005] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:38.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:206:0) after 1m0s
[12:56:38.054] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:206:0)
[12:56:38.054] Timer tick, asking Buildbucket for the build status
[12:56:38.145] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:38.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:207:0) after 1m0s
[12:57:38.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:207:0)
[12:57:38.272] Timer tick, asking Buildbucket for the build status
[12:57:38.589] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:38.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:208:0) after 1m0s
[12:58:38.637] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:208:0)
[12:58:38.637] Timer tick, asking Buildbucket for the build status
[12:58:38.706] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:38.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:209:0) after 1m0s
[12:59:38.802] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:209:0)
[12:59:38.802] Timer tick, asking Buildbucket for the build status
[12:59:38.880] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:38.880] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:210:0) after 1m0s
[13:00:38.931] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:210:0)
[13:00:38.932] Timer tick, asking Buildbucket for the build status
[13:00:39.622] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:39.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:211:0) after 1m0s
[13:01:39.665] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:211:0)
[13:01:39.665] Timer tick, asking Buildbucket for the build status
[13:01:39.767] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:39.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:212:0) after 1m0s
[13:02:39.764] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:212:0)
[13:02:39.764] Timer tick, asking Buildbucket for the build status
[13:02:39.900] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:39.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:213:0) after 1m0s
[13:03:40.083] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:213:0)
[13:03:40.083] Timer tick, asking Buildbucket for the build status
[13:03:40.177] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:40.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:214:0) after 1m0s
[13:04:40.253] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:214:0)
[13:04:40.253] Timer tick, asking Buildbucket for the build status
[13:04:40.362] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:40.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:215:0) after 1m0s
[13:05:40.533] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:215:0)
[13:05:40.533] Timer tick, asking Buildbucket for the build status
[13:05:40.650] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:40.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:216:0) after 1m0s
[13:06:40.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:216:0)
[13:06:40.788] Timer tick, asking Buildbucket for the build status
[13:06:40.926] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:40.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:217:0) after 1m0s
[13:07:41.059] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:217:0)
[13:07:41.059] Timer tick, asking Buildbucket for the build status
[13:07:41.162] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:41.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:218:0) after 1m0s
[13:08:41.234] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:218:0)
[13:08:41.234] Timer tick, asking Buildbucket for the build status
[13:08:41.438] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:41.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:219:0) after 1m0s
[13:09:41.511] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:219:0)
[13:09:41.511] Timer tick, asking Buildbucket for the build status
[13:09:41.890] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:41.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:220:0) after 1m0s
[13:10:41.986] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:220:0)
[13:10:41.986] Timer tick, asking Buildbucket for the build status
[13:10:42.104] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:42.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:221:0) after 1m0s
[13:11:42.214] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:221:0)
[13:11:42.214] Timer tick, asking Buildbucket for the build status
[13:11:42.284] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:42.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:222:0) after 1m0s
[13:12:42.348] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:222:0)
[13:12:42.348] Timer tick, asking Buildbucket for the build status
[13:12:42.438] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:42.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:223:0) after 1m0s
[13:13:42.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:223:0)
[13:13:42.494] Timer tick, asking Buildbucket for the build status
[13:13:42.728] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:42.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:224:0) after 1m0s
[13:14:43.183] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:224:0)
[13:14:43.183] Timer tick, asking Buildbucket for the build status
[13:14:43.265] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:43.265] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:225:0) after 1m0s
[13:15:43.455] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:225:0)
[13:15:43.455] Timer tick, asking Buildbucket for the build status
[13:15:43.699] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:43.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:226:0) after 1m0s
[13:16:43.854] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:226:0)
[13:16:43.854] Timer tick, asking Buildbucket for the build status
[13:16:44.135] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:44.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:227:0) after 1m0s
[13:17:44.263] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:227:0)
[13:17:44.263] Timer tick, asking Buildbucket for the build status
[13:17:44.363] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:44.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:228:0) after 1m0s
[13:18:44.398] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:228:0)
[13:18:44.398] Timer tick, asking Buildbucket for the build status
[13:18:44.675] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:44.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:229:0) after 1m0s
[13:19:44.748] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:229:0)
[13:19:44.748] Timer tick, asking Buildbucket for the build status
[13:19:44.840] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:44.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:230:0) after 1m0s
[13:20:45.001] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:230:0)
[13:20:45.001] Timer tick, asking Buildbucket for the build status
[13:20:45.323] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:45.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:231:0) after 1m0s
[13:21:45.315] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:231:0)
[13:21:45.315] Timer tick, asking Buildbucket for the build status
[13:21:45.397] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:45.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:232:0) after 1m0s
[13:22:45.455] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:232:0)
[13:22:45.455] Timer tick, asking Buildbucket for the build status
[13:22:45.536] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:45.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:233:0) after 1m0s
[13:23:45.587] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:233:0)
[13:23:45.587] Timer tick, asking Buildbucket for the build status
[13:23:45.665] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:45.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:234:0) after 1m0s
[13:24:45.692] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:234:0)
[13:24:45.692] Timer tick, asking Buildbucket for the build status
[13:24:45.910] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:45.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:235:0) after 1m0s
[13:25:45.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:235:0)
[13:25:45.934] Timer tick, asking Buildbucket for the build status
[13:25:46.055] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:46.055] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:236:0) after 1m0s
[13:26:46.117] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:236:0)
[13:26:46.117] Timer tick, asking Buildbucket for the build status
[13:26:46.280] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:46.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:237:0) after 1m0s
[13:27:46.332] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:237:0)
[13:27:46.332] Timer tick, asking Buildbucket for the build status
[13:27:46.418] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:46.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:238:0) after 1m0s
[13:28:46.447] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:238:0)
[13:28:46.447] Timer tick, asking Buildbucket for the build status
[13:28:46.518] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:46.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:239:0) after 1m0s
[13:29:46.508] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:239:0)
[13:29:46.508] Timer tick, asking Buildbucket for the build status
[13:29:46.616] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:46.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:240:0) after 1m0s
[13:30:46.645] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:240:0)
[13:30:46.645] Timer tick, asking Buildbucket for the build status
[13:30:46.727] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:46.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:241:0) after 1m0s
[13:31:46.755] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:241:0)
[13:31:46.755] Timer tick, asking Buildbucket for the build status
[13:31:46.971] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:46.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:242:0) after 1m0s
[13:32:46.986] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:242:0)
[13:32:46.986] Timer tick, asking Buildbucket for the build status
[13:32:47.083] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:47.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:243:0) after 1m0s
[13:33:47.110] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:243:0)
[13:33:47.110] Timer tick, asking Buildbucket for the build status
[13:33:47.191] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:47.191] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:244:0) after 1m0s
[13:34:47.292] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:244:0)
[13:34:47.292] Timer tick, asking Buildbucket for the build status
[13:34:47.372] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:47.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:245:0) after 1m0s
[13:35:47.406] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:245:0)
[13:35:47.406] Timer tick, asking Buildbucket for the build status
[13:35:47.490] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:47.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:246:0) after 1m0s
[13:36:47.563] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:246:0)
[13:36:47.563] Timer tick, asking Buildbucket for the build status
[13:36:47.665] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:47.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:247:0) after 1m0s
[13:37:47.688] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:247:0)
[13:37:47.688] Timer tick, asking Buildbucket for the build status
[13:37:47.791] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:47.791] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:248:0) after 1m0s
[13:38:47.784] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:248:0)
[13:38:47.784] Timer tick, asking Buildbucket for the build status
[13:38:48.001] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:48.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:249:0) after 1m0s
[13:39:48.011] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:249:0)
[13:39:48.011] Timer tick, asking Buildbucket for the build status
[13:39:48.091] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:48.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:250:0) after 1m0s
[13:40:48.120] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:250:0)
[13:40:48.120] Timer tick, asking Buildbucket for the build status
[13:40:48.196] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:48.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:251:0) after 1m0s
[13:41:48.312] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:251:0)
[13:41:48.312] Timer tick, asking Buildbucket for the build status
[13:41:48.399] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:48.399] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:252:0) after 1m0s
[13:42:48.416] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:252:0)
[13:42:48.416] Timer tick, asking Buildbucket for the build status
[13:42:48.560] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:48.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:253:0) after 1m0s
[13:43:48.592] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:253:0)
[13:43:48.592] Timer tick, asking Buildbucket for the build status
[13:43:48.676] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:48.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:254:0) after 1m0s
[13:44:48.731] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:254:0)
[13:44:48.731] Timer tick, asking Buildbucket for the build status
[13:44:48.832] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:48.832] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:255:0) after 1m0s
[13:45:48.862] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:255:0)
[13:45:48.862] Timer tick, asking Buildbucket for the build status
[13:45:48.957] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:48.957] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:256:0) after 1m0s
[13:46:48.992] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:256:0)
[13:46:48.992] Timer tick, asking Buildbucket for the build status
[13:46:49.074] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:49.074] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:257:0) after 1m0s
[13:47:49.150] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:257:0)
[13:47:49.150] Timer tick, asking Buildbucket for the build status
[13:47:49.255] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:49.255] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:258:0) after 1m0s
[13:48:49.255] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:258:0)
[13:48:49.255] Timer tick, asking Buildbucket for the build status
[13:48:49.329] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:49.329] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:259:0) after 1m0s
[13:49:49.439] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:259:0)
[13:49:49.439] Timer tick, asking Buildbucket for the build status
[13:49:49.512] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:49.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:260:0) after 1m0s
[13:50:49.521] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:260:0)
[13:50:49.521] Timer tick, asking Buildbucket for the build status
[13:50:49.600] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:49.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:261:0) after 1m0s
[13:51:49.655] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:261:0)
[13:51:49.655] Timer tick, asking Buildbucket for the build status
[13:51:49.732] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:49.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:262:0) after 1m0s
[13:52:49.777] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:262:0)
[13:52:49.777] Timer tick, asking Buildbucket for the build status
[13:52:49.886] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:49.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:263:0) after 1m0s
[13:53:49.892] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:263:0)
[13:53:49.892] Timer tick, asking Buildbucket for the build status
[13:53:49.972] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:49.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:264:0) after 1m0s
[13:54:49.998] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:264:0)
[13:54:49.998] Timer tick, asking Buildbucket for the build status
[13:54:50.086] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:50.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:265:0) after 1m0s
[13:55:50.132] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:265:0)
[13:55:50.132] Timer tick, asking Buildbucket for the build status
[13:55:50.216] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:50.216] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:266:0) after 1m0s
[13:56:50.296] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:266:0)
[13:56:50.296] Timer tick, asking Buildbucket for the build status
[13:56:50.449] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:50.449] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:267:0) after 1m0s
[13:57:50.472] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:267:0)
[13:57:50.472] Timer tick, asking Buildbucket for the build status
[13:57:50.574] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:50.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:268:0) after 1m0s
[13:58:50.704] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:268:0)
[13:58:50.704] Timer tick, asking Buildbucket for the build status
[13:58:50.799] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:50.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:269:0) after 1m0s
[13:59:50.829] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:269:0)
[13:59:50.829] Timer tick, asking Buildbucket for the build status
[13:59:50.908] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:50.908] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:270:0) after 1m0s
[14:00:51.101] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:270:0)
[14:00:51.102] Timer tick, asking Buildbucket for the build status
[14:00:51.235] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:51.235] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:271:0) after 1m0s
[14:01:51.423] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:271:0)
[14:01:51.423] Timer tick, asking Buildbucket for the build status
[14:01:51.509] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:51.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:272:0) after 1m0s
[14:02:51.549] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:272:0)
[14:02:51.549] Timer tick, asking Buildbucket for the build status
[14:02:51.658] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:51.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:273:0) after 1m0s
[14:03:51.839] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:273:0)
[14:03:51.839] Timer tick, asking Buildbucket for the build status
[14:03:52.097] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:52.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:274:0) after 1m0s
[14:04:52.171] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:274:0)
[14:04:52.171] Timer tick, asking Buildbucket for the build status
[14:04:52.264] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:52.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:275:0) after 1m0s
[14:05:52.244] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:275:0)
[14:05:52.244] Timer tick, asking Buildbucket for the build status
[14:05:52.333] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:52.333] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:276:0) after 1m0s
[14:06:52.410] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:276:0)
[14:06:52.410] Timer tick, asking Buildbucket for the build status
[14:06:53.098] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:53.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:277:0) after 1m0s
[14:07:53.146] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:277:0)
[14:07:53.146] Timer tick, asking Buildbucket for the build status
[14:07:53.592] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:53.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:278:0) after 1m0s
[14:08:53.618] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:278:0)
[14:08:53.618] Timer tick, asking Buildbucket for the build status
[14:08:53.784] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:53.784] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:279:0) after 1m0s
[14:09:53.817] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:279:0)
[14:09:53.817] Timer tick, asking Buildbucket for the build status
[14:09:53.916] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:53.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:280:0) after 1m0s
[14:10:53.939] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:280:0)
[14:10:53.939] Timer tick, asking Buildbucket for the build status
[14:10:54.025] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:54.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:281:0) after 1m0s
[14:11:54.110] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:281:0)
[14:11:54.110] Timer tick, asking Buildbucket for the build status
[14:11:54.409] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:54.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:282:0) after 1m0s
[14:12:54.485] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:282:0)
[14:12:54.485] Timer tick, asking Buildbucket for the build status
[14:12:54.601] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:54.601] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:283:0) after 1m0s
[14:13:54.683] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:283:0)
[14:13:54.683] Timer tick, asking Buildbucket for the build status
[14:13:55.154] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:55.154] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:284:0) after 1m0s
[14:14:55.282] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:284:0)
[14:14:55.282] Timer tick, asking Buildbucket for the build status
[14:14:55.722] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:55.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:285:0) after 1m0s
[14:15:55.890] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:285:0)
[14:15:55.890] Timer tick, asking Buildbucket for the build status
[14:15:56.061] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:56.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:286:0) after 1m0s
[14:16:56.089] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:286:0)
[14:16:56.089] Timer tick, asking Buildbucket for the build status
[14:16:56.393] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:56.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:287:0) after 1m0s
[14:17:56.417] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:287:0)
[14:17:56.417] Timer tick, asking Buildbucket for the build status
[14:17:56.503] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:56.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:288:0) after 1m0s
[14:18:56.529] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:288:0)
[14:18:56.529] Timer tick, asking Buildbucket for the build status
[14:18:56.627] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:56.627] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:289:0) after 1m0s
[14:19:56.632] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:289:0)
[14:19:56.632] Timer tick, asking Buildbucket for the build status
[14:19:56.767] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:56.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:290:0) after 1m0s
[14:20:56.813] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:290:0)
[14:20:56.813] Timer tick, asking Buildbucket for the build status
[14:20:58.076] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:58.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:291:0) after 1m0s
[14:21:58.118] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:291:0)
[14:21:58.118] Timer tick, asking Buildbucket for the build status
[14:21:58.905] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:58.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:292:0) after 1m0s
[14:22:59.197] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:292:0)
[14:22:59.197] Timer tick, asking Buildbucket for the build status
[14:22:59.272] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:59.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:293:0) after 1m0s
[14:23:59.308] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:293:0)
[14:23:59.308] Timer tick, asking Buildbucket for the build status
[14:23:59.442] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:59.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:294:0) after 1m0s
[14:24:59.600] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:294:0)
[14:24:59.600] Timer tick, asking Buildbucket for the build status
[14:24:59.687] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:59.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:295:0) after 1m0s
[14:25:59.873] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:295:0)
[14:25:59.873] Timer tick, asking Buildbucket for the build status
[14:25:59.955] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:59.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:296:0) after 1m0s
[14:27:00.158] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:296:0)
[14:27:00.158] Timer tick, asking Buildbucket for the build status
[14:27:00.267] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:00.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:297:0) after 1m0s
[14:28:00.325] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:297:0)
[14:28:00.325] Timer tick, asking Buildbucket for the build status
[14:28:00.418] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:00.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:298:0) after 1m0s
[14:29:00.488] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:298:0)
[14:29:00.488] Timer tick, asking Buildbucket for the build status
[14:29:00.562] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:00.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:299:0) after 1m0s
[14:30:00.583] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:299:0)
[14:30:00.583] Timer tick, asking Buildbucket for the build status
[14:30:00.684] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:00.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:300:0) after 1m0s
[14:31:00.798] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:300:0)
[14:31:00.798] Timer tick, asking Buildbucket for the build status
[14:31:00.892] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:00.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:301:0) after 1m0s
[14:32:01.617] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:301:0)
[14:32:01.617] Timer tick, asking Buildbucket for the build status
[14:32:02.696] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:02.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:302:0) after 1m0s
[14:33:02.678] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:302:0)
[14:33:02.678] Timer tick, asking Buildbucket for the build status
[14:33:02.925] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:02.925] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:303:0) after 1m0s
[14:34:02.954] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:303:0)
[14:34:02.954] Timer tick, asking Buildbucket for the build status
[14:34:03.043] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:03.043] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:304:0) after 1m0s
[14:35:03.072] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:304:0)
[14:35:03.072] Timer tick, asking Buildbucket for the build status
[14:35:03.299] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:03.299] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:305:0) after 1m0s
[14:36:03.333] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:305:0)
[14:36:03.333] Timer tick, asking Buildbucket for the build status
[14:36:03.425] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:03.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:306:0) after 1m0s
[14:37:03.455] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:306:0)
[14:37:03.455] Timer tick, asking Buildbucket for the build status
[14:37:03.903] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:03.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:307:0) after 1m0s
[14:38:03.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:307:0)
[14:38:03.960] Timer tick, asking Buildbucket for the build status
[14:38:04.302] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:04.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:308:0) after 1m0s
[14:39:04.307] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:308:0)
[14:39:04.307] Timer tick, asking Buildbucket for the build status
[14:39:04.443] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:04.443] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:309:0) after 1m0s
[14:40:04.500] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:309:0)
[14:40:04.500] Timer tick, asking Buildbucket for the build status
[14:40:04.640] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:04.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:310:0) after 1m0s
[14:41:04.693] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:310:0)
[14:41:04.693] Timer tick, asking Buildbucket for the build status
[14:41:04.790] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:04.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:311:0) after 1m0s
[14:42:04.857] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:311:0)
[14:42:04.857] Timer tick, asking Buildbucket for the build status
[14:42:04.987] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:04.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:312:0) after 1m0s
[14:43:05.038] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:312:0)
[14:43:05.038] Timer tick, asking Buildbucket for the build status
[14:43:05.127] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:05.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:313:0) after 1m0s
[14:44:05.182] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:313:0)
[14:44:05.182] Timer tick, asking Buildbucket for the build status
[14:44:05.343] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:05.343] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:314:0) after 1m0s
[14:45:05.408] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:314:0)
[14:45:05.408] Timer tick, asking Buildbucket for the build status
[14:45:05.483] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:05.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:315:0) after 1m0s
[14:46:05.476] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:315:0)
[14:46:05.476] Timer tick, asking Buildbucket for the build status
[14:46:05.569] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:05.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:316:0) after 1m0s
[14:47:05.600] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:316:0)
[14:47:05.600] Timer tick, asking Buildbucket for the build status
[14:47:05.695] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:05.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:317:0) after 1m0s
[14:48:05.861] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:317:0)
[14:48:05.861] Timer tick, asking Buildbucket for the build status
[14:48:05.988] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:05.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:318:0) after 1m0s
[14:49:06.095] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:318:0)
[14:49:06.095] Timer tick, asking Buildbucket for the build status
[14:49:06.477] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:06.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:319:0) after 1m0s
[14:50:06.595] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:319:0)
[14:50:06.595] Timer tick, asking Buildbucket for the build status
[14:50:07.068] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:07.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:320:0) after 1m0s
[14:51:07.096] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:320:0)
[14:51:07.096] Timer tick, asking Buildbucket for the build status
[14:51:07.422] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:07.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:321:0) after 1m0s
[14:52:07.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:321:0)
[14:52:07.494] Timer tick, asking Buildbucket for the build status
[14:52:07.606] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:07.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:322:0) after 1m0s
[14:53:07.678] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:322:0)
[14:53:07.678] Timer tick, asking Buildbucket for the build status
[14:53:08.262] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:08.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:323:0) after 1m0s
[14:54:08.326] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:323:0)
[14:54:08.326] Timer tick, asking Buildbucket for the build status
[14:54:08.714] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:08.714] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:324:0) after 1m0s
[14:55:08.801] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:324:0)
[14:55:08.801] Timer tick, asking Buildbucket for the build status
[14:55:08.926] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:08.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:325:0) after 1m0s
[14:56:08.986] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:325:0)
[14:56:08.986] Timer tick, asking Buildbucket for the build status
[14:56:09.064] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:09.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:326:0) after 1m0s
[14:57:09.167] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:326:0)
[14:57:09.167] Timer tick, asking Buildbucket for the build status
[14:57:09.731] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:09.731] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:327:0) after 1m0s
[14:58:09.795] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:327:0)
[14:58:09.795] Timer tick, asking Buildbucket for the build status
[14:58:10.387] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:10.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:328:0) after 1m0s
[14:59:10.416] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:328:0)
[14:59:10.416] Timer tick, asking Buildbucket for the build status
[14:59:10.674] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:10.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:329:0) after 1m0s
[15:00:10.704] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:329:0)
[15:00:10.704] Timer tick, asking Buildbucket for the build status
[15:00:10.842] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:10.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:330:0) after 1m0s
[15:01:10.878] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:330:0)
[15:01:10.878] Timer tick, asking Buildbucket for the build status
[15:01:11.004] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:11.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:331:0) after 1m0s
[15:02:11.037] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:331:0)
[15:02:11.037] Timer tick, asking Buildbucket for the build status
[15:02:11.238] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:11.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:332:0) after 1m0s
[15:03:11.305] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:332:0)
[15:03:11.305] Timer tick, asking Buildbucket for the build status
[15:03:11.416] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:11.416] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:333:0) after 1m0s
[15:04:11.457] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:333:0)
[15:04:11.457] Timer tick, asking Buildbucket for the build status
[15:04:11.607] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:11.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:334:0) after 1m0s
[15:05:11.749] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:334:0)
[15:05:11.749] Timer tick, asking Buildbucket for the build status
[15:05:11.942] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:11.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:335:0) after 1m0s
[15:06:11.998] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:335:0)
[15:06:11.998] Timer tick, asking Buildbucket for the build status
[15:06:12.950] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:12.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:336:0) after 1m0s
[15:07:12.979] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:336:0)
[15:07:12.979] Timer tick, asking Buildbucket for the build status
[15:07:13.097] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:13.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:337:0) after 1m0s
[15:08:13.230] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:337:0)
[15:08:13.230] Timer tick, asking Buildbucket for the build status
[15:08:13.501] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:13.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:338:0) after 1m0s
[15:09:13.531] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:338:0)
[15:09:13.531] Timer tick, asking Buildbucket for the build status
[15:09:13.608] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:13.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:339:0) after 1m0s
[15:10:13.751] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:339:0)
[15:10:13.751] Timer tick, asking Buildbucket for the build status
[15:10:13.871] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:13.871] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:340:0) after 1m0s
[15:11:13.968] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:340:0)
[15:11:13.968] Timer tick, asking Buildbucket for the build status
[15:11:14.126] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:14.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:341:0) after 1m0s
[15:12:14.158] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:341:0)
[15:12:14.158] Timer tick, asking Buildbucket for the build status
[15:12:14.266] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:14.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:342:0) after 1m0s
[15:13:14.300] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:342:0)
[15:13:14.300] Timer tick, asking Buildbucket for the build status
[15:13:14.380] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:14.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:343:0) after 1m0s
[15:14:14.461] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:343:0)
[15:14:14.461] Timer tick, asking Buildbucket for the build status
[15:14:14.594] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:14.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:344:0) after 1m0s
[15:15:14.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:344:0)
[15:15:14.834] Timer tick, asking Buildbucket for the build status
[15:15:14.958] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:14.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:345:0) after 1m0s
[15:16:15.054] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:345:0)
[15:16:15.054] Timer tick, asking Buildbucket for the build status
[15:16:15.144] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:15.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:346:0) after 1m0s
[15:17:15.385] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:346:0)
[15:17:15.385] Timer tick, asking Buildbucket for the build status
[15:17:15.552] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:15.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:347:0) after 1m0s
[15:18:16.161] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:347:0)
[15:18:16.161] Timer tick, asking Buildbucket for the build status
[15:18:16.244] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:16.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:348:0) after 1m0s
[15:19:16.309] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:348:0)
[15:19:16.309] Timer tick, asking Buildbucket for the build status
[15:19:16.690] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:16.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:349:0) after 1m0s
[15:20:16.759] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:349:0)
[15:20:16.759] Timer tick, asking Buildbucket for the build status
[15:20:16.840] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:16.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:350:0) after 1m0s
[15:21:16.890] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:350:0)
[15:21:16.890] Timer tick, asking Buildbucket for the build status
[15:21:17.227] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:17.227] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:351:0) after 1m0s
[15:22:17.315] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:351:0)
[15:22:17.315] Timer tick, asking Buildbucket for the build status
[15:22:17.437] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:17.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:352:0) after 1m0s
[15:23:17.458] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:352:0)
[15:23:17.458] Timer tick, asking Buildbucket for the build status
[15:23:17.555] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:17.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:353:0) after 1m0s
[15:24:17.589] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:353:0)
[15:24:17.589] Timer tick, asking Buildbucket for the build status
[15:24:17.745] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:17.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:354:0) after 1m0s
[15:25:17.796] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:354:0)
[15:25:17.796] Timer tick, asking Buildbucket for the build status
[15:25:18.007] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:18.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:355:0) after 1m0s
[15:26:18.057] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:355:0)
[15:26:18.057] Timer tick, asking Buildbucket for the build status
[15:26:18.149] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:18.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:356:0) after 1m0s
[15:27:18.197] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:356:0)
[15:27:18.197] Timer tick, asking Buildbucket for the build status
[15:27:18.347] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:18.347] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:357:0) after 1m0s
[15:28:18.383] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:357:0)
[15:28:18.383] Timer tick, asking Buildbucket for the build status
[15:28:18.474] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:18.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:358:0) after 1m0s
[15:29:18.507] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:358:0)
[15:29:18.507] Timer tick, asking Buildbucket for the build status
[15:29:18.585] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:18.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:359:0) after 1m0s
[15:30:18.635] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:359:0)
[15:30:18.635] Timer tick, asking Buildbucket for the build status
[15:30:18.712] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:18.712] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:360:0) after 1m0s
[15:31:18.744] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:360:0)
[15:31:18.744] Timer tick, asking Buildbucket for the build status
[15:31:19.234] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:19.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:361:0) after 1m0s
[15:32:19.495] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:361:0)
[15:32:19.495] Timer tick, asking Buildbucket for the build status
[15:32:19.616] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:19.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:362:0) after 1m0s
[15:33:20.627] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:362:0)
[15:33:20.627] Timer tick, asking Buildbucket for the build status
[15:33:20.827] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:20.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:363:0) after 1m0s
[15:34:21.216] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:363:0)
[15:34:21.216] Timer tick, asking Buildbucket for the build status
[15:34:21.313] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:21.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:364:0) after 1m0s
[15:35:21.609] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:364:0)
[15:35:21.609] Timer tick, asking Buildbucket for the build status
[15:35:22.082] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:22.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:365:0) after 1m0s
[15:36:22.278] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:365:0)
[15:36:22.278] Timer tick, asking Buildbucket for the build status
[15:36:22.386] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:22.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:366:0) after 1m0s
[15:37:22.440] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:366:0)
[15:37:22.440] Timer tick, asking Buildbucket for the build status
[15:37:22.554] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:22.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:367:0) after 1m0s
[15:38:22.608] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:367:0)
[15:38:22.609] Timer tick, asking Buildbucket for the build status
[15:38:22.699] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:22.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:368:0) after 1m0s
[15:39:22.811] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:368:0)
[15:39:22.811] Timer tick, asking Buildbucket for the build status
[15:39:23.254] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:23.254] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:369:0) after 1m0s
[15:40:23.241] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:369:0)
[15:40:23.241] Timer tick, asking Buildbucket for the build status
[15:40:23.315] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:23.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:370:0) after 1m0s
[15:41:23.408] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:370:0)
[15:41:23.408] Timer tick, asking Buildbucket for the build status
[15:41:23.493] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:23.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:371:0) after 1m0s
[15:42:23.580] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:371:0)
[15:42:23.580] Timer tick, asking Buildbucket for the build status
[15:42:23.689] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:23.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:372:0) after 1m0s
[15:43:23.795] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:372:0)
[15:43:23.795] Timer tick, asking Buildbucket for the build status
[15:43:23.885] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:23.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:373:0) after 1m0s
[15:44:23.942] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:373:0)
[15:44:23.942] Timer tick, asking Buildbucket for the build status
[15:44:24.008] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:24.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:374:0) after 1m0s
[15:45:24.130] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:374:0)
[15:45:24.130] Timer tick, asking Buildbucket for the build status
[15:45:24.228] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:24.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:375:0) after 1m0s
[15:46:24.338] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:375:0)
[15:46:24.338] Timer tick, asking Buildbucket for the build status
[15:46:24.422] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:24.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:376:0) after 1m0s
[15:47:24.504] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:376:0)
[15:47:24.504] Timer tick, asking Buildbucket for the build status
[15:47:24.598] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:24.598] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:377:0) after 1m0s
[15:48:24.621] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:377:0)
[15:48:24.621] Timer tick, asking Buildbucket for the build status
[15:48:24.803] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:24.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:378:0) after 1m0s
[15:49:24.874] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:378:0)
[15:49:24.874] Timer tick, asking Buildbucket for the build status
[15:49:24.963] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:24.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:379:0) after 1m0s
[15:50:25.104] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:379:0)
[15:50:25.104] Timer tick, asking Buildbucket for the build status
[15:50:25.705] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:25.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:380:0) after 1m0s
[15:51:25.769] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:380:0)
[15:51:25.769] Timer tick, asking Buildbucket for the build status
[15:51:25.843] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:25.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:381:0) after 1m0s
[15:52:25.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:381:0)
[15:52:25.920] Timer tick, asking Buildbucket for the build status
[15:52:26.061] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:26.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:382:0) after 1m0s
[15:53:26.103] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:382:0)
[15:53:26.103] Timer tick, asking Buildbucket for the build status
[15:53:26.774] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:26.774] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:383:0) after 1m0s
[15:54:26.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:383:0)
[15:54:26.960] Timer tick, asking Buildbucket for the build status
[15:54:27.025] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:27.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:384:0) after 1m0s
[15:55:27.046] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:384:0)
[15:55:27.046] Timer tick, asking Buildbucket for the build status
[15:55:27.153] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:27.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:385:0) after 1m0s
[15:56:27.198] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:385:0)
[15:56:27.198] Timer tick, asking Buildbucket for the build status
[15:56:27.274] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:27.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:386:0) after 1m0s
[15:57:27.443] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:386:0)
[15:57:27.443] Timer tick, asking Buildbucket for the build status
[15:57:27.523] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:27.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:387:0) after 1m0s
[15:58:27.586] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:387:0)
[15:58:27.586] Timer tick, asking Buildbucket for the build status
[15:58:27.653] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:27.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:388:0) after 1m0s
[15:59:27.953] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:388:0)
[15:59:27.953] Timer tick, asking Buildbucket for the build status
[15:59:28.022] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:28.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:389:0) after 1m0s
[16:00:28.157] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:389:0)
[16:00:28.157] Timer tick, asking Buildbucket for the build status
[16:00:28.344] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:28.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:390:0) after 1m0s
[16:01:28.522] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:390:0)
[16:01:28.522] Timer tick, asking Buildbucket for the build status
[16:01:28.620] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:28.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:391:0) after 1m0s
[16:02:28.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:391:0)
[16:02:28.808] Timer tick, asking Buildbucket for the build status
[16:02:29.433] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:29.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:392:0) after 1m0s
[16:03:29.528] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:392:0)
[16:03:29.528] Timer tick, asking Buildbucket for the build status
[16:03:29.929] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:29.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:393:0) after 1m0s
[16:04:30.098] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:393:0)
[16:04:30.098] Timer tick, asking Buildbucket for the build status
[16:04:30.279] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:30.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:394:0) after 1m0s
[16:05:30.445] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:394:0)
[16:05:30.445] Timer tick, asking Buildbucket for the build status
[16:05:30.628] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:30.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:395:0) after 1m0s
[16:06:30.708] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:395:0)
[16:06:30.708] Timer tick, asking Buildbucket for the build status
[16:06:30.809] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:30.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:396:0) after 1m0s
[16:07:30.948] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:396:0)
[16:07:30.948] Timer tick, asking Buildbucket for the build status
[16:07:31.056] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:31.056] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:397:0) after 1m0s
[16:08:31.151] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:397:0)
[16:08:31.151] Timer tick, asking Buildbucket for the build status
[16:08:31.395] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:31.395] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:398:0) after 1m0s
[16:09:31.555] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:398:0)
[16:09:31.555] Timer tick, asking Buildbucket for the build status
[16:09:31.621] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:31.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:399:0) after 1m0s
[16:10:31.694] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:399:0)
[16:10:31.694] Timer tick, asking Buildbucket for the build status
[16:10:31.892] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:31.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:400:0) after 1m0s
[16:11:31.923] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:400:0)
[16:11:31.923] Timer tick, asking Buildbucket for the build status
[16:11:32.005] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:32.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:401:0) after 1m0s
[16:12:32.049] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:401:0)
[16:12:32.049] Timer tick, asking Buildbucket for the build status
[16:12:33.306] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:33.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:402:0) after 1m0s
[16:13:33.406] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:402:0)
[16:13:33.406] Timer tick, asking Buildbucket for the build status
[16:13:33.527] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:33.527] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:403:0) after 1m0s
[16:14:33.575] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:403:0)
[16:14:33.575] Timer tick, asking Buildbucket for the build status
[16:14:33.717] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:33.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:404:0) after 1m0s
[16:15:33.757] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:404:0)
[16:15:33.757] Timer tick, asking Buildbucket for the build status
[16:15:33.863] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:33.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:405:0) after 1m0s
[16:16:33.923] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:405:0)
[16:16:33.923] Timer tick, asking Buildbucket for the build status
[16:16:33.996] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:33.996] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:406:0) after 1m0s
[16:17:34.079] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:406:0)
[16:17:34.079] Timer tick, asking Buildbucket for the build status
[16:17:34.174] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:34.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:407:0) after 1m0s
[16:18:34.281] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:407:0)
[16:18:34.281] Timer tick, asking Buildbucket for the build status
[16:18:34.397] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:34.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:408:0) after 1m0s
[16:19:34.483] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:408:0)
[16:19:34.483] Timer tick, asking Buildbucket for the build status
[16:19:34.715] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:34.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:409:0) after 1m0s
[16:20:34.794] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:409:0)
[16:20:34.794] Timer tick, asking Buildbucket for the build status
[16:20:34.909] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:34.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:410:0) after 1m0s
[16:21:35.016] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:410:0)
[16:21:35.016] Timer tick, asking Buildbucket for the build status
[16:21:35.228] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:35.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:411:0) after 1m0s
[16:22:35.554] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:411:0)
[16:22:35.554] Timer tick, asking Buildbucket for the build status
[16:22:35.641] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:35.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:412:0) after 1m0s
[16:23:35.688] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:412:0)
[16:23:35.688] Timer tick, asking Buildbucket for the build status
[16:23:36.008] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:36.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:413:0) after 1m0s
[16:24:36.112] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:413:0)
[16:24:36.112] Timer tick, asking Buildbucket for the build status
[16:24:36.237] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:36.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:414:0) after 1m0s
[16:25:36.418] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:414:0)
[16:25:36.418] Timer tick, asking Buildbucket for the build status
[16:25:36.489] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:36.489] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:415:0) after 1m0s
[16:26:36.589] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:415:0)
[16:26:36.589] Timer tick, asking Buildbucket for the build status
[16:26:36.690] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:36.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:416:0) after 1m0s
[16:27:36.783] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:416:0)
[16:27:36.783] Timer tick, asking Buildbucket for the build status
[16:27:36.890] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:36.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:417:0) after 1m0s
[16:28:37.082] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:417:0)
[16:28:37.082] Timer tick, asking Buildbucket for the build status
[16:28:37.170] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:37.170] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:418:0) after 1m0s
[16:29:37.263] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:418:0)
[16:29:37.263] Timer tick, asking Buildbucket for the build status
[16:29:37.379] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:37.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:419:0) after 1m0s
[16:30:37.525] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:419:0)
[16:30:37.525] Timer tick, asking Buildbucket for the build status
[16:30:37.647] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:37.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:420:0) after 1m0s
[16:31:38.630] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:420:0)
[16:31:38.630] Timer tick, asking Buildbucket for the build status
[16:31:38.705] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:38.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:421:0) after 1m0s
[16:32:38.743] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:421:0)
[16:32:38.743] Timer tick, asking Buildbucket for the build status
[16:32:38.848] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:38.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:422:0) after 1m0s
[16:33:40.292] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:422:0)
[16:33:40.292] Timer tick, asking Buildbucket for the build status
[16:33:40.383] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:40.383] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:423:0) after 1m0s
[16:34:40.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:423:0)
[16:34:40.738] Timer tick, asking Buildbucket for the build status
[16:34:40.958] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:40.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:424:0) after 1m0s
[16:35:41.358] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:424:0)
[16:35:41.358] Timer tick, asking Buildbucket for the build status
[16:35:41.438] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:41.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:425:0) after 1m0s
[16:36:41.687] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:425:0)
[16:36:41.687] Timer tick, asking Buildbucket for the build status
[16:36:41.760] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:41.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:426:0) after 1m0s
[16:37:42.149] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:426:0)
[16:37:42.149] Timer tick, asking Buildbucket for the build status
[16:37:42.240] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:42.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:427:0) after 1m0s
[16:38:44.996] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:427:0)
[16:38:44.996] Timer tick, asking Buildbucket for the build status
[16:38:45.072] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:45.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:428:0) after 1m0s
[16:39:45.096] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:428:0)
[16:39:45.096] Timer tick, asking Buildbucket for the build status
[16:39:45.240] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:45.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:429:0) after 1m0s
[16:40:45.280] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:429:0)
[16:40:45.280] Timer tick, asking Buildbucket for the build status
[16:40:45.518] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:45.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:430:0) after 1m0s
--- the log has been cut here ---
[19:59:54.398] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:54.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:628:0) after 1m0s
[20:00:54.451] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:628:0)
[20:00:54.451] Timer tick, asking Buildbucket for the build status
[20:00:54.805] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:54.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:629:0) after 1m0s
[20:01:54.857] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:629:0)
[20:01:54.857] Timer tick, asking Buildbucket for the build status
[20:01:54.956] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:54.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:630:0) after 1m0s
[20:02:55.045] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:630:0)
[20:02:55.045] Timer tick, asking Buildbucket for the build status
[20:02:55.245] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:55.245] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:631:0) after 1m0s
[20:03:55.276] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:631:0)
[20:03:55.276] Timer tick, asking Buildbucket for the build status
[20:03:55.920] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:55.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:632:0) after 1m0s
[20:04:56.045] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:632:0)
[20:04:56.045] Timer tick, asking Buildbucket for the build status
[20:04:56.543] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:56.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:633:0) after 1m0s
[20:05:56.646] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:633:0)
[20:05:56.646] Timer tick, asking Buildbucket for the build status
[20:05:57.137] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:57.137] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:634:0) after 1m0s
[20:06:57.183] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:634:0)
[20:06:57.183] Timer tick, asking Buildbucket for the build status
[20:06:57.287] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:57.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:635:0) after 1m0s
[20:07:57.314] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:635:0)
[20:07:57.314] Timer tick, asking Buildbucket for the build status
[20:07:57.403] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:57.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:636:0) after 1m0s
[20:08:57.491] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:636:0)
[20:08:57.491] Timer tick, asking Buildbucket for the build status
[20:08:57.726] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:57.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:637:0) after 1m0s
[20:09:57.770] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:637:0)
[20:09:57.770] Timer tick, asking Buildbucket for the build status
[20:09:57.928] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:57.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:638:0) after 1m0s
[20:10:57.956] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:638:0)
[20:10:57.956] Timer tick, asking Buildbucket for the build status
[20:10:58.057] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:58.057] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:639:0) after 1m0s
[20:11:58.128] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:639:0)
[20:11:58.128] Timer tick, asking Buildbucket for the build status
[20:11:58.207] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:58.207] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:640:0) after 1m0s
[20:12:58.300] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:640:0)
[20:12:58.300] Timer tick, asking Buildbucket for the build status
[20:12:58.396] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:58.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:641:0) after 1m0s
[20:13:58.492] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:641:0)
[20:13:58.492] Timer tick, asking Buildbucket for the build status
[20:13:58.630] Build 8854878214133640592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:58.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9020308276320496368:642:0) after 1m0s
[20:14:03.382] Received PubSub notification, asking Buildbucket for the build status
[20:14:03.613] Build 8854878214133640592: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:14:03.613] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "completed_ts": "1613765642411643",
    "created_by": "project:nacl",
    "created_ts": "1613727094483751",
    "id": "8854878214133640592",
    "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\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"title\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}}",
    "project": "nacl",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"title\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-flex-ci-xenial-4-38uc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.nacl\", \"buildername\": \"linux-64-validator-opt\", \"buildnumber\": 166, \"got_revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0c2213e2471b4804ce7cc02c147d9769f9d07f20fd3fd447c453f4900380938c_v2\", \"builder_61fc32c3bc5a7ee2a26f46d61db55ba1f83c918285cc8d2dc6086b96201d8c90_v2\", \"builder_9e6340b972c271dffa7c0d98fd1acf5f94a4ba0557aafe35f72187cb5874ff44_v2\", \"builder_a20b1ade66d3cd92c501ea59e0fa76fddd60e1587b9432210d1936953c00db76_v2\", \"builder_d6e34fbf0b97f42009d0e08c4c2190eabfc3f965b1a56dffd678d628cf424e8a_v2\", \"git\", \"gocache\", \"goma_v2\", \"gopath\", \"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-4-38uc\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.flex.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1613727697002082",
    "status": "COMPLETED",
    "status_changed_ts": "1613765642685296",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/166",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/4ad2ff292145e8613ec371302875f0eaf8b4fa14",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9020308276320496368",
      "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/8854878214133640592/+/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:51d272eddb5bcd10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1613765642698236",
    "url": "https://ci.chromium.org/b/8854878214133640592",
    "utcnow_ts": "1613765643597038"
  }
}
[20:14:03.613] Invocation finished in 10h42m30.598811949s with status SUCCEEDED