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

• 8db20f20316f13d8886a2732099f5bb880568663 (4 years ago)

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

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

[05:33:20.774] New invocation is queued and will start shortly
[05:33:24.918] Starting the invocation (attempt 1)
[05:33:24.954] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:33:24.954] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:33:24.954] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9021501023398103392",
  "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\":\"8db20f20316f13d8886a2732099f5bb880568663\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@8db20f20316f13d8886a2732099f5bb880568663\",\"title\":\"8db20f20316f13d8886a2732099f5bb880568663\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/8db20f20316f13d8886a2732099f5bb880568663\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"8db20f20316f13d8886a2732099f5bb880568663\"}}",
  "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:9021501023398103392",
    "scheduler_job_id:nacl/linux-64-validator-opt",
    "user_agent:luci-scheduler",
    "buildset:commit/git/8db20f20316f13d8886a2732099f5bb880568663",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/8db20f20316f13d8886a2732099f5bb880568663",
    "gitiles_ref:refs/heads/master"
  ]
}
[05:33:25.452] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1612589605038416",
    "id": "8856070958265884048",
    "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\": \"8db20f20316f13d8886a2732099f5bb880568663\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@8db20f20316f13d8886a2732099f5bb880568663\", \"title\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/8db20f20316f13d8886a2732099f5bb880568663\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"8db20f20316f13d8886a2732099f5bb880568663\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1612589605345453",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/160",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/8db20f20316f13d8886a2732099f5bb880568663",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/8db20f20316f13d8886a2732099f5bb880568663",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021501023398103392",
      "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/8856070958265884048/+/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": "1612589605345566",
    "url": "https://ci.chromium.org/b/8856070958265884048",
    "utcnow_ts": "1612589605445166"
  }
}
[05:33:25.452] Task URL: https://ci.chromium.org/b/8856070958265884048
[05:33:25.452] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:2:0) after 1m0s
[05:34:25.536] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:2:0)
[05:34:25.536] Timer tick, asking Buildbucket for the build status
[05:34:25.626] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:25.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:3:0) after 1m0s
[05:35:25.677] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:3:0)
[05:35:25.677] Timer tick, asking Buildbucket for the build status
[05:35:25.753] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:25.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:4:0) after 1m0s
[05:36:25.899] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:4:0)
[05:36:25.899] Timer tick, asking Buildbucket for the build status
[05:36:26.001] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:26.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:5:0) after 1m0s
[05:37:26.181] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:5:0)
[05:37:26.181] Timer tick, asking Buildbucket for the build status
[05:37:26.589] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:26.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:6:0) after 1m0s
[05:38:26.681] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:6:0)
[05:38:26.681] Timer tick, asking Buildbucket for the build status
[05:38:27.031] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:27.031] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:7:0) after 1m0s
[05:39:27.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:7:0)
[05:39:27.251] Timer tick, asking Buildbucket for the build status
[05:39:27.349] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:27.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:8:0) after 1m0s
[05:40:27.519] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:8:0)
[05:40:27.519] Timer tick, asking Buildbucket for the build status
[05:40:27.711] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:27.711] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:9:0) after 1m0s
[05:41:27.871] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:9:0)
[05:41:27.871] Timer tick, asking Buildbucket for the build status
[05:41:28.226] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:28.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:10:0) after 1m0s
[05:42:28.449] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:10:0)
[05:42:28.449] Timer tick, asking Buildbucket for the build status
[05:42:29.003] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:29.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:11:0) after 1m0s
[05:43:29.020] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:11:0)
[05:43:29.020] Timer tick, asking Buildbucket for the build status
[05:43:29.194] Build 8856070958265884048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:29.194] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:12:0) after 1m0s
[05:43:47.509] Received PubSub notification, asking Buildbucket for the build status
[05:43:47.780] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:29.205] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:12:0)
[05:44:29.205] Timer tick, asking Buildbucket for the build status
[05:44:29.316] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:29.316] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:14:0) after 1m0s
[05:45:29.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:14:0)
[05:45:29.394] Timer tick, asking Buildbucket for the build status
[05:45:29.458] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:29.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:15:0) after 1m0s
[05:46:29.559] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:15:0)
[05:46:29.559] Timer tick, asking Buildbucket for the build status
[05:46:29.855] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:29.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:16:0) after 1m0s
[05:47:29.956] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:16:0)
[05:47:29.956] Timer tick, asking Buildbucket for the build status
[05:47:30.298] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:30.298] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:17:0) after 1m0s
[05:48:30.419] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:17:0)
[05:48:30.420] Timer tick, asking Buildbucket for the build status
[05:48:30.521] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:30.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:18:0) after 1m0s
[05:49:30.592] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:18:0)
[05:49:30.592] Timer tick, asking Buildbucket for the build status
[05:49:30.752] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:30.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:19:0) after 1m0s
[05:50:30.770] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:19:0)
[05:50:30.770] Timer tick, asking Buildbucket for the build status
[05:50:30.913] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:30.913] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:20:0) after 1m0s
[05:51:30.971] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:20:0)
[05:51:30.971] Timer tick, asking Buildbucket for the build status
[05:51:31.038] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:31.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:21:0) after 1m0s
[05:52:31.098] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:21:0)
[05:52:31.098] Timer tick, asking Buildbucket for the build status
[05:52:31.224] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:31.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:22:0) after 1m0s
[05:53:31.220] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:22:0)
[05:53:31.220] Timer tick, asking Buildbucket for the build status
[05:53:31.526] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:31.526] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:23:0) after 1m0s
[05:54:31.527] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:23:0)
[05:54:31.527] Timer tick, asking Buildbucket for the build status
[05:54:31.610] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:31.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:24:0) after 1m0s
[05:55:31.692] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:24:0)
[05:55:31.692] Timer tick, asking Buildbucket for the build status
[05:55:31.910] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:31.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:25:0) after 1m0s
[05:56:31.958] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:25:0)
[05:56:31.958] Timer tick, asking Buildbucket for the build status
[05:56:32.021] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:32.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:26:0) after 1m0s
[05:57:32.112] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:26:0)
[05:57:32.112] Timer tick, asking Buildbucket for the build status
[05:57:32.226] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:32.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:27:0) after 1m0s
[05:58:32.244] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:27:0)
[05:58:32.244] Timer tick, asking Buildbucket for the build status
[05:58:32.362] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:32.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:28:0) after 1m0s
[05:59:32.380] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:28:0)
[05:59:32.380] Timer tick, asking Buildbucket for the build status
[05:59:32.434] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:32.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:29:0) after 1m0s
[06:00:32.409] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:29:0)
[06:00:32.409] Timer tick, asking Buildbucket for the build status
[06:00:32.492] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:32.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:30:0) after 1m0s
[06:01:40.905] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:30:0)
[06:01:40.905] Timer tick, asking Buildbucket for the build status
[06:01:41.024] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:41.024] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:31:0) after 1m0s
[06:02:41.085] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:31:0)
[06:02:41.085] Timer tick, asking Buildbucket for the build status
[06:02:41.258] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:41.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:32:0) after 1m0s
[06:03:41.386] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:32:0)
[06:03:41.386] Timer tick, asking Buildbucket for the build status
[06:03:41.492] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:41.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:33:0) after 1m0s
[06:04:41.559] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:33:0)
[06:04:41.559] Timer tick, asking Buildbucket for the build status
[06:04:41.621] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:41.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:34:0) after 1m0s
[06:05:41.655] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:34:0)
[06:05:41.656] Timer tick, asking Buildbucket for the build status
[06:05:41.725] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:41.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:35:0) after 1m0s
[06:06:41.754] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:35:0)
[06:06:41.754] Timer tick, asking Buildbucket for the build status
[06:06:41.823] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:41.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:36:0) after 1m0s
[06:07:41.843] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:36:0)
[06:07:41.843] Timer tick, asking Buildbucket for the build status
[06:07:42.411] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:42.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:37:0) after 1m0s
[06:08:42.428] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:37:0)
[06:08:42.429] Timer tick, asking Buildbucket for the build status
[06:08:42.551] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:42.551] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:38:0) after 1m0s
[06:09:42.628] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:38:0)
[06:09:42.628] Timer tick, asking Buildbucket for the build status
[06:09:42.793] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:42.793] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:39:0) after 1m0s
[06:10:42.824] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:39:0)
[06:10:42.824] Timer tick, asking Buildbucket for the build status
[06:10:43.040] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:43.040] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:40:0) after 1m0s
[06:11:43.063] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:40:0)
[06:11:43.063] Timer tick, asking Buildbucket for the build status
[06:11:43.322] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:43.322] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:41:0) after 1m0s
[06:12:43.365] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:41:0)
[06:12:43.365] Timer tick, asking Buildbucket for the build status
[06:12:43.431] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:43.431] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:42:0) after 1m0s
[06:13:43.497] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:42:0)
[06:13:43.497] Timer tick, asking Buildbucket for the build status
[06:13:43.608] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:43.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:43:0) after 1m0s
[06:14:43.630] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:43:0)
[06:14:43.630] Timer tick, asking Buildbucket for the build status
[06:14:44.726] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:44.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:44:0) after 1m0s
[06:15:44.710] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:44:0)
[06:15:44.710] Timer tick, asking Buildbucket for the build status
[06:15:47.523] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:47.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:45:0) after 1m0s
[06:16:47.542] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:45:0)
[06:16:47.542] Timer tick, asking Buildbucket for the build status
[06:16:47.751] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:47.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:46:0) after 1m0s
[06:17:47.772] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:46:0)
[06:17:47.772] Timer tick, asking Buildbucket for the build status
[06:17:50.357] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:50.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:47:0) after 1m0s
[06:18:50.491] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:47:0)
[06:18:50.492] Timer tick, asking Buildbucket for the build status
[06:18:52.375] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:52.375] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:48:0) after 1m0s
[06:19:52.390] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:48:0)
[06:19:52.390] Timer tick, asking Buildbucket for the build status
[06:19:55.473] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:55.473] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:49:0) after 1m0s
[06:20:55.556] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:49:0)
[06:20:55.556] Timer tick, asking Buildbucket for the build status
[06:20:55.647] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:55.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:50:0) after 1m0s
[06:21:55.685] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:50:0)
[06:21:55.685] Timer tick, asking Buildbucket for the build status
[06:21:55.793] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:55.793] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:51:0) after 1m0s
[06:22:55.823] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:51:0)
[06:22:55.823] Timer tick, asking Buildbucket for the build status
[06:22:56.822] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:56.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:52:0) after 1m0s
[06:23:56.955] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:52:0)
[06:23:56.955] Timer tick, asking Buildbucket for the build status
[06:23:59.781] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:59.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:53:0) after 1m0s
[06:24:59.943] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:53:0)
[06:24:59.943] Timer tick, asking Buildbucket for the build status
[06:25:00.797] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:00.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:54:0) after 1m0s
[06:26:00.951] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:54:0)
[06:26:00.951] Timer tick, asking Buildbucket for the build status
[06:26:01.777] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:01.777] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:55:0) after 1m0s
[06:27:02.154] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:55:0)
[06:27:02.154] Timer tick, asking Buildbucket for the build status
[06:27:02.665] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:02.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:56:0) after 1m0s
[06:28:02.752] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:56:0)
[06:28:02.752] Timer tick, asking Buildbucket for the build status
[06:28:04.251] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:04.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:57:0) after 1m0s
[06:29:04.355] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:57:0)
[06:29:04.355] Timer tick, asking Buildbucket for the build status
[06:29:08.183] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:08.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:58:0) after 1m0s
[06:30:08.351] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:58:0)
[06:30:08.352] Timer tick, asking Buildbucket for the build status
[06:30:08.715] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:08.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:59:0) after 1m0s
[06:31:08.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:59:0)
[06:31:08.929] Timer tick, asking Buildbucket for the build status
[06:31:11.241] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:11.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:60:0) after 1m0s
[06:32:11.971] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:60:0)
[06:32:11.971] Timer tick, asking Buildbucket for the build status
[06:32:13.085] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:13.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:61:0) after 1m0s
[06:33:13.659] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:61:0)
[06:33:13.659] Timer tick, asking Buildbucket for the build status
[06:33:14.236] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:14.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:62:0) after 1m0s
[06:34:14.279] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:62:0)
[06:34:14.279] Timer tick, asking Buildbucket for the build status
[06:34:15.274] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:15.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:63:0) after 1m0s
[06:35:15.424] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:63:0)
[06:35:15.424] Timer tick, asking Buildbucket for the build status
[06:35:15.994] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:15.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:64:0) after 1m0s
[06:36:16.149] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:64:0)
[06:36:16.149] Timer tick, asking Buildbucket for the build status
[06:36:16.741] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:16.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:65:0) after 1m0s
[06:37:16.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:65:0)
[06:37:16.929] Timer tick, asking Buildbucket for the build status
[06:37:17.041] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:17.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:66:0) after 1m0s
[06:38:17.143] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:66:0)
[06:38:17.143] Timer tick, asking Buildbucket for the build status
[06:38:17.354] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:17.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:67:0) after 1m0s
[06:39:17.542] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:67:0)
[06:39:17.542] Timer tick, asking Buildbucket for the build status
[06:39:20.519] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:20.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:68:0) after 1m0s
[06:40:20.518] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:68:0)
[06:40:20.518] Timer tick, asking Buildbucket for the build status
[06:40:23.495] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:23.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:69:0) after 1m0s
[06:41:23.503] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:69:0)
[06:41:23.503] Timer tick, asking Buildbucket for the build status
[06:41:27.757] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:27.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:70:0) after 1m0s
[06:42:27.822] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:70:0)
[06:42:27.822] Timer tick, asking Buildbucket for the build status
[06:42:27.947] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:27.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:71:0) after 1m0s
[06:43:27.983] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:71:0)
[06:43:27.983] Timer tick, asking Buildbucket for the build status
[06:43:28.753] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:28.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:72:0) after 1m0s
[06:44:28.794] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:72:0)
[06:44:28.795] Timer tick, asking Buildbucket for the build status
[06:44:28.894] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:28.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:73:0) after 1m0s
[06:45:28.974] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:73:0)
[06:45:28.974] Timer tick, asking Buildbucket for the build status
[06:45:29.144] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:29.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:74:0) after 1m0s
[06:46:29.204] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:74:0)
[06:46:29.204] Timer tick, asking Buildbucket for the build status
[06:46:29.674] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:29.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:75:0) after 1m0s
[06:47:29.663] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:75:0)
[06:47:29.663] Timer tick, asking Buildbucket for the build status
[06:47:29.791] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:29.791] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:76:0) after 1m0s
[06:48:29.806] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:76:0)
[06:48:29.807] Timer tick, asking Buildbucket for the build status
[06:48:30.957] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:30.957] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:77:0) after 1m0s
[06:49:31.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:77:0)
[06:49:31.008] Timer tick, asking Buildbucket for the build status
[06:49:32.397] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:32.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:78:0) after 1m0s
[06:50:32.406] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:78:0)
[06:50:32.406] Timer tick, asking Buildbucket for the build status
[06:50:34.606] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:34.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:79:0) after 1m0s
[06:51:34.653] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:79:0)
[06:51:34.653] Timer tick, asking Buildbucket for the build status
[06:51:35.728] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:35.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:80:0) after 1m0s
[06:52:35.873] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:80:0)
[06:52:35.873] Timer tick, asking Buildbucket for the build status
[06:52:37.013] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:37.013] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:81:0) after 1m0s
[06:53:37.207] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:81:0)
[06:53:37.207] Timer tick, asking Buildbucket for the build status
[06:53:37.302] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:37.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:82:0) after 1m0s
[06:54:37.322] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:82:0)
[06:54:37.322] Timer tick, asking Buildbucket for the build status
[06:54:39.192] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:39.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:83:0) after 1m0s
[06:55:39.206] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:83:0)
[06:55:39.206] Timer tick, asking Buildbucket for the build status
[06:55:42.596] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:42.596] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:84:0) after 1m0s
[06:56:42.666] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:84:0)
[06:56:42.666] Timer tick, asking Buildbucket for the build status
[06:56:44.575] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:44.575] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:85:0) after 1m0s
[06:57:44.637] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:85:0)
[06:57:44.637] Timer tick, asking Buildbucket for the build status
[06:57:44.803] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:44.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:86:0) after 1m0s
[06:58:44.818] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:86:0)
[06:58:44.818] Timer tick, asking Buildbucket for the build status
[06:58:48.883] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:48.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:87:0) after 1m0s
[06:59:49.019] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:87:0)
[06:59:49.019] Timer tick, asking Buildbucket for the build status
[06:59:50.359] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:50.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:88:0) after 1m0s
[07:00:50.392] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:88:0)
[07:00:50.392] Timer tick, asking Buildbucket for the build status
[07:00:52.734] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:52.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:89:0) after 1m0s
[07:01:52.755] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:89:0)
[07:01:52.755] Timer tick, asking Buildbucket for the build status
[07:01:55.283] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:55.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:90:0) after 1m0s
[07:02:55.352] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:90:0)
[07:02:55.352] Timer tick, asking Buildbucket for the build status
[07:02:56.070] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:56.070] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:91:0) after 1m0s
[07:03:56.046] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:91:0)
[07:03:56.046] Timer tick, asking Buildbucket for the build status
[07:03:56.230] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:56.230] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:92:0) after 1m0s
[07:04:56.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:92:0)
[07:04:56.405] Timer tick, asking Buildbucket for the build status
[07:04:56.498] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:56.498] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:93:0) after 1m0s
[07:05:56.516] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:93:0)
[07:05:56.516] Timer tick, asking Buildbucket for the build status
[07:05:58.336] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:58.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:94:0) after 1m0s
[07:06:58.354] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:94:0)
[07:06:58.354] Timer tick, asking Buildbucket for the build status
[07:07:00.223] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:00.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:95:0) after 1m0s
[07:08:00.314] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:95:0)
[07:08:00.314] Timer tick, asking Buildbucket for the build status
[07:08:01.728] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:01.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:96:0) after 1m0s
[07:09:01.771] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:96:0)
[07:09:01.771] Timer tick, asking Buildbucket for the build status
[07:09:01.952] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:01.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:97:0) after 1m0s
[07:10:01.953] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:97:0)
[07:10:01.953] Timer tick, asking Buildbucket for the build status
[07:10:02.426] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:02.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:98:0) after 1m0s
[07:11:02.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:98:0)
[07:11:02.494] Timer tick, asking Buildbucket for the build status
[07:11:02.579] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:02.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:99:0) after 1m0s
[07:12:02.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:99:0)
[07:12:02.808] Timer tick, asking Buildbucket for the build status
[07:12:03.742] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:03.742] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:100:0) after 1m0s
[07:13:03.770] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:100:0)
[07:13:03.770] Timer tick, asking Buildbucket for the build status
[07:13:10.778] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:10.778] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:101:0) after 1m0s
[07:14:10.806] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:101:0)
[07:14:10.806] Timer tick, asking Buildbucket for the build status
[07:14:12.246] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:12.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:102:0) after 1m0s
[07:15:12.248] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:102:0)
[07:15:12.248] Timer tick, asking Buildbucket for the build status
[07:15:15.174] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:15.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:103:0) after 1m0s
[07:16:15.161] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:103:0)
[07:16:15.161] Timer tick, asking Buildbucket for the build status
[07:16:18.210] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:18.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:104:0) after 1m0s
[07:17:18.229] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:104:0)
[07:17:18.229] Timer tick, asking Buildbucket for the build status
[07:17:18.391] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:18.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:105:0) after 1m0s
[07:18:18.552] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:105:0)
[07:18:18.552] Timer tick, asking Buildbucket for the build status
[07:18:18.688] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:18.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:106:0) after 1m0s
[07:19:18.787] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:106:0)
[07:19:18.787] Timer tick, asking Buildbucket for the build status
[07:19:19.068] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:19.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:107:0) after 1m0s
[07:20:19.089] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:107:0)
[07:20:19.089] Timer tick, asking Buildbucket for the build status
[07:20:19.167] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:19.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:108:0) after 1m0s
[07:21:19.185] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:108:0)
[07:21:19.185] Timer tick, asking Buildbucket for the build status
[07:21:19.519] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:19.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:109:0) after 1m0s
[07:22:19.582] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:109:0)
[07:22:19.582] Timer tick, asking Buildbucket for the build status
[07:22:20.330] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:20.330] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:110:0) after 1m0s
[07:23:20.383] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:110:0)
[07:23:20.383] Timer tick, asking Buildbucket for the build status
[07:23:21.082] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:21.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:111:0) after 1m0s
[07:24:21.144] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:111:0)
[07:24:21.144] Timer tick, asking Buildbucket for the build status
[07:24:22.429] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:22.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:112:0) after 1m0s
[07:25:22.481] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:112:0)
[07:25:22.481] Timer tick, asking Buildbucket for the build status
[07:25:26.783] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:26.783] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:113:0) after 1m0s
[07:26:26.803] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:113:0)
[07:26:26.803] Timer tick, asking Buildbucket for the build status
[07:26:26.871] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:26.871] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:114:0) after 1m0s
[07:27:26.900] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:114:0)
[07:27:26.900] Timer tick, asking Buildbucket for the build status
[07:27:26.972] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:26.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:115:0) after 1m0s
[07:28:27.032] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:115:0)
[07:28:27.032] Timer tick, asking Buildbucket for the build status
[07:28:27.123] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:27.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:116:0) after 1m0s
[07:29:27.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:116:0)
[07:29:27.251] Timer tick, asking Buildbucket for the build status
[07:29:27.310] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:27.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:117:0) after 1m0s
[07:30:27.374] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:117:0)
[07:30:27.374] Timer tick, asking Buildbucket for the build status
[07:30:27.470] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:27.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:118:0) after 1m0s
[07:31:27.613] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:118:0)
[07:31:27.613] Timer tick, asking Buildbucket for the build status
[07:31:27.669] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:27.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:119:0) after 1m0s
[07:32:27.790] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:119:0)
[07:32:27.790] Timer tick, asking Buildbucket for the build status
[07:32:27.886] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:27.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:120:0) after 1m0s
[07:33:27.971] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:120:0)
[07:33:27.971] Timer tick, asking Buildbucket for the build status
[07:33:28.035] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:28.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:121:0) after 1m0s
[07:34:28.076] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:121:0)
[07:34:28.076] Timer tick, asking Buildbucket for the build status
[07:34:29.483] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:29.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:122:0) after 1m0s
[07:35:29.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:122:0)
[07:35:29.517] Timer tick, asking Buildbucket for the build status
[07:35:29.649] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:29.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:123:0) after 1m0s
[07:36:29.656] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:123:0)
[07:36:29.656] Timer tick, asking Buildbucket for the build status
[07:36:29.939] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:29.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:124:0) after 1m0s
[07:37:29.926] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:124:0)
[07:37:29.926] Timer tick, asking Buildbucket for the build status
[07:37:30.080] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:30.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:125:0) after 1m0s
[07:38:30.172] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:125:0)
[07:38:30.172] Timer tick, asking Buildbucket for the build status
[07:38:30.728] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:30.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:126:0) after 1m0s
[07:39:30.715] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:126:0)
[07:39:30.715] Timer tick, asking Buildbucket for the build status
[07:39:30.783] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:30.784] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:127:0) after 1m0s
[07:40:31.048] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:127:0)
[07:40:31.048] Timer tick, asking Buildbucket for the build status
[07:40:31.518] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:31.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:128:0) after 1m0s
[07:41:31.563] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:128:0)
[07:41:31.563] Timer tick, asking Buildbucket for the build status
[07:41:31.646] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:31.646] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:129:0) after 1m0s
[07:42:31.821] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:129:0)
[07:42:31.821] Timer tick, asking Buildbucket for the build status
[07:42:32.051] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:32.051] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:130:0) after 1m0s
[07:43:32.068] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:130:0)
[07:43:32.068] Timer tick, asking Buildbucket for the build status
[07:43:32.156] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:32.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:131:0) after 1m0s
[07:44:32.241] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:131:0)
[07:44:32.241] Timer tick, asking Buildbucket for the build status
[07:44:32.708] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:32.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:132:0) after 1m0s
[07:45:32.765] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:132:0)
[07:45:32.765] Timer tick, asking Buildbucket for the build status
[07:45:34.185] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:34.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:133:0) after 1m0s
[07:46:34.261] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:133:0)
[07:46:34.261] Timer tick, asking Buildbucket for the build status
[07:46:35.488] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:35.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:134:0) after 1m0s
[07:47:35.559] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:134:0)
[07:47:35.559] Timer tick, asking Buildbucket for the build status
[07:47:35.873] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:35.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:135:0) after 1m0s
[07:48:35.925] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:135:0)
[07:48:35.926] Timer tick, asking Buildbucket for the build status
[07:48:35.988] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:35.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:136:0) after 1m0s
[07:49:36.040] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:136:0)
[07:49:36.040] Timer tick, asking Buildbucket for the build status
[07:49:37.445] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:37.445] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:137:0) after 1m0s
[07:50:37.586] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:137:0)
[07:50:37.586] Timer tick, asking Buildbucket for the build status
[07:50:40.786] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:40.786] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:138:0) after 1m0s
[07:51:40.867] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:138:0)
[07:51:40.867] Timer tick, asking Buildbucket for the build status
[07:51:40.937] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:40.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:139:0) after 1m0s
[07:52:40.965] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:139:0)
[07:52:40.965] Timer tick, asking Buildbucket for the build status
[07:52:42.462] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:42.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:140:0) after 1m0s
[07:53:42.482] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:140:0)
[07:53:42.482] Timer tick, asking Buildbucket for the build status
[07:53:42.800] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:42.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:141:0) after 1m0s
[07:54:42.891] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:141:0)
[07:54:42.891] Timer tick, asking Buildbucket for the build status
[07:54:45.157] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:45.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:142:0) after 1m0s
[07:55:45.181] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:142:0)
[07:55:45.181] Timer tick, asking Buildbucket for the build status
[07:55:45.548] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:45.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:143:0) after 1m0s
[07:56:45.635] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:143:0)
[07:56:45.635] Timer tick, asking Buildbucket for the build status
[07:56:46.725] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:46.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:144:0) after 1m0s
[07:57:46.783] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:144:0)
[07:57:46.783] Timer tick, asking Buildbucket for the build status
[07:57:48.045] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:48.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:145:0) after 1m0s
[07:58:48.142] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:145:0)
[07:58:48.142] Timer tick, asking Buildbucket for the build status
[07:58:51.091] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:51.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:146:0) after 1m0s
[07:59:51.151] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:146:0)
[07:59:51.151] Timer tick, asking Buildbucket for the build status
[07:59:51.484] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:51.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:147:0) after 1m0s
[08:00:51.478] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:147:0)
[08:00:51.478] Timer tick, asking Buildbucket for the build status
[08:00:51.561] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:51.561] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:148:0) after 1m0s
[08:01:51.664] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:148:0)
[08:01:51.664] Timer tick, asking Buildbucket for the build status
[08:01:53.730] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:53.730] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:149:0) after 1m0s
[08:02:53.760] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:149:0)
[08:02:53.760] Timer tick, asking Buildbucket for the build status
[08:02:54.166] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:54.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:150:0) after 1m0s
[08:03:54.176] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:150:0)
[08:03:54.177] Timer tick, asking Buildbucket for the build status
[08:03:54.388] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:54.388] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:151:0) after 1m0s
[08:04:54.424] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:151:0)
[08:04:54.424] Timer tick, asking Buildbucket for the build status
[08:04:56.464] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:56.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:152:0) after 1m0s
[08:05:56.473] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:152:0)
[08:05:56.473] Timer tick, asking Buildbucket for the build status
[08:05:56.570] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:56.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:153:0) after 1m0s
[08:06:56.660] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:153:0)
[08:06:56.660] Timer tick, asking Buildbucket for the build status
[08:06:56.714] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:56.714] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:154:0) after 1m0s
[08:07:56.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:154:0)
[08:07:56.737] Timer tick, asking Buildbucket for the build status
[08:07:56.885] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:56.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:155:0) after 1m0s
[08:08:56.977] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:155:0)
[08:08:56.977] Timer tick, asking Buildbucket for the build status
[08:08:57.136] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:57.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:156:0) after 1m0s
[08:09:57.257] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:156:0)
[08:09:57.257] Timer tick, asking Buildbucket for the build status
[08:09:57.463] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:57.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:157:0) after 1m0s
[08:10:57.501] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:157:0)
[08:10:57.501] Timer tick, asking Buildbucket for the build status
[08:10:57.573] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:57.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:158:0) after 1m0s
[08:11:57.594] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:158:0)
[08:11:57.594] Timer tick, asking Buildbucket for the build status
[08:11:57.927] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:57.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:159:0) after 1m0s
[08:12:58.084] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:159:0)
[08:12:58.084] Timer tick, asking Buildbucket for the build status
[08:12:58.145] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:58.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:160:0) after 1m0s
[08:13:58.167] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:160:0)
[08:13:58.167] Timer tick, asking Buildbucket for the build status
[08:13:59.134] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:59.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:161:0) after 1m0s
[08:14:59.209] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:161:0)
[08:14:59.209] Timer tick, asking Buildbucket for the build status
[08:14:59.661] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:59.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:162:0) after 1m0s
[08:15:59.730] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:162:0)
[08:15:59.730] Timer tick, asking Buildbucket for the build status
[08:16:00.145] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:00.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:163:0) after 1m0s
[08:17:00.170] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:163:0)
[08:17:00.170] Timer tick, asking Buildbucket for the build status
[08:17:00.689] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:00.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:164:0) after 1m0s
[08:18:00.709] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:164:0)
[08:18:00.709] Timer tick, asking Buildbucket for the build status
[08:18:00.902] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:00.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:165:0) after 1m0s
[08:19:00.977] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:165:0)
[08:19:00.977] Timer tick, asking Buildbucket for the build status
[08:19:01.383] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:01.383] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:166:0) after 1m0s
[08:20:01.406] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:166:0)
[08:20:01.406] Timer tick, asking Buildbucket for the build status
[08:20:01.574] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:01.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:167:0) after 1m0s
[08:21:01.796] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:167:0)
[08:21:01.796] Timer tick, asking Buildbucket for the build status
[08:21:01.873] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:01.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:168:0) after 1m0s
[08:22:01.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:168:0)
[08:22:01.934] Timer tick, asking Buildbucket for the build status
[08:22:02.025] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:02.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:169:0) after 1m0s
[08:23:02.067] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:169:0)
[08:23:02.067] Timer tick, asking Buildbucket for the build status
[08:23:02.136] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:02.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:170:0) after 1m0s
[08:24:02.157] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:170:0)
[08:24:02.157] Timer tick, asking Buildbucket for the build status
[08:24:02.417] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:02.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:171:0) after 1m0s
[08:25:02.418] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:171:0)
[08:25:02.418] Timer tick, asking Buildbucket for the build status
[08:25:03.000] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:03.000] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:172:0) after 1m0s
[08:26:03.030] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:172:0)
[08:26:03.030] Timer tick, asking Buildbucket for the build status
[08:26:03.108] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:03.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:173:0) after 1m0s
[08:27:03.154] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:173:0)
[08:27:03.154] Timer tick, asking Buildbucket for the build status
[08:27:03.247] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:03.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:174:0) after 1m0s
[08:28:03.250] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:174:0)
[08:28:03.250] Timer tick, asking Buildbucket for the build status
[08:28:03.383] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:03.383] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:175:0) after 1m0s
[08:29:03.438] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:175:0)
[08:29:03.438] Timer tick, asking Buildbucket for the build status
[08:29:04.119] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:04.119] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:176:0) after 1m0s
[08:30:04.145] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:176:0)
[08:30:04.145] Timer tick, asking Buildbucket for the build status
[08:30:04.556] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:04.556] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:177:0) after 1m0s
[08:31:04.575] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:177:0)
[08:31:04.575] Timer tick, asking Buildbucket for the build status
[08:31:04.682] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:04.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:178:0) after 1m0s
[08:32:04.703] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:178:0)
[08:32:04.703] Timer tick, asking Buildbucket for the build status
[08:32:05.135] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:05.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:179:0) after 1m0s
[08:33:05.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:179:0)
[08:33:05.156] Timer tick, asking Buildbucket for the build status
[08:33:05.220] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:05.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:180:0) after 1m0s
[08:34:05.273] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:180:0)
[08:34:05.273] Timer tick, asking Buildbucket for the build status
[08:34:05.450] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:05.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:181:0) after 1m0s
[08:35:05.497] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:181:0)
[08:35:05.497] Timer tick, asking Buildbucket for the build status
[08:35:05.601] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:05.601] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:182:0) after 1m0s
[08:36:05.760] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:182:0)
[08:36:05.760] Timer tick, asking Buildbucket for the build status
[08:36:06.737] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:06.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:183:0) after 1m0s
[08:37:06.806] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:183:0)
[08:37:06.806] Timer tick, asking Buildbucket for the build status
[08:37:06.926] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:06.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:184:0) after 1m0s
[08:38:06.952] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:184:0)
[08:38:06.952] Timer tick, asking Buildbucket for the build status
[08:38:07.034] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:07.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:185:0) after 1m0s
[08:39:07.092] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:185:0)
[08:39:07.092] Timer tick, asking Buildbucket for the build status
[08:39:07.324] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:07.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:186:0) after 1m0s
[08:40:07.425] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:186:0)
[08:40:07.425] Timer tick, asking Buildbucket for the build status
[08:40:07.531] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:07.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:187:0) after 1m0s
[08:41:07.586] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:187:0)
[08:41:07.586] Timer tick, asking Buildbucket for the build status
[08:41:07.817] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:07.817] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:188:0) after 1m0s
[08:42:07.851] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:188:0)
[08:42:07.851] Timer tick, asking Buildbucket for the build status
[08:42:07.917] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:07.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:189:0) after 1m0s
[08:43:07.956] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:189:0)
[08:43:07.956] Timer tick, asking Buildbucket for the build status
[08:43:08.023] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:08.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:190:0) after 1m0s
[08:44:08.090] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:190:0)
[08:44:08.090] Timer tick, asking Buildbucket for the build status
[08:44:08.167] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:08.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:191:0) after 1m0s
[08:45:08.202] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:191:0)
[08:45:08.202] Timer tick, asking Buildbucket for the build status
[08:45:08.392] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:08.392] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:192:0) after 1m0s
[08:46:08.451] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:192:0)
[08:46:08.451] Timer tick, asking Buildbucket for the build status
[08:46:08.522] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:08.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:193:0) after 1m0s
[08:47:08.547] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:193:0)
[08:47:08.547] Timer tick, asking Buildbucket for the build status
[08:47:08.821] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:08.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:194:0) after 1m0s
[08:48:08.857] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:194:0)
[08:48:08.857] Timer tick, asking Buildbucket for the build status
[08:48:08.928] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:08.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:195:0) after 1m0s
[08:49:08.963] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:195:0)
[08:49:08.963] Timer tick, asking Buildbucket for the build status
[08:49:09.363] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:09.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:196:0) after 1m0s
[08:50:09.389] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:196:0)
[08:50:09.389] Timer tick, asking Buildbucket for the build status
[08:50:10.006] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:10.006] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:197:0) after 1m0s
[08:51:10.029] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:197:0)
[08:51:10.029] Timer tick, asking Buildbucket for the build status
[08:51:10.405] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:10.405] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:198:0) after 1m0s
[08:52:10.424] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:198:0)
[08:52:10.424] Timer tick, asking Buildbucket for the build status
[08:52:10.487] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:10.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:199:0) after 1m0s
[08:53:10.557] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:199:0)
[08:53:10.557] Timer tick, asking Buildbucket for the build status
[08:53:10.617] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:10.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:200:0) after 1m0s
[08:54:10.602] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:200:0)
[08:54:10.602] Timer tick, asking Buildbucket for the build status
[08:54:10.828] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:10.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:201:0) after 1m0s
[08:55:10.897] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:201:0)
[08:55:10.897] Timer tick, asking Buildbucket for the build status
[08:55:11.136] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:11.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:202:0) after 1m0s
[08:56:11.193] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:202:0)
[08:56:11.193] Timer tick, asking Buildbucket for the build status
[08:56:12.017] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:12.017] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:203:0) after 1m0s
[08:57:12.018] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:203:0)
[08:57:12.018] Timer tick, asking Buildbucket for the build status
[08:57:12.192] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:12.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:204:0) after 1m0s
[08:58:12.255] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:204:0)
[08:58:12.255] Timer tick, asking Buildbucket for the build status
[08:58:12.340] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:12.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:205:0) after 1m0s
[08:59:12.392] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:205:0)
[08:59:12.392] Timer tick, asking Buildbucket for the build status
[08:59:12.535] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:12.535] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:206:0) after 1m0s
[09:00:12.557] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:206:0)
[09:00:12.557] Timer tick, asking Buildbucket for the build status
[09:00:12.661] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:12.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:207:0) after 1m0s
[09:01:12.683] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:207:0)
[09:01:12.683] Timer tick, asking Buildbucket for the build status
[09:01:12.757] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:12.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:208:0) after 1m0s
[09:02:12.858] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:208:0)
[09:02:12.858] Timer tick, asking Buildbucket for the build status
[09:02:13.124] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:13.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:209:0) after 1m0s
[09:03:13.151] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:209:0)
[09:03:13.151] Timer tick, asking Buildbucket for the build status
[09:03:13.435] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:13.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:210:0) after 1m0s
[09:04:13.474] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:210:0)
[09:04:13.474] Timer tick, asking Buildbucket for the build status
[09:04:13.897] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:13.897] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:211:0) after 1m0s
[09:05:13.932] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:211:0)
[09:05:13.932] Timer tick, asking Buildbucket for the build status
[09:05:14.441] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:14.441] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:212:0) after 1m0s
[09:06:14.518] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:212:0)
[09:06:14.518] Timer tick, asking Buildbucket for the build status
[09:06:14.584] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:14.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:213:0) after 1m0s
[09:07:14.693] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:213:0)
[09:07:14.693] Timer tick, asking Buildbucket for the build status
[09:07:14.769] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:14.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:214:0) after 1m0s
[09:08:14.825] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:214:0)
[09:08:14.825] Timer tick, asking Buildbucket for the build status
[09:08:15.196] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:15.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:215:0) after 1m0s
[09:09:15.221] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:215:0)
[09:09:15.221] Timer tick, asking Buildbucket for the build status
[09:09:15.385] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:15.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:216:0) after 1m0s
[09:10:15.434] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:216:0)
[09:10:15.434] Timer tick, asking Buildbucket for the build status
[09:10:15.941] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:15.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:217:0) after 1m0s
[09:11:16.006] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:217:0)
[09:11:16.006] Timer tick, asking Buildbucket for the build status
[09:11:16.230] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:16.230] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:218:0) after 1m0s
[09:12:16.295] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:218:0)
[09:12:16.295] Timer tick, asking Buildbucket for the build status
[09:12:16.380] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:16.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:219:0) after 1m0s
[09:13:16.419] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:219:0)
[09:13:16.419] Timer tick, asking Buildbucket for the build status
[09:13:16.498] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:16.498] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:220:0) after 1m0s
[09:14:16.560] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:220:0)
[09:14:16.560] Timer tick, asking Buildbucket for the build status
[09:14:16.625] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:16.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:221:0) after 1m0s
[09:15:16.743] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:221:0)
[09:15:16.743] Timer tick, asking Buildbucket for the build status
[09:15:16.848] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:16.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:222:0) after 1m0s
[09:16:16.887] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:222:0)
[09:16:16.887] Timer tick, asking Buildbucket for the build status
[09:16:17.053] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:17.053] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:223:0) after 1m0s
[09:17:17.165] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:223:0)
[09:17:17.165] Timer tick, asking Buildbucket for the build status
[09:17:17.352] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:17.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:224:0) after 1m0s
[09:18:17.497] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:224:0)
[09:18:17.497] Timer tick, asking Buildbucket for the build status
[09:18:17.565] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:17.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:225:0) after 1m0s
[09:19:17.704] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:225:0)
[09:19:17.705] Timer tick, asking Buildbucket for the build status
[09:19:17.898] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:17.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:226:0) after 1m0s
[09:20:17.922] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:226:0)
[09:20:17.922] Timer tick, asking Buildbucket for the build status
[09:20:18.674] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:18.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:227:0) after 1m0s
[09:21:18.774] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:227:0)
[09:21:18.774] Timer tick, asking Buildbucket for the build status
[09:21:18.840] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:18.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:228:0) after 1m0s
[09:22:18.988] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:228:0)
[09:22:18.988] Timer tick, asking Buildbucket for the build status
[09:22:19.211] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:19.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:229:0) after 1m0s
[09:23:19.296] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:229:0)
[09:23:19.296] Timer tick, asking Buildbucket for the build status
[09:23:19.389] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:19.389] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:230:0) after 1m0s
[09:24:19.438] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:230:0)
[09:24:19.438] Timer tick, asking Buildbucket for the build status
[09:24:19.539] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:19.539] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:231:0) after 1m0s
[09:25:19.560] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:231:0)
[09:25:19.560] Timer tick, asking Buildbucket for the build status
[09:25:19.726] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:19.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:232:0) after 1m0s
[09:26:19.784] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:232:0)
[09:26:19.784] Timer tick, asking Buildbucket for the build status
[09:26:20.042] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:20.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:233:0) after 1m0s
[09:27:20.109] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:233:0)
[09:27:20.109] Timer tick, asking Buildbucket for the build status
[09:27:20.331] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:20.331] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:234:0) after 1m0s
[09:28:20.357] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:234:0)
[09:28:20.357] Timer tick, asking Buildbucket for the build status
[09:28:20.640] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:20.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:235:0) after 1m0s
[09:29:20.720] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:235:0)
[09:29:20.720] Timer tick, asking Buildbucket for the build status
[09:29:20.902] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:20.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:236:0) after 1m0s
[09:30:20.984] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:236:0)
[09:30:20.984] Timer tick, asking Buildbucket for the build status
[09:30:21.178] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:21.178] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:237:0) after 1m0s
[09:31:21.205] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:237:0)
[09:31:21.205] Timer tick, asking Buildbucket for the build status
[09:31:21.490] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:21.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:238:0) after 1m0s
[09:32:21.542] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:238:0)
[09:32:21.542] Timer tick, asking Buildbucket for the build status
[09:32:21.652] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:21.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:239:0) after 1m0s
[09:33:21.729] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:239:0)
[09:33:21.729] Timer tick, asking Buildbucket for the build status
[09:33:22.009] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:22.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:240:0) after 1m0s
[09:34:22.045] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:240:0)
[09:34:22.045] Timer tick, asking Buildbucket for the build status
[09:34:22.117] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:22.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:241:0) after 1m0s
[09:35:22.172] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:241:0)
[09:35:22.172] Timer tick, asking Buildbucket for the build status
[09:35:22.340] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:22.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:242:0) after 1m0s
[09:36:22.410] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:242:0)
[09:36:22.410] Timer tick, asking Buildbucket for the build status
[09:36:22.705] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:22.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:243:0) after 1m0s
[09:37:22.742] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:243:0)
[09:37:22.742] Timer tick, asking Buildbucket for the build status
[09:37:22.808] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:22.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:244:0) after 1m0s
[09:38:22.804] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:244:0)
[09:38:22.804] Timer tick, asking Buildbucket for the build status
[09:38:23.875] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:23.875] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:245:0) after 1m0s
[09:39:23.869] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:245:0)
[09:39:23.869] Timer tick, asking Buildbucket for the build status
[09:39:24.192] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:24.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:246:0) after 1m0s
[09:40:24.219] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:246:0)
[09:40:24.219] Timer tick, asking Buildbucket for the build status
[09:40:24.310] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:24.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:247:0) after 1m0s
[09:41:24.334] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:247:0)
[09:41:24.334] Timer tick, asking Buildbucket for the build status
[09:41:24.451] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:24.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:248:0) after 1m0s
[09:42:24.476] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:248:0)
[09:42:24.476] Timer tick, asking Buildbucket for the build status
[09:42:24.843] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:24.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:249:0) after 1m0s
[09:43:24.866] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:249:0)
[09:43:24.866] Timer tick, asking Buildbucket for the build status
[09:43:24.919] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:24.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:250:0) after 1m0s
[09:44:24.946] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:250:0)
[09:44:24.946] Timer tick, asking Buildbucket for the build status
[09:44:25.019] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:25.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:251:0) after 1m0s
[09:45:24.997] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:251:0)
[09:45:24.997] Timer tick, asking Buildbucket for the build status
[09:45:25.315] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:25.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:252:0) after 1m0s
[09:46:25.341] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:252:0)
[09:46:25.341] Timer tick, asking Buildbucket for the build status
[09:46:25.402] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:25.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:253:0) after 1m0s
[09:47:25.425] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:253:0)
[09:47:25.425] Timer tick, asking Buildbucket for the build status
[09:47:25.522] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:25.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:254:0) after 1m0s
[09:48:25.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:254:0)
[09:48:25.544] Timer tick, asking Buildbucket for the build status
[09:48:26.168] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:26.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:255:0) after 1m0s
[09:49:26.220] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:255:0)
[09:49:26.220] Timer tick, asking Buildbucket for the build status
[09:49:26.281] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:26.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:256:0) after 1m0s
[09:50:26.307] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:256:0)
[09:50:26.308] Timer tick, asking Buildbucket for the build status
[09:50:26.464] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:26.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:257:0) after 1m0s
[09:51:26.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:257:0)
[09:51:26.487] Timer tick, asking Buildbucket for the build status
[09:51:26.571] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:26.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:258:0) after 1m0s
[09:52:26.638] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:258:0)
[09:52:26.638] Timer tick, asking Buildbucket for the build status
[09:52:26.706] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:26.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:259:0) after 1m0s
[09:53:26.733] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:259:0)
[09:53:26.733] Timer tick, asking Buildbucket for the build status
[09:53:26.794] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:26.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:260:0) after 1m0s
[09:54:26.783] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:260:0)
[09:54:26.783] Timer tick, asking Buildbucket for the build status
[09:54:26.924] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:26.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:261:0) after 1m0s
[09:55:26.944] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:261:0)
[09:55:26.944] Timer tick, asking Buildbucket for the build status
[09:55:27.342] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:27.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:262:0) after 1m0s
[09:56:27.381] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:262:0)
[09:56:27.381] Timer tick, asking Buildbucket for the build status
[09:56:27.460] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:27.460] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:263:0) after 1m0s
[09:57:27.533] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:263:0)
[09:57:27.533] Timer tick, asking Buildbucket for the build status
[09:57:27.611] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:27.611] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:264:0) after 1m0s
[09:58:27.676] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:264:0)
[09:58:27.676] Timer tick, asking Buildbucket for the build status
[09:58:27.750] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:27.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:265:0) after 1m0s
[09:59:27.837] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:265:0)
[09:59:27.837] Timer tick, asking Buildbucket for the build status
[09:59:28.099] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:28.099] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:266:0) after 1m0s
[10:00:28.222] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:266:0)
[10:00:28.222] Timer tick, asking Buildbucket for the build status
[10:00:29.562] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:29.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:267:0) after 1m0s
[10:01:29.624] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:267:0)
[10:01:29.624] Timer tick, asking Buildbucket for the build status
[10:01:29.795] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:29.795] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:268:0) after 1m0s
[10:02:30.019] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:268:0)
[10:02:30.019] Timer tick, asking Buildbucket for the build status
[10:02:30.155] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:30.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:269:0) after 1m0s
[10:03:30.324] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:269:0)
[10:03:30.324] Timer tick, asking Buildbucket for the build status
[10:03:30.380] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:30.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:270:0) after 1m0s
[10:04:30.482] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:270:0)
[10:04:30.482] Timer tick, asking Buildbucket for the build status
[10:04:30.693] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:30.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:271:0) after 1m0s
[10:05:30.765] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:271:0)
[10:05:30.765] Timer tick, asking Buildbucket for the build status
[10:05:30.881] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:30.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:272:0) after 1m0s
[10:06:30.930] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:272:0)
[10:06:30.930] Timer tick, asking Buildbucket for the build status
[10:06:30.991] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:30.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:273:0) after 1m0s
[10:07:31.016] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:273:0)
[10:07:31.016] Timer tick, asking Buildbucket for the build status
[10:07:31.267] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:31.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:274:0) after 1m0s
[10:08:31.361] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:274:0)
[10:08:31.361] Timer tick, asking Buildbucket for the build status
[10:08:31.538] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:31.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:275:0) after 1m0s
[10:09:31.552] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:275:0)
[10:09:31.552] Timer tick, asking Buildbucket for the build status
[10:09:31.649] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:31.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:276:0) after 1m0s
[10:10:31.654] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:276:0)
[10:10:31.654] Timer tick, asking Buildbucket for the build status
[10:10:31.857] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:31.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:277:0) after 1m0s
[10:11:31.884] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:277:0)
[10:11:31.884] Timer tick, asking Buildbucket for the build status
[10:11:32.238] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:32.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:278:0) after 1m0s
[10:12:32.266] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:278:0)
[10:12:32.266] Timer tick, asking Buildbucket for the build status
[10:12:32.357] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:32.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:279:0) after 1m0s
[10:13:32.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:279:0)
[10:13:32.394] Timer tick, asking Buildbucket for the build status
[10:13:32.479] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:32.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:280:0) after 1m0s
[10:14:32.686] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:280:0)
[10:14:32.686] Timer tick, asking Buildbucket for the build status
[10:14:32.805] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:32.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:281:0) after 1m0s
[10:15:33.001] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:281:0)
[10:15:33.001] Timer tick, asking Buildbucket for the build status
[10:15:33.495] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:33.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:282:0) after 1m0s
[10:16:33.538] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:282:0)
[10:16:33.538] Timer tick, asking Buildbucket for the build status
[10:16:33.638] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:33.638] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:283:0) after 1m0s
[10:17:33.774] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:283:0)
[10:17:33.774] Timer tick, asking Buildbucket for the build status
[10:17:34.993] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:34.993] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:284:0) after 1m0s
[10:18:34.982] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:284:0)
[10:18:34.982] Timer tick, asking Buildbucket for the build status
[10:18:35.279] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:35.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:285:0) after 1m0s
[10:19:35.312] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:285:0)
[10:19:35.312] Timer tick, asking Buildbucket for the build status
[10:19:35.434] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:35.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:286:0) after 1m0s
[10:20:35.502] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:286:0)
[10:20:35.502] Timer tick, asking Buildbucket for the build status
[10:20:35.626] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:35.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:287:0) after 1m0s
[10:21:35.651] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:287:0)
[10:21:35.651] Timer tick, asking Buildbucket for the build status
[10:21:35.707] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:35.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:288:0) after 1m0s
[10:22:35.790] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:288:0)
[10:22:35.790] Timer tick, asking Buildbucket for the build status
[10:22:35.855] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:35.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:289:0) after 1m0s
[10:23:35.922] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:289:0)
[10:23:35.922] Timer tick, asking Buildbucket for the build status
[10:23:35.983] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:35.983] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:290:0) after 1m0s
[10:24:36.012] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:290:0)
[10:24:36.012] Timer tick, asking Buildbucket for the build status
[10:24:36.075] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:36.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:291:0) after 1m0s
[10:25:36.102] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:291:0)
[10:25:36.102] Timer tick, asking Buildbucket for the build status
[10:25:36.219] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:36.219] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:292:0) after 1m0s
[10:26:36.305] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:292:0)
[10:26:36.305] Timer tick, asking Buildbucket for the build status
[10:26:36.369] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:36.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:293:0) after 1m0s
[10:27:36.488] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:293:0)
[10:27:36.488] Timer tick, asking Buildbucket for the build status
[10:27:36.620] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:36.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:294:0) after 1m0s
[10:28:36.676] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:294:0)
[10:28:36.676] Timer tick, asking Buildbucket for the build status
[10:28:36.727] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:36.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:295:0) after 1m0s
[10:29:36.799] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:295:0)
[10:29:36.799] Timer tick, asking Buildbucket for the build status
[10:29:36.859] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:36.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:296:0) after 1m0s
[10:30:36.993] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:296:0)
[10:30:36.993] Timer tick, asking Buildbucket for the build status
[10:30:37.433] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:37.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:297:0) after 1m0s
[10:31:37.483] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:297:0)
[10:31:37.483] Timer tick, asking Buildbucket for the build status
[10:31:37.573] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:37.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:298:0) after 1m0s
[10:32:46.147] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:298:0)
[10:32:46.147] Timer tick, asking Buildbucket for the build status
[10:32:46.997] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:46.997] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:299:0) after 1m0s
[10:33:47.023] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:299:0)
[10:33:47.023] Timer tick, asking Buildbucket for the build status
[10:33:47.309] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:47.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:300:0) after 1m0s
[10:34:47.382] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:300:0)
[10:34:47.382] Timer tick, asking Buildbucket for the build status
[10:34:47.470] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:47.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:301:0) after 1m0s
[10:35:47.496] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:301:0)
[10:35:47.496] Timer tick, asking Buildbucket for the build status
[10:35:47.588] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:47.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:302:0) after 1m0s
[10:36:47.657] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:302:0)
[10:36:47.657] Timer tick, asking Buildbucket for the build status
[10:36:47.734] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:47.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:303:0) after 1m0s
[10:37:47.758] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:303:0)
[10:37:47.758] Timer tick, asking Buildbucket for the build status
[10:37:47.819] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:47.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:304:0) after 1m0s
[10:38:47.858] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:304:0)
[10:38:47.858] Timer tick, asking Buildbucket for the build status
[10:38:48.219] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:48.219] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:305:0) after 1m0s
[10:39:48.249] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:305:0)
[10:39:48.249] Timer tick, asking Buildbucket for the build status
[10:39:48.698] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:48.698] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:306:0) after 1m0s
[10:40:48.772] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:306:0)
[10:40:48.772] Timer tick, asking Buildbucket for the build status
[10:40:49.011] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:49.011] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:307:0) after 1m0s
[10:41:49.181] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:307:0)
[10:41:49.181] Timer tick, asking Buildbucket for the build status
[10:41:50.289] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:50.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:308:0) after 1m0s
[10:42:50.378] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:308:0)
[10:42:50.378] Timer tick, asking Buildbucket for the build status
[10:42:50.449] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:50.449] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:309:0) after 1m0s
[10:43:50.554] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:309:0)
[10:43:50.554] Timer tick, asking Buildbucket for the build status
[10:43:51.450] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:51.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:310:0) after 1m0s
[10:44:51.485] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:310:0)
[10:44:51.485] Timer tick, asking Buildbucket for the build status
[10:44:51.740] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:51.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:311:0) after 1m0s
[10:45:51.893] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:311:0)
[10:45:51.893] Timer tick, asking Buildbucket for the build status
[10:45:52.085] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:52.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:312:0) after 1m0s
[10:46:52.117] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:312:0)
[10:46:52.117] Timer tick, asking Buildbucket for the build status
[10:46:52.631] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:52.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:313:0) after 1m0s
[10:47:52.713] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:313:0)
[10:47:52.713] Timer tick, asking Buildbucket for the build status
[10:47:52.785] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:52.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:314:0) after 1m0s
[10:48:52.864] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:314:0)
[10:48:52.864] Timer tick, asking Buildbucket for the build status
[10:48:52.944] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:52.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:315:0) after 1m0s
[10:49:52.985] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:315:0)
[10:49:52.985] Timer tick, asking Buildbucket for the build status
[10:49:53.092] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:53.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:316:0) after 1m0s
[10:50:53.125] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:316:0)
[10:50:53.125] Timer tick, asking Buildbucket for the build status
[10:50:53.412] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:53.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:317:0) after 1m0s
[10:51:53.438] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:317:0)
[10:51:53.438] Timer tick, asking Buildbucket for the build status
[10:51:53.835] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:53.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:318:0) after 1m0s
[10:52:53.910] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:318:0)
[10:52:53.910] Timer tick, asking Buildbucket for the build status
[10:52:53.995] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:53.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:319:0) after 1m0s
[10:53:54.119] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:319:0)
[10:53:54.119] Timer tick, asking Buildbucket for the build status
[10:53:54.246] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:54.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:320:0) after 1m0s
[10:54:54.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:320:0)
[10:54:54.360] Timer tick, asking Buildbucket for the build status
[10:54:54.586] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:54.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:321:0) after 1m0s
[10:55:54.626] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:321:0)
[10:55:54.626] Timer tick, asking Buildbucket for the build status
[10:55:56.386] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:56.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:322:0) after 1m0s
[10:56:56.473] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:322:0)
[10:56:56.473] Timer tick, asking Buildbucket for the build status
[10:56:56.705] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:56.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:323:0) after 1m0s
[10:57:56.975] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:323:0)
[10:57:56.975] Timer tick, asking Buildbucket for the build status
[10:57:57.069] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:57.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:324:0) after 1m0s
[10:58:57.381] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:324:0)
[10:58:57.381] Timer tick, asking Buildbucket for the build status
[10:58:57.449] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:57.449] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:325:0) after 1m0s
[10:59:57.541] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:325:0)
[10:59:57.541] Timer tick, asking Buildbucket for the build status
[10:59:57.656] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:57.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:326:0) after 1m0s
[11:00:57.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:326:0)
[11:00:57.738] Timer tick, asking Buildbucket for the build status
[11:00:57.997] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:57.997] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:327:0) after 1m0s
[11:01:58.034] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:327:0)
[11:01:58.034] Timer tick, asking Buildbucket for the build status
[11:01:58.098] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:58.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:328:0) after 1m0s
[11:02:58.132] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:328:0)
[11:02:58.132] Timer tick, asking Buildbucket for the build status
[11:02:58.220] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:58.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:329:0) after 1m0s
[11:03:58.309] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:329:0)
[11:03:58.309] Timer tick, asking Buildbucket for the build status
[11:03:58.439] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:58.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:330:0) after 1m0s
[11:04:58.488] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:330:0)
[11:04:58.488] Timer tick, asking Buildbucket for the build status
[11:04:59.127] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:59.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:331:0) after 1m0s
[11:05:59.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:331:0)
[11:05:59.156] Timer tick, asking Buildbucket for the build status
[11:05:59.208] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:59.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:332:0) after 1m0s
[11:06:59.336] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:332:0)
[11:06:59.336] Timer tick, asking Buildbucket for the build status
[11:06:59.440] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:59.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:333:0) after 1m0s
[11:07:59.602] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:333:0)
[11:07:59.602] Timer tick, asking Buildbucket for the build status
[11:07:59.664] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:59.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:334:0) after 1m0s
[11:08:59.740] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:334:0)
[11:08:59.740] Timer tick, asking Buildbucket for the build status
[11:08:59.801] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:59.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:335:0) after 1m0s
[11:09:59.831] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:335:0)
[11:09:59.831] Timer tick, asking Buildbucket for the build status
[11:10:00.286] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:00.286] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:336:0) after 1m0s
[11:11:00.380] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:336:0)
[11:11:00.380] Timer tick, asking Buildbucket for the build status
[11:11:00.454] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:00.454] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:337:0) after 1m0s
[11:12:00.530] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:337:0)
[11:12:00.530] Timer tick, asking Buildbucket for the build status
[11:12:00.620] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:00.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:338:0) after 1m0s
[11:13:00.836] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:338:0)
[11:13:00.836] Timer tick, asking Buildbucket for the build status
[11:13:01.305] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:01.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:339:0) after 1m0s
[11:14:01.376] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:339:0)
[11:14:01.376] Timer tick, asking Buildbucket for the build status
[11:14:01.482] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:01.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:340:0) after 1m0s
[11:15:01.470] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:340:0)
[11:15:01.470] Timer tick, asking Buildbucket for the build status
[11:15:01.594] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:01.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:341:0) after 1m0s
[11:16:01.771] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:341:0)
[11:16:01.771] Timer tick, asking Buildbucket for the build status
[11:16:01.987] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:01.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:342:0) after 1m0s
[11:17:02.016] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:342:0)
[11:17:02.016] Timer tick, asking Buildbucket for the build status
[11:17:02.082] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:02.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:343:0) after 1m0s
[11:18:02.061] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:343:0)
[11:18:02.061] Timer tick, asking Buildbucket for the build status
[11:18:02.404] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:02.404] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:344:0) after 1m0s
[11:19:02.438] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:344:0)
[11:19:02.438] Timer tick, asking Buildbucket for the build status
[11:19:03.528] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:03.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:345:0) after 1m0s
[11:20:03.582] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:345:0)
[11:20:03.582] Timer tick, asking Buildbucket for the build status
[11:20:03.991] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:03.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:346:0) after 1m0s
[11:21:04.275] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:346:0)
[11:21:04.275] Timer tick, asking Buildbucket for the build status
[11:21:04.534] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:04.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:347:0) after 1m0s
[11:22:04.674] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:347:0)
[11:22:04.674] Timer tick, asking Buildbucket for the build status
[11:22:04.757] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:04.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:348:0) after 1m0s
[11:23:04.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:348:0)
[11:23:04.745] Timer tick, asking Buildbucket for the build status
[11:23:04.939] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:04.939] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:349:0) after 1m0s
[11:24:05.037] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:349:0)
[11:24:05.037] Timer tick, asking Buildbucket for the build status
[11:24:05.105] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:05.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:350:0) after 1m0s
[11:25:05.151] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:350:0)
[11:25:05.151] Timer tick, asking Buildbucket for the build status
[11:25:05.461] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:05.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:351:0) after 1m0s
[11:26:05.596] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:351:0)
[11:26:05.596] Timer tick, asking Buildbucket for the build status
[11:26:05.714] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:05.714] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:352:0) after 1m0s
[11:27:05.790] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:352:0)
[11:27:05.790] Timer tick, asking Buildbucket for the build status
[11:27:06.139] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:06.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:353:0) after 1m0s
[11:28:06.213] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:353:0)
[11:28:06.213] Timer tick, asking Buildbucket for the build status
[11:28:08.464] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:08.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:354:0) after 1m0s
[11:29:08.576] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:354:0)
[11:29:08.576] Timer tick, asking Buildbucket for the build status
[11:29:08.641] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:08.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:355:0) after 1m0s
[11:30:08.681] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:355:0)
[11:30:08.681] Timer tick, asking Buildbucket for the build status
[11:30:08.789] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:08.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:356:0) after 1m0s
[11:31:08.919] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:356:0)
[11:31:08.919] Timer tick, asking Buildbucket for the build status
[11:31:08.980] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:08.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:357:0) after 1m0s
[11:32:08.972] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:357:0)
[11:32:08.972] Timer tick, asking Buildbucket for the build status
[11:32:09.040] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:09.040] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:358:0) after 1m0s
[11:33:09.069] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:358:0)
[11:33:09.069] Timer tick, asking Buildbucket for the build status
[11:33:09.140] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:09.140] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:359:0) after 1m0s
[11:34:09.175] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:359:0)
[11:34:09.175] Timer tick, asking Buildbucket for the build status
[11:34:09.600] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:09.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:360:0) after 1m0s
[11:35:09.682] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:360:0)
[11:35:09.682] Timer tick, asking Buildbucket for the build status
[11:35:09.836] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:09.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:361:0) after 1m0s
[11:36:09.866] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:361:0)
[11:36:09.866] Timer tick, asking Buildbucket for the build status
[11:36:09.943] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:09.943] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:362:0) after 1m0s
[11:37:09.971] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:362:0)
[11:37:09.971] Timer tick, asking Buildbucket for the build status
[11:37:10.042] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:10.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:363:0) after 1m0s
[11:38:10.091] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:363:0)
[11:38:10.091] Timer tick, asking Buildbucket for the build status
[11:38:10.191] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:10.191] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:364:0) after 1m0s
[11:39:10.225] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:364:0)
[11:39:10.225] Timer tick, asking Buildbucket for the build status
[11:39:10.303] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:10.303] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:365:0) after 1m0s
[11:40:10.328] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:365:0)
[11:40:10.328] Timer tick, asking Buildbucket for the build status
[11:40:10.571] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:10.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:366:0) after 1m0s
[11:41:10.610] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:366:0)
[11:41:10.610] Timer tick, asking Buildbucket for the build status
[11:41:10.737] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:10.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:367:0) after 1m0s
[11:42:10.819] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:367:0)
[11:42:10.819] Timer tick, asking Buildbucket for the build status
[11:42:11.573] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:11.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:368:0) after 1m0s
[11:43:11.654] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:368:0)
[11:43:11.654] Timer tick, asking Buildbucket for the build status
[11:43:11.720] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:11.720] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:369:0) after 1m0s
[11:44:11.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:369:0)
[11:44:11.834] Timer tick, asking Buildbucket for the build status
[11:44:11.912] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:11.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:370:0) after 1m0s
[11:45:11.941] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:370:0)
[11:45:11.941] Timer tick, asking Buildbucket for the build status
[11:45:12.424] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:12.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:371:0) after 1m0s
[11:46:12.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:371:0)
[11:46:12.554] Timer tick, asking Buildbucket for the build status
[11:46:12.630] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:12.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:372:0) after 1m0s
[11:47:12.684] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:372:0)
[11:47:12.684] Timer tick, asking Buildbucket for the build status
[11:47:12.780] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:12.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:373:0) after 1m0s
[11:48:12.813] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:373:0)
[11:48:12.813] Timer tick, asking Buildbucket for the build status
[11:48:12.881] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:12.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:374:0) after 1m0s
[11:49:12.917] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:374:0)
[11:49:12.917] Timer tick, asking Buildbucket for the build status
[11:49:13.237] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:13.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:375:0) after 1m0s
[11:50:13.242] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:375:0)
[11:50:13.242] Timer tick, asking Buildbucket for the build status
[11:50:13.393] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:13.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:376:0) after 1m0s
[11:51:13.435] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:376:0)
[11:51:13.435] Timer tick, asking Buildbucket for the build status
[11:51:13.507] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:13.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:377:0) after 1m0s
[11:52:13.652] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:377:0)
[11:52:13.652] Timer tick, asking Buildbucket for the build status
[11:52:13.724] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:13.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:378:0) after 1m0s
[11:53:13.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:378:0)
[11:53:13.844] Timer tick, asking Buildbucket for the build status
[11:53:14.045] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:14.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:379:0) after 1m0s
[11:54:14.130] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:379:0)
[11:54:14.130] Timer tick, asking Buildbucket for the build status
[11:54:14.885] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:14.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:380:0) after 1m0s
[11:55:14.913] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:380:0)
[11:55:14.913] Timer tick, asking Buildbucket for the build status
[11:55:15.087] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:15.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:381:0) after 1m0s
[11:56:15.114] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:381:0)
[11:56:15.114] Timer tick, asking Buildbucket for the build status
[11:56:15.236] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:15.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:382:0) after 1m0s
[11:57:15.316] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:382:0)
[11:57:15.316] Timer tick, asking Buildbucket for the build status
[11:57:15.600] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:15.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:383:0) after 1m0s
[11:58:15.627] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:383:0)
[11:58:15.627] Timer tick, asking Buildbucket for the build status
[11:58:15.700] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:15.700] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:384:0) after 1m0s
[11:59:15.730] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:384:0)
[11:59:15.730] Timer tick, asking Buildbucket for the build status
[11:59:15.911] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:15.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:385:0) after 1m0s
[12:00:15.948] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:385:0)
[12:00:15.948] Timer tick, asking Buildbucket for the build status
[12:00:16.066] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:16.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:386:0) after 1m0s
[12:01:16.175] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:386:0)
[12:01:16.175] Timer tick, asking Buildbucket for the build status
[12:01:16.427] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:16.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:387:0) after 1m0s
[12:02:16.491] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:387:0)
[12:02:16.491] Timer tick, asking Buildbucket for the build status
[12:02:17.166] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:17.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:388:0) after 1m0s
[12:03:17.228] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:388:0)
[12:03:17.228] Timer tick, asking Buildbucket for the build status
[12:03:17.507] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:17.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:389:0) after 1m0s
[12:04:17.599] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:389:0)
[12:04:17.599] Timer tick, asking Buildbucket for the build status
[12:04:17.671] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:17.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:390:0) after 1m0s
[12:05:17.742] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:390:0)
[12:05:17.742] Timer tick, asking Buildbucket for the build status
[12:05:17.896] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:17.896] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:391:0) after 1m0s
[12:06:17.980] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:391:0)
[12:06:17.980] Timer tick, asking Buildbucket for the build status
[12:06:18.210] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:18.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:392:0) after 1m0s
[12:07:18.304] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:392:0)
[12:07:18.304] Timer tick, asking Buildbucket for the build status
[12:07:18.391] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:18.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:393:0) after 1m0s
[12:08:18.583] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:393:0)
[12:08:18.583] Timer tick, asking Buildbucket for the build status
[12:08:18.837] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:18.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:394:0) after 1m0s
[12:09:18.956] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:394:0)
[12:09:18.956] Timer tick, asking Buildbucket for the build status
[12:09:19.148] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:19.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:395:0) after 1m0s
[12:10:19.142] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:395:0)
[12:10:19.142] Timer tick, asking Buildbucket for the build status
[12:10:19.236] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:19.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:396:0) after 1m0s
[12:11:19.269] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:396:0)
[12:11:19.269] Timer tick, asking Buildbucket for the build status
[12:11:19.459] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:19.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:397:0) after 1m0s
[12:12:19.488] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:397:0)
[12:12:19.488] Timer tick, asking Buildbucket for the build status
[12:12:19.649] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:19.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:398:0) after 1m0s
[12:13:19.689] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:398:0)
[12:13:19.689] Timer tick, asking Buildbucket for the build status
[12:13:19.767] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:19.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:399:0) after 1m0s
[12:14:19.865] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:399:0)
[12:14:19.865] Timer tick, asking Buildbucket for the build status
[12:14:20.219] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:20.219] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:400:0) after 1m0s
[12:15:20.298] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:400:0)
[12:15:20.298] Timer tick, asking Buildbucket for the build status
[12:15:20.611] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:20.611] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:401:0) after 1m0s
[12:16:20.692] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:401:0)
[12:16:20.692] Timer tick, asking Buildbucket for the build status
[12:16:20.801] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:20.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:402:0) after 1m0s
[12:17:20.791] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:402:0)
[12:17:20.791] Timer tick, asking Buildbucket for the build status
[12:17:20.869] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:20.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:403:0) after 1m0s
[12:18:20.906] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:403:0)
[12:18:20.906] Timer tick, asking Buildbucket for the build status
[12:18:20.963] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:20.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:404:0) after 1m0s
[12:19:20.998] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:404:0)
[12:19:20.998] Timer tick, asking Buildbucket for the build status
[12:19:21.100] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:21.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:405:0) after 1m0s
[12:20:21.210] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:405:0)
[12:20:21.210] Timer tick, asking Buildbucket for the build status
[12:20:21.336] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:21.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:406:0) after 1m0s
[12:21:21.389] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:406:0)
[12:21:21.389] Timer tick, asking Buildbucket for the build status
[12:21:21.707] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:21.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:407:0) after 1m0s
[12:22:21.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:407:0)
[12:22:21.737] Timer tick, asking Buildbucket for the build status
[12:22:21.837] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:21.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:408:0) after 1m0s
[12:23:21.967] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:408:0)
[12:23:21.967] Timer tick, asking Buildbucket for the build status
[12:23:22.051] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:22.051] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:409:0) after 1m0s
[12:24:22.102] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:409:0)
[12:24:22.102] Timer tick, asking Buildbucket for the build status
[12:24:22.177] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:22.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:410:0) after 1m0s
[12:25:22.173] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:410:0)
[12:25:22.173] Timer tick, asking Buildbucket for the build status
[12:25:22.354] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:22.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:411:0) after 1m0s
[12:26:22.476] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:411:0)
[12:26:22.476] Timer tick, asking Buildbucket for the build status
[12:26:22.579] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:22.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:412:0) after 1m0s
[12:27:22.688] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:412:0)
[12:27:22.688] Timer tick, asking Buildbucket for the build status
[12:27:22.792] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:22.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:413:0) after 1m0s
[12:28:22.882] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:413:0)
[12:28:22.882] Timer tick, asking Buildbucket for the build status
[12:28:22.934] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:22.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:414:0) after 1m0s
[12:29:22.961] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:414:0)
[12:29:22.961] Timer tick, asking Buildbucket for the build status
[12:29:23.079] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:23.079] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:415:0) after 1m0s
[12:30:23.144] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:415:0)
[12:30:23.144] Timer tick, asking Buildbucket for the build status
[12:30:23.560] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:23.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:416:0) after 1m0s
[12:31:23.595] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:416:0)
[12:31:23.595] Timer tick, asking Buildbucket for the build status
[12:31:23.653] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:23.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:417:0) after 1m0s
[12:32:23.724] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:417:0)
[12:32:23.724] Timer tick, asking Buildbucket for the build status
[12:32:24.021] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:24.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:418:0) after 1m0s
[12:33:24.116] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:418:0)
[12:33:24.116] Timer tick, asking Buildbucket for the build status
[12:33:24.321] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:24.321] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:419:0) after 1m0s
[12:34:24.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:419:0)
[12:34:24.360] Timer tick, asking Buildbucket for the build status
[12:34:24.438] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:24.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:420:0) after 1m0s
[12:35:24.699] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:420:0)
[12:35:24.699] Timer tick, asking Buildbucket for the build status
[12:35:24.859] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:24.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:421:0) after 1m0s
[12:36:24.932] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:421:0)
[12:36:24.932] Timer tick, asking Buildbucket for the build status
[12:36:25.102] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:25.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:422:0) after 1m0s
[12:37:25.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:422:0)
[12:37:25.186] Timer tick, asking Buildbucket for the build status
[12:37:25.256] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:25.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:423:0) after 1m0s
[12:38:25.421] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:423:0)
[12:38:25.421] Timer tick, asking Buildbucket for the build status
[12:38:25.487] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:25.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:424:0) after 1m0s
[12:39:25.599] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:424:0)
[12:39:25.599] Timer tick, asking Buildbucket for the build status
[12:39:25.907] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:25.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:425:0) after 1m0s
[12:40:26.009] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:425:0)
[12:40:26.009] Timer tick, asking Buildbucket for the build status
[12:40:26.147] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:26.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:426:0) after 1m0s
[12:41:26.164] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:426:0)
[12:41:26.164] Timer tick, asking Buildbucket for the build status
[12:41:26.336] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:26.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:427:0) after 1m0s
[12:42:26.344] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:427:0)
[12:42:26.344] Timer tick, asking Buildbucket for the build status
[12:42:26.405] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:26.405] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:428:0) after 1m0s
[12:43:26.437] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:428:0)
[12:43:26.437] Timer tick, asking Buildbucket for the build status
[12:43:26.500] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:26.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:429:0) after 1m0s
[12:44:26.578] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:429:0)
[12:44:26.578] Timer tick, asking Buildbucket for the build status
[12:44:26.861] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:26.861] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:430:0) after 1m0s
--- the log has been cut here ---
[16:43:03.528] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:03.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:667:0) after 1m0s
[16:44:03.554] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:667:0)
[16:44:03.554] Timer tick, asking Buildbucket for the build status
[16:44:03.956] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:03.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:668:0) after 1m0s
[16:45:04.036] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:668:0)
[16:45:04.036] Timer tick, asking Buildbucket for the build status
[16:45:04.948] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:04.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:669:0) after 1m0s
[16:46:04.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:669:0)
[16:46:04.934] Timer tick, asking Buildbucket for the build status
[16:46:05.059] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:05.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:670:0) after 1m0s
[16:47:05.179] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:670:0)
[16:47:05.179] Timer tick, asking Buildbucket for the build status
[16:47:05.236] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:05.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:671:0) after 1m0s
[16:48:05.291] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:671:0)
[16:48:05.291] Timer tick, asking Buildbucket for the build status
[16:48:05.351] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:05.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:672:0) after 1m0s
[16:49:05.437] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:672:0)
[16:49:05.437] Timer tick, asking Buildbucket for the build status
[16:49:05.507] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:05.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:673:0) after 1m0s
[16:50:05.539] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:673:0)
[16:50:05.539] Timer tick, asking Buildbucket for the build status
[16:50:05.625] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:05.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:674:0) after 1m0s
[16:51:05.643] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:674:0)
[16:51:05.643] Timer tick, asking Buildbucket for the build status
[16:51:06.335] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:06.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:675:0) after 1m0s
[16:52:06.424] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:675:0)
[16:52:06.424] Timer tick, asking Buildbucket for the build status
[16:52:06.838] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:06.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:676:0) after 1m0s
[16:53:06.887] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:676:0)
[16:53:06.887] Timer tick, asking Buildbucket for the build status
[16:53:06.957] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:06.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:677:0) after 1m0s
[16:54:06.998] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:677:0)
[16:54:06.998] Timer tick, asking Buildbucket for the build status
[16:54:07.208] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:07.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:678:0) after 1m0s
[16:55:07.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:678:0)
[16:55:07.272] Timer tick, asking Buildbucket for the build status
[16:55:07.337] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:07.337] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:679:0) after 1m0s
[16:56:07.410] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:679:0)
[16:56:07.410] Timer tick, asking Buildbucket for the build status
[16:56:07.523] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:07.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:680:0) after 1m0s
[16:57:07.553] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:680:0)
[16:57:07.553] Timer tick, asking Buildbucket for the build status
[16:57:07.669] Build 8856070958265884048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:07.670] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021501023398103392:681:0) after 1m0s
[16:57:53.593] Received PubSub notification, asking Buildbucket for the build status
[16:57:53.782] Build 8856070958265884048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:57:53.782] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "completed_ts": "1612630668980051",
    "created_by": "project:nacl",
    "created_ts": "1612589605038416",
    "id": "8856070958265884048",
    "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\": \"8db20f20316f13d8886a2732099f5bb880568663\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@8db20f20316f13d8886a2732099f5bb880568663\", \"title\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/8db20f20316f13d8886a2732099f5bb880568663\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"8db20f20316f13d8886a2732099f5bb880568663\"}}",
    "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\": \"8db20f20316f13d8886a2732099f5bb880568663\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@8db20f20316f13d8886a2732099f5bb880568663\", \"title\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/8db20f20316f13d8886a2732099f5bb880568663\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-flex-ci-xenial-1-lw53\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.nacl\", \"buildername\": \"linux-64-validator-opt\", \"buildnumber\": 160, \"got_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_41bff59e48143683eee7e209c35176da7d4c8f0bf6fc4cc531114b3142934c50_v2\", \"builder_5a5bb86f59b56b196ab2fcd890c7333739724a7208c96ec90a4b21c46bf89f1e_v2\", \"builder_b21fc2474b74a202903fba65fd8166899cce4d46f0d8adaea07be83158cf5611_v2\", \"builder_f58e49d4978dd47022c74d62848afbffa29b3ee52aa79f0e76d160631af2bf15_v2\", \"builder_ffd36e29a428b818c867dca5a22339cd31e7cf39c69354dd8e9deb8785e0186c_v2\", \"git\", \"goma_v2\", \"vpython\", \"win_toolchain\"], \"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-1-lw53\"], \"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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1612590226003900",
    "status": "COMPLETED",
    "status_changed_ts": "1612630672053057",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/160",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/8db20f20316f13d8886a2732099f5bb880568663",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/8db20f20316f13d8886a2732099f5bb880568663",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021501023398103392",
      "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/8856070958265884048/+/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:518ea62cf1d00110",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612630672511122",
    "url": "https://ci.chromium.org/b/8856070958265884048",
    "utcnow_ts": "1612630673773648"
  }
}
[16:57:53.782] Invocation finished in 11h24m33.021869401s with status SUCCEEDED