[10:38:33.137] New invocation is queued and will start shortly
[10:38:34.282] Starting the invocation (attempt 1)
[10:38:34.336] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:38:34.337] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:38:34.337] Buildbucket request:
{
"bucket": "luci.nacl.ci",
"client_operation_id": "9019398091268177712",
"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\":\"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\",\"title\":\"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}}",
"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:9019398091268177712",
"scheduler_job_id:nacl/linux-64-validator-opt",
"user_agent:luci-scheduler",
"buildset:commit/git/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a",
"gitiles_ref:refs/heads/master"
]
}
[10:38:36.400] Buildbucket response:
{
"build": {
"bucket": "luci.nacl.ci",
"canary_preference": "PROD",
"created_by": "project:nacl",
"created_ts": "1614595115702275",
"id": "8853968027915921040",
"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\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\", \"title\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}}",
"project": "nacl",
"result_details_json": "{\"properties\": {}}",
"service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614595116239073",
"tags": [
"build_address:luci.nacl.ci/linux-64-validator-opt/168",
"builder:linux-64-validator-opt",
"buildset:commit/git/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019398091268177712",
"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/8853968027915921040/+/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": "1614595116239192",
"url": "https://ci.chromium.org/b/8853968027915921040",
"utcnow_ts": "1614595116392255"
}
}
[10:38:36.400] Task URL: https://ci.chromium.org/b/8853968027915921040
[10:38:36.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:2:0) after 1m0s
[10:39:36.518] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:2:0)
[10:39:36.518] Timer tick, asking Buildbucket for the build status
[10:39:36.611] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:39:36.611] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:3:0) after 1m0s
[10:40:36.630] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:3:0)
[10:40:36.630] Timer tick, asking Buildbucket for the build status
[10:40:36.833] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:40:36.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:4:0) after 1m0s
[10:41:36.918] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:4:0)
[10:41:36.918] Timer tick, asking Buildbucket for the build status
[10:41:37.185] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:41:37.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:5:0) after 1m0s
[10:42:37.666] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:5:0)
[10:42:37.666] Timer tick, asking Buildbucket for the build status
[10:42:37.974] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:42:37.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:6:0) after 1m0s
[10:43:37.993] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:6:0)
[10:43:37.993] Timer tick, asking Buildbucket for the build status
[10:43:38.420] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:43:38.420] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:7:0) after 1m0s
[10:44:38.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:7:0)
[10:44:38.487] Timer tick, asking Buildbucket for the build status
[10:44:38.938] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:44:38.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:8:0) after 1m0s
[10:45:38.957] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:8:0)
[10:45:38.957] Timer tick, asking Buildbucket for the build status
[10:45:39.150] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:45:39.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:9:0) after 1m0s
[10:46:39.169] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:9:0)
[10:46:39.169] Timer tick, asking Buildbucket for the build status
[10:46:39.242] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:46:39.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:10:0) after 1m0s
[10:47:39.215] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:10:0)
[10:47:39.215] Timer tick, asking Buildbucket for the build status
[10:47:39.338] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:47:39.338] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:11:0) after 1m0s
[10:48:39.340] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:11:0)
[10:48:39.340] Timer tick, asking Buildbucket for the build status
[10:48:39.457] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:48:39.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:12:0) after 1m0s
[10:49:39.558] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:12:0)
[10:49:39.558] Timer tick, asking Buildbucket for the build status
[10:49:39.631] Build 8853968027915921040: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:49:39.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:13:0) after 1m0s
[10:50:34.689] Received PubSub notification, asking Buildbucket for the build status
[10:50:34.772] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:39.684] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:13:0)
[10:50:39.684] Timer tick, asking Buildbucket for the build status
[10:50:39.782] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:39.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:15:0) after 1m0s
[10:51:39.811] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:15:0)
[10:51:39.811] Timer tick, asking Buildbucket for the build status
[10:51:39.877] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:39.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:16:0) after 1m0s
[10:52:39.915] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:16:0)
[10:52:39.915] Timer tick, asking Buildbucket for the build status
[10:52:40.008] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:40.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:17:0) after 1m0s
[10:53:40.070] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:17:0)
[10:53:40.070] Timer tick, asking Buildbucket for the build status
[10:53:40.141] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:40.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:18:0) after 1m0s
[10:54:40.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:18:0)
[10:54:40.156] Timer tick, asking Buildbucket for the build status
[10:54:40.249] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:40.249] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:19:0) after 1m0s
[10:55:40.277] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:19:0)
[10:55:40.277] Timer tick, asking Buildbucket for the build status
[10:55:40.364] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:40.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:20:0) after 1m0s
[10:56:40.388] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:20:0)
[10:56:40.388] Timer tick, asking Buildbucket for the build status
[10:56:40.468] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:40.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:21:0) after 1m0s
[10:57:40.508] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:21:0)
[10:57:40.508] Timer tick, asking Buildbucket for the build status
[10:57:40.599] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:40.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:22:0) after 1m0s
[10:58:40.620] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:22:0)
[10:58:40.620] Timer tick, asking Buildbucket for the build status
[10:58:40.713] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:40.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:23:0) after 1m0s
[10:59:40.823] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:23:0)
[10:59:40.823] Timer tick, asking Buildbucket for the build status
[10:59:40.977] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:40.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:24:0) after 1m0s
[11:00:40.999] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:24:0)
[11:00:40.999] Timer tick, asking Buildbucket for the build status
[11:00:41.105] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:41.106] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:25:0) after 1m0s
[11:01:41.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:25:0)
[11:01:41.156] Timer tick, asking Buildbucket for the build status
[11:01:41.314] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:41.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:26:0) after 1m0s
[11:02:41.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:26:0)
[11:02:41.330] Timer tick, asking Buildbucket for the build status
[11:02:41.543] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:41.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:27:0) after 1m0s
[11:03:41.523] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:27:0)
[11:03:41.523] Timer tick, asking Buildbucket for the build status
[11:03:41.676] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:41.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:28:0) after 1m0s
[11:04:41.718] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:28:0)
[11:04:41.718] Timer tick, asking Buildbucket for the build status
[11:04:41.843] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:41.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:29:0) after 1m0s
[11:05:41.863] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:29:0)
[11:05:41.863] Timer tick, asking Buildbucket for the build status
[11:05:41.952] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:41.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:30:0) after 1m0s
[11:06:41.972] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:30:0)
[11:06:41.972] Timer tick, asking Buildbucket for the build status
[11:06:42.058] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:42.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:31:0) after 1m0s
[11:07:42.082] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:31:0)
[11:07:42.083] Timer tick, asking Buildbucket for the build status
[11:07:42.161] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:42.161] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:32:0) after 1m0s
[11:08:42.177] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:32:0)
[11:08:42.177] Timer tick, asking Buildbucket for the build status
[11:08:42.272] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:42.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:33:0) after 1m0s
[11:09:42.264] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:33:0)
[11:09:42.264] Timer tick, asking Buildbucket for the build status
[11:09:42.839] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:42.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:34:0) after 1m0s
[11:10:42.887] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:34:0)
[11:10:42.887] Timer tick, asking Buildbucket for the build status
[11:10:43.036] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:43.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:35:0) after 1m0s
[11:11:43.065] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:35:0)
[11:11:43.065] Timer tick, asking Buildbucket for the build status
[11:11:43.281] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:43.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:36:0) after 1m0s
[11:12:43.332] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:36:0)
[11:12:43.332] Timer tick, asking Buildbucket for the build status
[11:12:43.431] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:43.431] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:37:0) after 1m0s
[11:13:43.451] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:37:0)
[11:13:43.451] Timer tick, asking Buildbucket for the build status
[11:13:43.533] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:43.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:38:0) after 1m0s
[11:14:43.558] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:38:0)
[11:14:43.558] Timer tick, asking Buildbucket for the build status
[11:14:43.693] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:43.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:39:0) after 1m0s
[11:15:43.712] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:39:0)
[11:15:43.712] Timer tick, asking Buildbucket for the build status
[11:15:44.354] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:44.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:40:0) after 1m0s
[11:16:44.357] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:40:0)
[11:16:44.357] Timer tick, asking Buildbucket for the build status
[11:16:44.589] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:44.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:41:0) after 1m0s
[11:17:44.606] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:41:0)
[11:17:44.606] Timer tick, asking Buildbucket for the build status
[11:17:44.680] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:44.680] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:42:0) after 1m0s
[11:18:44.704] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:42:0)
[11:18:44.704] Timer tick, asking Buildbucket for the build status
[11:18:44.819] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:44.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:43:0) after 1m0s
[11:19:44.881] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:43:0)
[11:19:44.881] Timer tick, asking Buildbucket for the build status
[11:19:45.038] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:45.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:44:0) after 1m0s
[11:20:45.094] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:44:0)
[11:20:45.094] Timer tick, asking Buildbucket for the build status
[11:20:45.161] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:45.161] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:45:0) after 1m0s
[11:21:45.175] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:45:0)
[11:21:45.175] Timer tick, asking Buildbucket for the build status
[11:21:45.276] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:45.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:46:0) after 1m0s
[11:22:45.293] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:46:0)
[11:22:45.293] Timer tick, asking Buildbucket for the build status
[11:22:45.745] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:45.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:47:0) after 1m0s
[11:23:45.790] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:47:0)
[11:23:45.790] Timer tick, asking Buildbucket for the build status
[11:23:46.086] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:46.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:48:0) after 1m0s
[11:24:46.093] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:48:0)
[11:24:46.093] Timer tick, asking Buildbucket for the build status
[11:24:46.182] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:46.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:49:0) after 1m0s
[11:25:46.206] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:49:0)
[11:25:46.206] Timer tick, asking Buildbucket for the build status
[11:25:46.342] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:46.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:50:0) after 1m0s
[11:26:46.373] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:50:0)
[11:26:46.373] Timer tick, asking Buildbucket for the build status
[11:26:46.442] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:46.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:51:0) after 1m0s
[11:27:46.498] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:51:0)
[11:27:46.498] Timer tick, asking Buildbucket for the build status
[11:27:46.575] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:46.575] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:52:0) after 1m0s
[11:28:46.624] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:52:0)
[11:28:46.624] Timer tick, asking Buildbucket for the build status
[11:28:47.053] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:47.053] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:53:0) after 1m0s
[11:29:47.106] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:53:0)
[11:29:47.106] Timer tick, asking Buildbucket for the build status
[11:29:47.193] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:47.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:54:0) after 1m0s
[11:30:47.245] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:54:0)
[11:30:47.245] Timer tick, asking Buildbucket for the build status
[11:30:47.330] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:47.330] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:55:0) after 1m0s
[11:31:47.348] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:55:0)
[11:31:47.348] Timer tick, asking Buildbucket for the build status
[11:31:47.552] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:47.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:56:0) after 1m0s
[11:32:47.558] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:56:0)
[11:32:47.558] Timer tick, asking Buildbucket for the build status
[11:32:47.806] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:47.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:57:0) after 1m0s
[11:33:47.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:57:0)
[11:33:47.844] Timer tick, asking Buildbucket for the build status
[11:33:47.927] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:47.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:58:0) after 1m0s
[11:34:47.982] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:58:0)
[11:34:47.982] Timer tick, asking Buildbucket for the build status
[11:34:48.339] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:48.339] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:59:0) after 1m0s
[11:35:48.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:59:0)
[11:35:48.330] Timer tick, asking Buildbucket for the build status
[11:35:48.572] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:48.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:60:0) after 1m0s
[11:36:48.582] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:60:0)
[11:36:48.582] Timer tick, asking Buildbucket for the build status
[11:36:48.664] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:48.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:61:0) after 1m0s
[11:37:48.687] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:61:0)
[11:37:48.687] Timer tick, asking Buildbucket for the build status
[11:37:48.839] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:48.839] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:62:0) after 1m0s
[11:38:48.843] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:62:0)
[11:38:48.843] Timer tick, asking Buildbucket for the build status
[11:38:48.923] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:48.923] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:63:0) after 1m0s
[11:39:48.965] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:63:0)
[11:39:48.965] Timer tick, asking Buildbucket for the build status
[11:39:49.060] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:49.060] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:64:0) after 1m0s
[11:40:49.144] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:64:0)
[11:40:49.144] Timer tick, asking Buildbucket for the build status
[11:40:49.223] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:49.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:65:0) after 1m0s
[11:41:49.243] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:65:0)
[11:41:49.243] Timer tick, asking Buildbucket for the build status
[11:41:49.427] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:49.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:66:0) after 1m0s
[11:42:49.831] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:66:0)
[11:42:49.831] Timer tick, asking Buildbucket for the build status
[11:42:49.902] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:49.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:67:0) after 1m0s
[11:43:50.093] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:67:0)
[11:43:50.093] Timer tick, asking Buildbucket for the build status
[11:43:50.190] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:50.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:68:0) after 1m0s
[11:44:50.259] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:68:0)
[11:44:50.259] Timer tick, asking Buildbucket for the build status
[11:44:50.376] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:50.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:69:0) after 1m0s
[11:45:50.472] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:69:0)
[11:45:50.472] Timer tick, asking Buildbucket for the build status
[11:45:50.546] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:50.546] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:70:0) after 1m0s
[11:46:50.606] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:70:0)
[11:46:50.607] Timer tick, asking Buildbucket for the build status
[11:46:50.808] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:50.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:71:0) after 1m0s
[11:47:50.857] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:71:0)
[11:47:50.857] Timer tick, asking Buildbucket for the build status
[11:47:50.934] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:50.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:72:0) after 1m0s
[11:48:50.994] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:72:0)
[11:48:50.994] Timer tick, asking Buildbucket for the build status
[11:48:51.156] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:51.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:73:0) after 1m0s
[11:49:51.193] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:73:0)
[11:49:51.193] Timer tick, asking Buildbucket for the build status
[11:49:51.381] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:51.381] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:74:0) after 1m0s
[11:50:51.562] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:74:0)
[11:50:51.562] Timer tick, asking Buildbucket for the build status
[11:50:51.635] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:51.635] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:75:0) after 1m0s
[11:51:51.869] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:75:0)
[11:51:51.869] Timer tick, asking Buildbucket for the build status
[11:51:51.966] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:51.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:76:0) after 1m0s
[11:52:52.055] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:76:0)
[11:52:52.056] Timer tick, asking Buildbucket for the build status
[11:52:52.231] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:52.231] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:77:0) after 1m0s
[11:53:52.218] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:77:0)
[11:53:52.218] Timer tick, asking Buildbucket for the build status
[11:53:52.751] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:52.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:78:0) after 1m0s
[11:54:52.850] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:78:0)
[11:54:52.850] Timer tick, asking Buildbucket for the build status
[11:54:52.994] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:52.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:79:0) after 1m0s
[11:55:53.018] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:79:0)
[11:55:53.018] Timer tick, asking Buildbucket for the build status
[11:55:53.207] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:53.207] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:80:0) after 1m0s
[11:56:53.232] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:80:0)
[11:56:53.232] Timer tick, asking Buildbucket for the build status
[11:56:53.313] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:53.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:81:0) after 1m0s
[11:57:53.780] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:81:0)
[11:57:53.780] Timer tick, asking Buildbucket for the build status
[11:57:55.400] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:55.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:82:0) after 1m0s
[11:58:55.593] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:82:0)
[11:58:55.593] Timer tick, asking Buildbucket for the build status
[11:58:55.656] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:55.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:83:0) after 1m0s
[11:59:55.669] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:83:0)
[11:59:55.669] Timer tick, asking Buildbucket for the build status
[11:59:55.777] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:55.777] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:84:0) after 1m0s
[12:00:55.830] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:84:0)
[12:00:55.830] Timer tick, asking Buildbucket for the build status
[12:00:56.155] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:56.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:85:0) after 1m0s
[12:01:56.222] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:85:0)
[12:01:56.222] Timer tick, asking Buildbucket for the build status
[12:01:56.460] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:56.460] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:86:0) after 1m0s
[12:02:56.541] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:86:0)
[12:02:56.542] Timer tick, asking Buildbucket for the build status
[12:02:56.623] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:56.623] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:87:0) after 1m0s
[12:03:56.735] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:87:0)
[12:03:56.735] Timer tick, asking Buildbucket for the build status
[12:03:56.818] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:56.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:88:0) after 1m0s
[12:04:56.894] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:88:0)
[12:04:56.894] Timer tick, asking Buildbucket for the build status
[12:04:56.995] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:56.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:89:0) after 1m0s
[12:05:56.986] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:89:0)
[12:05:56.986] Timer tick, asking Buildbucket for the build status
[12:05:57.145] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:57.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:90:0) after 1m0s
[12:06:57.173] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:90:0)
[12:06:57.173] Timer tick, asking Buildbucket for the build status
[12:06:57.259] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:57.259] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:91:0) after 1m0s
[12:07:57.373] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:91:0)
[12:07:57.373] Timer tick, asking Buildbucket for the build status
[12:07:57.585] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:57.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:92:0) after 1m0s
[12:08:57.573] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:92:0)
[12:08:57.573] Timer tick, asking Buildbucket for the build status
[12:08:57.698] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:57.698] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:93:0) after 1m0s
[12:09:57.720] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:93:0)
[12:09:57.720] Timer tick, asking Buildbucket for the build status
[12:09:57.870] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:57.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:94:0) after 1m0s
[12:10:57.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:94:0)
[12:10:57.960] Timer tick, asking Buildbucket for the build status
[12:10:58.058] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:58.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:95:0) after 1m0s
[12:11:58.187] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:95:0)
[12:11:58.187] Timer tick, asking Buildbucket for the build status
[12:11:58.358] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:58.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:96:0) after 1m0s
[12:12:58.640] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:96:0)
[12:12:58.640] Timer tick, asking Buildbucket for the build status
[12:12:58.753] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:58.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:97:0) after 1m0s
[12:13:58.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:97:0)
[12:13:58.920] Timer tick, asking Buildbucket for the build status
[12:13:59.029] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:59.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:98:0) after 1m0s
[12:14:59.050] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:98:0)
[12:14:59.050] Timer tick, asking Buildbucket for the build status
[12:14:59.486] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:59.486] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:99:0) after 1m0s
[12:15:59.631] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:99:0)
[12:15:59.631] Timer tick, asking Buildbucket for the build status
[12:15:59.758] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:59.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:100:0) after 1m0s
[12:16:59.798] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:100:0)
[12:16:59.798] Timer tick, asking Buildbucket for the build status
[12:17:00.151] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:00.151] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:101:0) after 1m0s
[12:18:00.170] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:101:0)
[12:18:00.170] Timer tick, asking Buildbucket for the build status
[12:18:00.446] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:00.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:102:0) after 1m0s
[12:19:00.480] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:102:0)
[12:19:00.480] Timer tick, asking Buildbucket for the build status
[12:19:00.802] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:00.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:103:0) after 1m0s
[12:20:00.890] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:103:0)
[12:20:00.890] Timer tick, asking Buildbucket for the build status
[12:20:01.603] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:01.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:104:0) after 1m0s
[12:21:01.609] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:104:0)
[12:21:01.609] Timer tick, asking Buildbucket for the build status
[12:21:01.906] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:01.906] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:105:0) after 1m0s
[12:22:01.961] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:105:0)
[12:22:01.961] Timer tick, asking Buildbucket for the build status
[12:22:02.128] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:02.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:106:0) after 1m0s
[12:23:02.153] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:106:0)
[12:23:02.153] Timer tick, asking Buildbucket for the build status
[12:23:02.233] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:02.233] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:107:0) after 1m0s
[12:24:02.252] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:107:0)
[12:24:02.252] Timer tick, asking Buildbucket for the build status
[12:24:02.322] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:02.322] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:108:0) after 1m0s
[12:25:02.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:108:0)
[12:25:02.360] Timer tick, asking Buildbucket for the build status
[12:25:02.447] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:02.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:109:0) after 1m0s
[12:26:02.505] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:109:0)
[12:26:02.505] Timer tick, asking Buildbucket for the build status
[12:26:02.719] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:02.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:110:0) after 1m0s
[12:27:02.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:110:0)
[12:27:02.737] Timer tick, asking Buildbucket for the build status
[12:27:02.810] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:02.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:111:0) after 1m0s
[12:28:02.858] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:111:0)
[12:28:02.858] Timer tick, asking Buildbucket for the build status
[12:28:03.059] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:03.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:112:0) after 1m0s
[12:29:03.036] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:112:0)
[12:29:03.036] Timer tick, asking Buildbucket for the build status
[12:29:03.110] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:03.110] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:113:0) after 1m0s
[12:30:03.208] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:113:0)
[12:30:03.208] Timer tick, asking Buildbucket for the build status
[12:30:03.295] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:03.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:114:0) after 1m0s
[12:31:03.298] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:114:0)
[12:31:03.298] Timer tick, asking Buildbucket for the build status
[12:31:03.519] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:03.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:115:0) after 1m0s
[12:32:03.592] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:115:0)
[12:32:03.592] Timer tick, asking Buildbucket for the build status
[12:32:03.669] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:03.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:116:0) after 1m0s
[12:33:03.714] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:116:0)
[12:33:03.714] Timer tick, asking Buildbucket for the build status
[12:33:03.802] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:03.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:117:0) after 1m0s
[12:34:03.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:117:0)
[12:34:03.834] Timer tick, asking Buildbucket for the build status
[12:34:03.944] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:03.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:118:0) after 1m0s
[12:35:04.040] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:118:0)
[12:35:04.040] Timer tick, asking Buildbucket for the build status
[12:35:04.123] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:04.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:119:0) after 1m0s
[12:36:04.150] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:119:0)
[12:36:04.151] Timer tick, asking Buildbucket for the build status
[12:36:04.256] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:04.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:120:0) after 1m0s
[12:37:04.232] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:120:0)
[12:37:04.232] Timer tick, asking Buildbucket for the build status
[12:37:04.359] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:04.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:121:0) after 1m0s
[12:38:04.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:121:0)
[12:38:04.405] Timer tick, asking Buildbucket for the build status
[12:38:04.485] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:04.485] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:122:0) after 1m0s
[12:39:04.483] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:122:0)
[12:39:04.483] Timer tick, asking Buildbucket for the build status
[12:39:04.635] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:04.635] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:123:0) after 1m0s
[12:40:04.687] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:123:0)
[12:40:04.687] Timer tick, asking Buildbucket for the build status
[12:40:04.842] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:04.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:124:0) after 1m0s
[12:41:05.051] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:124:0)
[12:41:05.051] Timer tick, asking Buildbucket for the build status
[12:41:05.124] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:05.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:125:0) after 1m0s
[12:42:05.197] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:125:0)
[12:42:05.197] Timer tick, asking Buildbucket for the build status
[12:42:05.319] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:05.319] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:126:0) after 1m0s
[12:43:05.369] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:126:0)
[12:43:05.369] Timer tick, asking Buildbucket for the build status
[12:43:05.564] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:05.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:127:0) after 1m0s
[12:44:05.651] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:127:0)
[12:44:05.651] Timer tick, asking Buildbucket for the build status
[12:44:05.872] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:05.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:128:0) after 1m0s
[12:45:06.070] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:128:0)
[12:45:06.070] Timer tick, asking Buildbucket for the build status
[12:45:06.215] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:06.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:129:0) after 1m0s
[12:46:06.397] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:129:0)
[12:46:06.397] Timer tick, asking Buildbucket for the build status
[12:46:06.624] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:06.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:130:0) after 1m0s
[12:47:06.812] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:130:0)
[12:47:06.812] Timer tick, asking Buildbucket for the build status
[12:47:07.415] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:07.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:131:0) after 1m0s
[12:48:07.668] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:131:0)
[12:48:07.668] Timer tick, asking Buildbucket for the build status
[12:48:08.457] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:08.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:132:0) after 1m0s
[12:49:08.500] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:132:0)
[12:49:08.500] Timer tick, asking Buildbucket for the build status
[12:49:08.581] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:08.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:133:0) after 1m0s
[12:50:08.649] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:133:0)
[12:50:08.649] Timer tick, asking Buildbucket for the build status
[12:50:08.765] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:08.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:134:0) after 1m0s
[12:51:08.803] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:134:0)
[12:51:08.803] Timer tick, asking Buildbucket for the build status
[12:51:08.903] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:08.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:135:0) after 1m0s
[12:52:08.963] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:135:0)
[12:52:08.963] Timer tick, asking Buildbucket for the build status
[12:52:09.036] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:09.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:136:0) after 1m0s
[12:53:09.113] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:136:0)
[12:53:09.113] Timer tick, asking Buildbucket for the build status
[12:53:09.256] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:09.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:137:0) after 1m0s
[12:54:09.397] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:137:0)
[12:54:09.397] Timer tick, asking Buildbucket for the build status
[12:54:09.665] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:09.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:138:0) after 1m0s
[12:55:09.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:138:0)
[12:55:09.844] Timer tick, asking Buildbucket for the build status
[12:55:09.920] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:09.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:139:0) after 1m0s
[12:56:09.966] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:139:0)
[12:56:09.966] Timer tick, asking Buildbucket for the build status
[12:56:10.062] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:10.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:140:0) after 1m0s
[12:57:10.236] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:140:0)
[12:57:10.236] Timer tick, asking Buildbucket for the build status
[12:57:10.424] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:10.424] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:141:0) after 1m0s
[12:58:10.579] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:141:0)
[12:58:10.579] Timer tick, asking Buildbucket for the build status
[12:58:10.757] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:10.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:142:0) after 1m0s
[12:59:10.928] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:142:0)
[12:59:10.928] Timer tick, asking Buildbucket for the build status
[12:59:11.004] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:11.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:143:0) after 1m0s
[13:00:11.066] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:143:0)
[13:00:11.066] Timer tick, asking Buildbucket for the build status
[13:00:12.069] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:12.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:144:0) after 1m0s
[13:01:12.307] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:144:0)
[13:01:12.307] Timer tick, asking Buildbucket for the build status
[13:01:12.422] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:12.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:145:0) after 1m0s
[13:02:12.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:145:0)
[13:02:12.544] Timer tick, asking Buildbucket for the build status
[13:02:12.617] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:12.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:146:0) after 1m0s
[13:03:12.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:146:0)
[13:03:12.737] Timer tick, asking Buildbucket for the build status
[13:03:12.861] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:12.861] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:147:0) after 1m0s
[13:04:12.979] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:147:0)
[13:04:12.979] Timer tick, asking Buildbucket for the build status
[13:04:13.142] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:13.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:148:0) after 1m0s
[13:05:13.163] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:148:0)
[13:05:13.163] Timer tick, asking Buildbucket for the build status
[13:05:13.251] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:13.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:149:0) after 1m0s
[13:06:13.321] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:149:0)
[13:06:13.321] Timer tick, asking Buildbucket for the build status
[13:06:13.388] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:13.388] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:150:0) after 1m0s
[13:07:13.471] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:150:0)
[13:07:13.471] Timer tick, asking Buildbucket for the build status
[13:07:13.562] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:13.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:151:0) after 1m0s
[13:08:13.552] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:151:0)
[13:08:13.552] Timer tick, asking Buildbucket for the build status
[13:08:13.636] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:13.636] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:152:0) after 1m0s
[13:09:13.692] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:152:0)
[13:09:13.692] Timer tick, asking Buildbucket for the build status
[13:09:13.763] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:13.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:153:0) after 1m0s
[13:10:14.416] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:153:0)
[13:10:14.416] Timer tick, asking Buildbucket for the build status
[13:10:14.557] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:14.557] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:154:0) after 1m0s
[13:11:14.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:154:0)
[13:11:14.737] Timer tick, asking Buildbucket for the build status
[13:11:14.958] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:14.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:155:0) after 1m0s
[13:12:15.015] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:155:0)
[13:12:15.015] Timer tick, asking Buildbucket for the build status
[13:12:15.095] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:15.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:156:0) after 1m0s
[13:13:15.118] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:156:0)
[13:13:15.118] Timer tick, asking Buildbucket for the build status
[13:13:15.265] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:15.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:157:0) after 1m0s
[13:14:15.358] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:157:0)
[13:14:15.358] Timer tick, asking Buildbucket for the build status
[13:14:15.427] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:15.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:158:0) after 1m0s
[13:15:15.527] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:158:0)
[13:15:15.527] Timer tick, asking Buildbucket for the build status
[13:15:15.616] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:15.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:159:0) after 1m0s
[13:16:15.670] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:159:0)
[13:16:15.670] Timer tick, asking Buildbucket for the build status
[13:16:15.771] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:15.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:160:0) after 1m0s
[13:17:15.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:160:0)
[13:17:15.834] Timer tick, asking Buildbucket for the build status
[13:17:15.912] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:15.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:161:0) after 1m0s
[13:18:15.970] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:161:0)
[13:18:15.970] Timer tick, asking Buildbucket for the build status
[13:18:16.052] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:16.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:162:0) after 1m0s
[13:19:16.161] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:162:0)
[13:19:16.161] Timer tick, asking Buildbucket for the build status
[13:19:16.385] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:16.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:163:0) after 1m0s
[13:20:16.546] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:163:0)
[13:20:16.546] Timer tick, asking Buildbucket for the build status
[13:20:16.722] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:16.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:164:0) after 1m0s
[13:21:16.845] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:164:0)
[13:21:16.845] Timer tick, asking Buildbucket for the build status
[13:21:17.201] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:17.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:165:0) after 1m0s
[13:22:17.329] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:165:0)
[13:22:17.329] Timer tick, asking Buildbucket for the build status
[13:22:17.667] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:17.667] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:166:0) after 1m0s
[13:23:17.817] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:166:0)
[13:23:17.817] Timer tick, asking Buildbucket for the build status
[13:23:17.909] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:17.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:167:0) after 1m0s
[13:24:18.073] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:167:0)
[13:24:18.073] Timer tick, asking Buildbucket for the build status
[13:24:18.143] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:18.143] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:168:0) after 1m0s
[13:25:18.261] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:168:0)
[13:25:18.261] Timer tick, asking Buildbucket for the build status
[13:25:18.364] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:18.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:169:0) after 1m0s
[13:26:18.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:169:0)
[13:26:18.487] Timer tick, asking Buildbucket for the build status
[13:26:18.645] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:18.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:170:0) after 1m0s
[13:27:18.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:170:0)
[13:27:18.808] Timer tick, asking Buildbucket for the build status
[13:27:18.966] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:18.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:171:0) after 1m0s
[13:28:18.996] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:171:0)
[13:28:18.996] Timer tick, asking Buildbucket for the build status
[13:28:19.069] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:19.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:172:0) after 1m0s
[13:29:19.123] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:172:0)
[13:29:19.123] Timer tick, asking Buildbucket for the build status
[13:29:19.192] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:19.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:173:0) after 1m0s
[13:30:19.284] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:173:0)
[13:30:19.284] Timer tick, asking Buildbucket for the build status
[13:30:19.779] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:19.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:174:0) after 1m0s
[13:31:19.800] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:174:0)
[13:31:19.800] Timer tick, asking Buildbucket for the build status
[13:31:19.878] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:19.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:175:0) after 1m0s
[13:32:19.942] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:175:0)
[13:32:19.942] Timer tick, asking Buildbucket for the build status
[13:32:20.035] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:20.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:176:0) after 1m0s
[13:33:20.091] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:176:0)
[13:33:20.091] Timer tick, asking Buildbucket for the build status
[13:33:20.172] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:20.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:177:0) after 1m0s
[13:34:20.198] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:177:0)
[13:34:20.198] Timer tick, asking Buildbucket for the build status
[13:34:20.747] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:20.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:178:0) after 1m0s
[13:35:20.919] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:178:0)
[13:35:20.919] Timer tick, asking Buildbucket for the build status
[13:35:21.014] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:21.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:179:0) after 1m0s
[13:36:21.084] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:179:0)
[13:36:21.084] Timer tick, asking Buildbucket for the build status
[13:36:21.185] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:21.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:180:0) after 1m0s
[13:37:21.233] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:180:0)
[13:37:21.233] Timer tick, asking Buildbucket for the build status
[13:37:21.551] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:21.551] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:181:0) after 1m0s
[13:38:21.636] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:181:0)
[13:38:21.636] Timer tick, asking Buildbucket for the build status
[13:38:21.699] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:21.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:182:0) after 1m0s
[13:39:21.862] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:182:0)
[13:39:21.862] Timer tick, asking Buildbucket for the build status
[13:39:21.933] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:21.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:183:0) after 1m0s
[13:40:21.968] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:183:0)
[13:40:21.968] Timer tick, asking Buildbucket for the build status
[13:40:22.068] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:22.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:184:0) after 1m0s
[13:41:22.167] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:184:0)
[13:41:22.167] Timer tick, asking Buildbucket for the build status
[13:41:22.241] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:22.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:185:0) after 1m0s
[13:42:22.222] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:185:0)
[13:42:22.222] Timer tick, asking Buildbucket for the build status
[13:42:22.310] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:22.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:186:0) after 1m0s
[13:43:22.415] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:186:0)
[13:43:22.415] Timer tick, asking Buildbucket for the build status
[13:43:22.497] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:22.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:187:0) after 1m0s
[13:44:22.655] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:187:0)
[13:44:22.655] Timer tick, asking Buildbucket for the build status
[13:44:22.759] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:22.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:188:0) after 1m0s
[13:45:22.961] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:188:0)
[13:45:22.961] Timer tick, asking Buildbucket for the build status
[13:45:23.226] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:23.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:189:0) after 1m0s
[13:46:23.368] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:189:0)
[13:46:23.368] Timer tick, asking Buildbucket for the build status
[13:46:23.444] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:23.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:190:0) after 1m0s
[13:47:23.497] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:190:0)
[13:47:23.497] Timer tick, asking Buildbucket for the build status
[13:47:23.581] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:23.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:191:0) after 1m0s
[13:48:23.712] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:191:0)
[13:48:23.712] Timer tick, asking Buildbucket for the build status
[13:48:23.816] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:23.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:192:0) after 1m0s
[13:49:23.848] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:192:0)
[13:49:23.849] Timer tick, asking Buildbucket for the build status
[13:49:23.924] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:23.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:193:0) after 1m0s
[13:50:23.938] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:193:0)
[13:50:23.938] Timer tick, asking Buildbucket for the build status
[13:50:24.101] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:24.101] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:194:0) after 1m0s
[13:51:24.108] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:194:0)
[13:51:24.108] Timer tick, asking Buildbucket for the build status
[13:51:24.304] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:24.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:195:0) after 1m0s
[13:52:24.366] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:195:0)
[13:52:24.366] Timer tick, asking Buildbucket for the build status
[13:52:24.553] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:24.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:196:0) after 1m0s
[13:53:24.543] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:196:0)
[13:53:24.543] Timer tick, asking Buildbucket for the build status
[13:53:24.713] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:24.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:197:0) after 1m0s
[13:54:24.748] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:197:0)
[13:54:24.748] Timer tick, asking Buildbucket for the build status
[13:54:25.202] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:25.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:198:0) after 1m0s
[13:55:25.250] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:198:0)
[13:55:25.250] Timer tick, asking Buildbucket for the build status
[13:55:25.359] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:25.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:199:0) after 1m0s
[13:56:25.428] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:199:0)
[13:56:25.428] Timer tick, asking Buildbucket for the build status
[13:56:25.733] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:25.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:200:0) after 1m0s
[13:57:25.733] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:200:0)
[13:57:25.733] Timer tick, asking Buildbucket for the build status
[13:57:26.048] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:26.048] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:201:0) after 1m0s
[13:58:26.092] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:201:0)
[13:58:26.092] Timer tick, asking Buildbucket for the build status
[13:58:26.178] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:26.178] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:202:0) after 1m0s
[13:59:26.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:202:0)
[13:59:26.238] Timer tick, asking Buildbucket for the build status
[13:59:26.328] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:26.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:203:0) after 1m0s
[14:00:26.400] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:203:0)
[14:00:26.400] Timer tick, asking Buildbucket for the build status
[14:00:26.624] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:26.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:204:0) after 1m0s
[14:01:26.704] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:204:0)
[14:01:26.704] Timer tick, asking Buildbucket for the build status
[14:01:26.786] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:26.786] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:205:0) after 1m0s
[14:02:26.894] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:205:0)
[14:02:26.894] Timer tick, asking Buildbucket for the build status
[14:02:26.970] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:26.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:206:0) after 1m0s
[14:03:26.986] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:206:0)
[14:03:26.986] Timer tick, asking Buildbucket for the build status
[14:03:27.226] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:27.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:207:0) after 1m0s
[14:04:27.343] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:207:0)
[14:04:27.343] Timer tick, asking Buildbucket for the build status
[14:04:27.420] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:27.420] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:208:0) after 1m0s
[14:05:27.569] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:208:0)
[14:05:27.569] Timer tick, asking Buildbucket for the build status
[14:05:27.776] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:27.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:209:0) after 1m0s
[14:06:27.841] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:209:0)
[14:06:27.841] Timer tick, asking Buildbucket for the build status
[14:06:28.098] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:28.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:210:0) after 1m0s
[14:07:28.219] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:210:0)
[14:07:28.219] Timer tick, asking Buildbucket for the build status
[14:07:28.340] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:28.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:211:0) after 1m0s
[14:08:28.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:211:0)
[14:08:28.330] Timer tick, asking Buildbucket for the build status
[14:08:28.400] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:28.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:212:0) after 1m0s
[14:09:28.441] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:212:0)
[14:09:28.441] Timer tick, asking Buildbucket for the build status
[14:09:28.545] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:28.545] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:213:0) after 1m0s
[14:10:28.602] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:213:0)
[14:10:28.602] Timer tick, asking Buildbucket for the build status
[14:10:28.706] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:28.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:214:0) after 1m0s
[14:11:28.870] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:214:0)
[14:11:28.870] Timer tick, asking Buildbucket for the build status
[14:11:28.966] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:28.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:215:0) after 1m0s
[14:12:29.158] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:215:0)
[14:12:29.158] Timer tick, asking Buildbucket for the build status
[14:12:29.252] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:29.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:216:0) after 1m0s
[14:13:29.279] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:216:0)
[14:13:29.279] Timer tick, asking Buildbucket for the build status
[14:13:29.347] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:29.347] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:217:0) after 1m0s
[14:14:29.476] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:217:0)
[14:14:29.476] Timer tick, asking Buildbucket for the build status
[14:14:29.565] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:29.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:218:0) after 1m0s
[14:15:29.702] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:218:0)
[14:15:29.702] Timer tick, asking Buildbucket for the build status
[14:15:30.023] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:30.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:219:0) after 1m0s
[14:16:30.271] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:219:0)
[14:16:30.271] Timer tick, asking Buildbucket for the build status
[14:16:30.360] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:30.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:220:0) after 1m0s
[14:17:30.570] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:220:0)
[14:17:30.570] Timer tick, asking Buildbucket for the build status
[14:17:30.773] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:30.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:221:0) after 1m0s
[14:18:30.875] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:221:0)
[14:18:30.875] Timer tick, asking Buildbucket for the build status
[14:18:30.961] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:30.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:222:0) after 1m0s
[14:19:31.083] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:222:0)
[14:19:31.083] Timer tick, asking Buildbucket for the build status
[14:19:31.171] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:31.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:223:0) after 1m0s
[14:20:31.213] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:223:0)
[14:20:31.213] Timer tick, asking Buildbucket for the build status
[14:20:31.520] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:31.520] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:224:0) after 1m0s
[14:21:31.658] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:224:0)
[14:21:31.658] Timer tick, asking Buildbucket for the build status
[14:21:31.723] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:31.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:225:0) after 1m0s
[14:22:31.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:225:0)
[14:22:31.788] Timer tick, asking Buildbucket for the build status
[14:22:31.876] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:31.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:226:0) after 1m0s
[14:23:31.971] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:226:0)
[14:23:31.971] Timer tick, asking Buildbucket for the build status
[14:23:32.062] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:32.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:227:0) after 1m0s
[14:24:32.249] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:227:0)
[14:24:32.249] Timer tick, asking Buildbucket for the build status
[14:24:32.389] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:32.389] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:228:0) after 1m0s
[14:25:32.434] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:228:0)
[14:25:32.434] Timer tick, asking Buildbucket for the build status
[14:25:33.034] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:33.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:229:0) after 1m0s
[14:26:33.241] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:229:0)
[14:26:33.241] Timer tick, asking Buildbucket for the build status
[14:26:33.330] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:33.330] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:230:0) after 1m0s
[14:27:33.495] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:230:0)
[14:27:33.495] Timer tick, asking Buildbucket for the build status
[14:27:33.771] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:33.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:231:0) after 1m0s
[14:28:33.970] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:231:0)
[14:28:33.970] Timer tick, asking Buildbucket for the build status
[14:28:34.052] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:34.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:232:0) after 1m0s
[14:29:34.364] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:232:0)
[14:29:34.364] Timer tick, asking Buildbucket for the build status
[14:29:34.512] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:34.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:233:0) after 1m0s
[14:30:34.572] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:233:0)
[14:30:34.572] Timer tick, asking Buildbucket for the build status
[14:30:34.662] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:34.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:234:0) after 1m0s
[14:31:34.785] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:234:0)
[14:31:34.785] Timer tick, asking Buildbucket for the build status
[14:31:34.983] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:34.983] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:235:0) after 1m0s
[14:32:35.595] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:235:0)
[14:32:35.595] Timer tick, asking Buildbucket for the build status
[14:32:35.708] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:35.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:236:0) after 1m0s
[14:33:35.879] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:236:0)
[14:33:35.879] Timer tick, asking Buildbucket for the build status
[14:33:35.982] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:35.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:237:0) after 1m0s
[14:34:36.056] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:237:0)
[14:34:36.056] Timer tick, asking Buildbucket for the build status
[14:34:36.143] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:36.143] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:238:0) after 1m0s
[14:35:36.378] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:238:0)
[14:35:36.378] Timer tick, asking Buildbucket for the build status
[14:35:36.559] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:36.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:239:0) after 1m0s
[14:36:36.693] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:239:0)
[14:36:36.693] Timer tick, asking Buildbucket for the build status
[14:36:36.881] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:36.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:240:0) after 1m0s
[14:37:36.930] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:240:0)
[14:37:36.931] Timer tick, asking Buildbucket for the build status
[14:37:37.138] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:37.138] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:241:0) after 1m0s
[14:38:37.219] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:241:0)
[14:38:37.219] Timer tick, asking Buildbucket for the build status
[14:38:37.364] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:37.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:242:0) after 1m0s
[14:39:37.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:242:0)
[14:39:37.494] Timer tick, asking Buildbucket for the build status
[14:39:37.907] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:37.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:243:0) after 1m0s
[14:40:37.961] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:243:0)
[14:40:37.961] Timer tick, asking Buildbucket for the build status
[14:40:38.132] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:38.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:244:0) after 1m0s
[14:41:38.169] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:244:0)
[14:41:38.169] Timer tick, asking Buildbucket for the build status
[14:41:38.275] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:38.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:245:0) after 1m0s
[14:42:38.323] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:245:0)
[14:42:38.323] Timer tick, asking Buildbucket for the build status
[14:42:38.535] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:38.535] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:246:0) after 1m0s
[14:43:38.600] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:246:0)
[14:43:38.600] Timer tick, asking Buildbucket for the build status
[14:43:38.689] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:38.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:247:0) after 1m0s
[14:44:38.757] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:247:0)
[14:44:38.757] Timer tick, asking Buildbucket for the build status
[14:44:38.843] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:38.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:248:0) after 1m0s
[14:45:38.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:248:0)
[14:45:38.934] Timer tick, asking Buildbucket for the build status
[14:45:39.030] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:39.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:249:0) after 1m0s
[14:46:39.109] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:249:0)
[14:46:39.109] Timer tick, asking Buildbucket for the build status
[14:46:39.199] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:39.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:250:0) after 1m0s
[14:47:39.189] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:250:0)
[14:47:39.189] Timer tick, asking Buildbucket for the build status
[14:47:39.456] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:39.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:251:0) after 1m0s
[14:48:39.481] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:251:0)
[14:48:39.481] Timer tick, asking Buildbucket for the build status
[14:48:39.554] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:39.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:252:0) after 1m0s
[14:49:39.579] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:252:0)
[14:49:39.579] Timer tick, asking Buildbucket for the build status
[14:49:40.122] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:40.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:253:0) after 1m0s
[14:50:40.205] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:253:0)
[14:50:40.205] Timer tick, asking Buildbucket for the build status
[14:50:40.346] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:40.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:254:0) after 1m0s
[14:51:40.392] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:254:0)
[14:51:40.392] Timer tick, asking Buildbucket for the build status
[14:51:40.837] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:40.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:255:0) after 1m0s
[14:52:40.865] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:255:0)
[14:52:40.865] Timer tick, asking Buildbucket for the build status
[14:52:41.244] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:41.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:256:0) after 1m0s
[14:53:41.275] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:256:0)
[14:53:41.275] Timer tick, asking Buildbucket for the build status
[14:53:41.920] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:41.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:257:0) after 1m0s
[14:54:42.037] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:257:0)
[14:54:42.037] Timer tick, asking Buildbucket for the build status
[14:54:42.187] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:42.187] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:258:0) after 1m0s
[14:55:42.261] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:258:0)
[14:55:42.261] Timer tick, asking Buildbucket for the build status
[14:55:42.436] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:42.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:259:0) after 1m0s
[14:56:42.459] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:259:0)
[14:56:42.459] Timer tick, asking Buildbucket for the build status
[14:56:42.612] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:42.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:260:0) after 1m0s
[14:57:42.598] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:260:0)
[14:57:42.598] Timer tick, asking Buildbucket for the build status
[14:57:42.663] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:42.663] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:261:0) after 1m0s
[14:58:42.687] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:261:0)
[14:58:42.688] Timer tick, asking Buildbucket for the build status
[14:58:42.820] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:42.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:262:0) after 1m0s
[14:59:42.905] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:262:0)
[14:59:42.905] Timer tick, asking Buildbucket for the build status
[14:59:43.006] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:43.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:263:0) after 1m0s
[15:00:43.040] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:263:0)
[15:00:43.040] Timer tick, asking Buildbucket for the build status
[15:00:43.504] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:43.504] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:264:0) after 1m0s
[15:01:43.528] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:264:0)
[15:01:43.528] Timer tick, asking Buildbucket for the build status
[15:01:43.630] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:43.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:265:0) after 1m0s
[15:02:43.679] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:265:0)
[15:02:43.679] Timer tick, asking Buildbucket for the build status
[15:02:43.813] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:43.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:266:0) after 1m0s
[15:03:43.908] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:266:0)
[15:03:43.908] Timer tick, asking Buildbucket for the build status
[15:03:44.090] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:44.090] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:267:0) after 1m0s
[15:04:44.151] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:267:0)
[15:04:44.151] Timer tick, asking Buildbucket for the build status
[15:04:44.415] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:44.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:268:0) after 1m0s
[15:05:44.563] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:268:0)
[15:05:44.563] Timer tick, asking Buildbucket for the build status
[15:05:45.307] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:45.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:269:0) after 1m0s
[15:06:45.377] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:269:0)
[15:06:45.377] Timer tick, asking Buildbucket for the build status
[15:06:45.456] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:45.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:270:0) after 1m0s
[15:07:45.499] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:270:0)
[15:07:45.499] Timer tick, asking Buildbucket for the build status
[15:07:45.744] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:45.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:271:0) after 1m0s
[15:08:45.779] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:271:0)
[15:08:45.779] Timer tick, asking Buildbucket for the build status
[15:08:45.865] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:45.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:272:0) after 1m0s
[15:09:45.886] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:272:0)
[15:09:45.886] Timer tick, asking Buildbucket for the build status
[15:09:46.521] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:46.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:273:0) after 1m0s
[15:10:46.585] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:273:0)
[15:10:46.585] Timer tick, asking Buildbucket for the build status
[15:10:46.790] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:46.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:274:0) after 1m0s
[15:11:46.887] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:274:0)
[15:11:46.887] Timer tick, asking Buildbucket for the build status
[15:11:47.140] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:47.140] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:275:0) after 1m0s
[15:12:47.133] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:275:0)
[15:12:47.133] Timer tick, asking Buildbucket for the build status
[15:12:47.716] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:47.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:276:0) after 1m0s
[15:13:47.817] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:276:0)
[15:13:47.817] Timer tick, asking Buildbucket for the build status
[15:13:47.964] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:47.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:277:0) after 1m0s
[15:14:48.064] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:277:0)
[15:14:48.064] Timer tick, asking Buildbucket for the build status
[15:14:48.292] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:48.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:278:0) after 1m0s
[15:15:48.333] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:278:0)
[15:15:48.333] Timer tick, asking Buildbucket for the build status
[15:15:48.429] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:48.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:279:0) after 1m0s
[15:16:48.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:279:0)
[15:16:48.486] Timer tick, asking Buildbucket for the build status
[15:16:48.634] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:48.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:280:0) after 1m0s
[15:17:48.698] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:280:0)
[15:17:48.698] Timer tick, asking Buildbucket for the build status
[15:17:48.936] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:48.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:281:0) after 1m0s
[15:18:48.975] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:281:0)
[15:18:48.975] Timer tick, asking Buildbucket for the build status
[15:18:49.090] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:49.090] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:282:0) after 1m0s
[15:19:49.246] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:282:0)
[15:19:49.246] Timer tick, asking Buildbucket for the build status
[15:19:49.359] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:49.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:283:0) after 1m0s
[15:20:49.367] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:283:0)
[15:20:49.367] Timer tick, asking Buildbucket for the build status
[15:20:49.458] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:49.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:284:0) after 1m0s
[15:21:49.485] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:284:0)
[15:21:49.485] Timer tick, asking Buildbucket for the build status
[15:21:49.592] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:49.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:285:0) after 1m0s
[15:22:49.646] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:285:0)
[15:22:49.646] Timer tick, asking Buildbucket for the build status
[15:22:49.767] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:49.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:286:0) after 1m0s
[15:23:49.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:286:0)
[15:23:49.788] Timer tick, asking Buildbucket for the build status
[15:23:50.123] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:50.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:287:0) after 1m0s
[15:24:50.168] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:287:0)
[15:24:50.168] Timer tick, asking Buildbucket for the build status
[15:24:50.343] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:50.343] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:288:0) after 1m0s
[15:25:50.343] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:288:0)
[15:25:50.343] Timer tick, asking Buildbucket for the build status
[15:25:50.533] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:50.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:289:0) after 1m0s
[15:26:50.575] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:289:0)
[15:26:50.575] Timer tick, asking Buildbucket for the build status
[15:26:50.820] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:50.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:290:0) after 1m0s
[15:27:50.843] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:290:0)
[15:27:50.843] Timer tick, asking Buildbucket for the build status
[15:27:51.005] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:51.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:291:0) after 1m0s
[15:28:51.046] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:291:0)
[15:28:51.046] Timer tick, asking Buildbucket for the build status
[15:28:51.134] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:51.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:292:0) after 1m0s
[15:29:51.213] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:292:0)
[15:29:51.213] Timer tick, asking Buildbucket for the build status
[15:29:51.353] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:51.353] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:293:0) after 1m0s
[15:30:51.428] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:293:0)
[15:30:51.428] Timer tick, asking Buildbucket for the build status
[15:30:52.204] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:52.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:294:0) after 1m0s
[15:31:52.541] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:294:0)
[15:31:52.541] Timer tick, asking Buildbucket for the build status
[15:31:52.623] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:52.623] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:295:0) after 1m0s
[15:32:52.787] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:295:0)
[15:32:52.787] Timer tick, asking Buildbucket for the build status
[15:32:52.893] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:52.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:296:0) after 1m0s
[15:33:52.916] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:296:0)
[15:33:52.916] Timer tick, asking Buildbucket for the build status
[15:33:53.718] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:53.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:297:0) after 1m0s
[15:34:53.792] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:297:0)
[15:34:53.792] Timer tick, asking Buildbucket for the build status
[15:34:53.888] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:53.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:298:0) after 1m0s
[15:35:54.248] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:298:0)
[15:35:54.248] Timer tick, asking Buildbucket for the build status
[15:35:54.383] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:54.383] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:299:0) after 1m0s
[15:36:54.446] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:299:0)
[15:36:54.446] Timer tick, asking Buildbucket for the build status
[15:36:54.621] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:54.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:300:0) after 1m0s
[15:37:54.688] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:300:0)
[15:37:54.688] Timer tick, asking Buildbucket for the build status
[15:37:55.958] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:55.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:301:0) after 1m0s
[15:38:56.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:301:0)
[15:38:56.008] Timer tick, asking Buildbucket for the build status
[15:38:56.078] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:56.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:302:0) after 1m0s
[15:39:56.133] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:302:0)
[15:39:56.133] Timer tick, asking Buildbucket for the build status
[15:39:56.204] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:56.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:303:0) after 1m0s
[15:40:56.347] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:303:0)
[15:40:56.347] Timer tick, asking Buildbucket for the build status
[15:40:56.436] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:56.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:304:0) after 1m0s
[15:41:56.928] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:304:0)
[15:41:56.928] Timer tick, asking Buildbucket for the build status
[15:41:57.064] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:57.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:305:0) after 1m0s
[15:42:57.452] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:305:0)
[15:42:57.452] Timer tick, asking Buildbucket for the build status
[15:42:57.550] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:57.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:306:0) after 1m0s
[15:43:57.626] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:306:0)
[15:43:57.626] Timer tick, asking Buildbucket for the build status
[15:43:57.696] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:57.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:307:0) after 1m0s
[15:44:57.829] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:307:0)
[15:44:57.829] Timer tick, asking Buildbucket for the build status
[15:44:57.915] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:57.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:308:0) after 1m0s
[15:45:58.089] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:308:0)
[15:45:58.089] Timer tick, asking Buildbucket for the build status
[15:45:58.172] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:58.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:309:0) after 1m0s
[15:46:58.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:309:0)
[15:46:58.290] Timer tick, asking Buildbucket for the build status
[15:46:58.371] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:58.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:310:0) after 1m0s
[15:47:58.476] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:310:0)
[15:47:58.476] Timer tick, asking Buildbucket for the build status
[15:47:58.658] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:58.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:311:0) after 1m0s
[15:48:58.716] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:311:0)
[15:48:58.716] Timer tick, asking Buildbucket for the build status
[15:48:58.812] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:58.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:312:0) after 1m0s
[15:49:58.945] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:312:0)
[15:49:58.945] Timer tick, asking Buildbucket for the build status
[15:49:59.128] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:59.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:313:0) after 1m0s
[15:50:59.188] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:313:0)
[15:50:59.188] Timer tick, asking Buildbucket for the build status
[15:50:59.259] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:59.259] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:314:0) after 1m0s
[15:51:59.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:314:0)
[15:51:59.290] Timer tick, asking Buildbucket for the build status
[15:51:59.513] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:59.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:315:0) after 1m0s
[15:52:59.567] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:315:0)
[15:52:59.567] Timer tick, asking Buildbucket for the build status
[15:52:59.663] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:59.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:316:0) after 1m0s
[15:53:59.842] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:316:0)
[15:53:59.842] Timer tick, asking Buildbucket for the build status
[15:53:59.946] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:59.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:317:0) after 1m0s
[15:55:01.966] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:317:0)
[15:55:01.966] Timer tick, asking Buildbucket for the build status
[15:55:02.156] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:02.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:318:0) after 1m0s
[15:56:02.870] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:318:0)
[15:56:02.870] Timer tick, asking Buildbucket for the build status
[15:56:03.090] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:03.090] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:319:0) after 1m0s
[15:57:03.410] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:319:0)
[15:57:03.410] Timer tick, asking Buildbucket for the build status
[15:57:03.919] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:03.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:320:0) after 1m0s
[15:58:04.077] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:320:0)
[15:58:04.077] Timer tick, asking Buildbucket for the build status
[15:58:04.155] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:04.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:321:0) after 1m0s
[15:59:04.332] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:321:0)
[15:59:04.332] Timer tick, asking Buildbucket for the build status
[15:59:04.432] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:04.432] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:322:0) after 1m0s
[16:00:04.603] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:322:0)
[16:00:04.603] Timer tick, asking Buildbucket for the build status
[16:00:04.821] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:04.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:323:0) after 1m0s
[16:01:04.996] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:323:0)
[16:01:04.996] Timer tick, asking Buildbucket for the build status
[16:01:05.634] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:05.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:324:0) after 1m0s
[16:02:05.861] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:324:0)
[16:02:05.861] Timer tick, asking Buildbucket for the build status
[16:02:09.438] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:09.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:325:0) after 1m0s
[16:03:09.932] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:325:0)
[16:03:09.932] Timer tick, asking Buildbucket for the build status
[16:03:10.708] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:10.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:326:0) after 1m0s
[16:04:11.579] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:326:0)
[16:04:11.579] Timer tick, asking Buildbucket for the build status
[16:04:11.935] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:11.935] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:327:0) after 1m0s
[16:05:11.996] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:327:0)
[16:05:11.996] Timer tick, asking Buildbucket for the build status
[16:05:12.131] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:12.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:328:0) after 1m0s
[16:06:12.254] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:328:0)
[16:06:12.254] Timer tick, asking Buildbucket for the build status
[16:06:12.346] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:12.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:329:0) after 1m0s
[16:07:12.442] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:329:0)
[16:07:12.442] Timer tick, asking Buildbucket for the build status
[16:07:12.740] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:12.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:330:0) after 1m0s
[16:08:12.763] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:330:0)
[16:08:12.763] Timer tick, asking Buildbucket for the build status
[16:08:12.894] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:12.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:331:0) after 1m0s
[16:09:13.056] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:331:0)
[16:09:13.056] Timer tick, asking Buildbucket for the build status
[16:09:13.172] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:13.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:332:0) after 1m0s
[16:10:13.270] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:332:0)
[16:10:13.270] Timer tick, asking Buildbucket for the build status
[16:10:13.361] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:13.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:333:0) after 1m0s
[16:11:14.341] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:333:0)
[16:11:14.341] Timer tick, asking Buildbucket for the build status
[16:11:14.558] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:14.558] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:334:0) after 1m0s
[16:12:14.640] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:334:0)
[16:12:14.640] Timer tick, asking Buildbucket for the build status
[16:12:14.771] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:14.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:335:0) after 1m0s
[16:13:14.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:335:0)
[16:13:14.834] Timer tick, asking Buildbucket for the build status
[16:13:15.301] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:15.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:336:0) after 1m0s
[16:14:15.339] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:336:0)
[16:14:15.339] Timer tick, asking Buildbucket for the build status
[16:14:15.835] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:15.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:337:0) after 1m0s
[16:15:15.941] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:337:0)
[16:15:15.941] Timer tick, asking Buildbucket for the build status
[16:15:16.317] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:16.317] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:338:0) after 1m0s
[16:16:16.325] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:338:0)
[16:16:16.325] Timer tick, asking Buildbucket for the build status
[16:16:16.476] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:16.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:339:0) after 1m0s
[16:17:16.503] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:339:0)
[16:17:16.503] Timer tick, asking Buildbucket for the build status
[16:17:16.653] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:16.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:340:0) after 1m0s
[16:18:16.721] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:340:0)
[16:18:16.721] Timer tick, asking Buildbucket for the build status
[16:18:16.857] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:16.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:341:0) after 1m0s
[16:19:16.864] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:341:0)
[16:19:16.864] Timer tick, asking Buildbucket for the build status
[16:19:17.202] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:17.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:342:0) after 1m0s
[16:20:17.287] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:342:0)
[16:20:17.287] Timer tick, asking Buildbucket for the build status
[16:20:17.578] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:17.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:343:0) after 1m0s
[16:21:17.607] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:343:0)
[16:21:17.607] Timer tick, asking Buildbucket for the build status
[16:21:17.736] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:17.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:344:0) after 1m0s
[16:22:17.838] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:344:0)
[16:22:17.838] Timer tick, asking Buildbucket for the build status
[16:22:17.960] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:17.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:345:0) after 1m0s
[16:23:17.972] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:345:0)
[16:23:17.972] Timer tick, asking Buildbucket for the build status
[16:23:18.167] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:18.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:346:0) after 1m0s
[16:24:18.216] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:346:0)
[16:24:18.216] Timer tick, asking Buildbucket for the build status
[16:24:18.343] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:18.343] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:347:0) after 1m0s
[16:25:18.400] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:347:0)
[16:25:18.400] Timer tick, asking Buildbucket for the build status
[16:25:18.517] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:18.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:348:0) after 1m0s
[16:26:18.577] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:348:0)
[16:26:18.577] Timer tick, asking Buildbucket for the build status
[16:26:20.697] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:20.697] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:349:0) after 1m0s
[16:27:20.758] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:349:0)
[16:27:20.758] Timer tick, asking Buildbucket for the build status
[16:27:20.866] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:20.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:350:0) after 1m0s
[16:28:20.915] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:350:0)
[16:28:20.915] Timer tick, asking Buildbucket for the build status
[16:28:20.982] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:20.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:351:0) after 1m0s
[16:29:21.072] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:351:0)
[16:29:21.072] Timer tick, asking Buildbucket for the build status
[16:29:21.313] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:21.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:352:0) after 1m0s
[16:30:21.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:352:0)
[16:30:21.360] Timer tick, asking Buildbucket for the build status
[16:30:21.662] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:21.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:353:0) after 1m0s
[16:31:21.804] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:353:0)
[16:31:21.804] Timer tick, asking Buildbucket for the build status
[16:31:21.883] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:21.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:354:0) after 1m0s
[16:32:21.994] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:354:0)
[16:32:21.994] Timer tick, asking Buildbucket for the build status
[16:32:22.159] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:22.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:355:0) after 1m0s
[16:33:22.311] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:355:0)
[16:33:22.311] Timer tick, asking Buildbucket for the build status
[16:33:23.844] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:23.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:356:0) after 1m0s
[16:34:23.932] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:356:0)
[16:34:23.932] Timer tick, asking Buildbucket for the build status
[16:34:31.456] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:31.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:357:0) after 1m0s
[16:35:31.462] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:357:0)
[16:35:31.462] Timer tick, asking Buildbucket for the build status
[16:35:31.581] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:31.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:358:0) after 1m0s
[16:36:31.591] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:358:0)
[16:36:31.591] Timer tick, asking Buildbucket for the build status
[16:36:31.688] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:31.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:359:0) after 1m0s
[16:37:31.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:359:0)
[16:37:31.737] Timer tick, asking Buildbucket for the build status
[16:37:31.852] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:31.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:360:0) after 1m0s
[16:38:31.900] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:360:0)
[16:38:31.900] Timer tick, asking Buildbucket for the build status
[16:38:31.967] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:31.967] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:361:0) after 1m0s
[16:39:31.996] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:361:0)
[16:39:31.996] Timer tick, asking Buildbucket for the build status
[16:39:32.141] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:32.141] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:362:0) after 1m0s
[16:40:32.171] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:362:0)
[16:40:32.171] Timer tick, asking Buildbucket for the build status
[16:40:32.267] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:32.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:363:0) after 1m0s
[16:41:32.299] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:363:0)
[16:41:32.299] Timer tick, asking Buildbucket for the build status
[16:41:32.387] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:32.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:364:0) after 1m0s
[16:42:32.502] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:364:0)
[16:42:32.502] Timer tick, asking Buildbucket for the build status
[16:42:32.587] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:32.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:365:0) after 1m0s
[16:43:33.391] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:365:0)
[16:43:33.391] Timer tick, asking Buildbucket for the build status
[16:43:33.523] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:33.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:366:0) after 1m0s
[16:44:34.166] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:366:0)
[16:44:34.166] Timer tick, asking Buildbucket for the build status
[16:44:34.245] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:34.245] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:367:0) after 1m0s
[16:45:34.589] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:367:0)
[16:45:34.589] Timer tick, asking Buildbucket for the build status
[16:45:34.768] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:34.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:368:0) after 1m0s
[16:46:34.849] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:368:0)
[16:46:34.849] Timer tick, asking Buildbucket for the build status
[16:46:35.339] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:35.339] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:369:0) after 1m0s
[16:47:35.663] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:369:0)
[16:47:35.663] Timer tick, asking Buildbucket for the build status
[16:47:35.749] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:35.749] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:370:0) after 1m0s
[16:48:36.000] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:370:0)
[16:48:36.000] Timer tick, asking Buildbucket for the build status
[16:48:36.083] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:36.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:371:0) after 1m0s
[16:49:36.237] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:371:0)
[16:49:36.237] Timer tick, asking Buildbucket for the build status
[16:49:36.313] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:36.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:372:0) after 1m0s
[16:50:36.548] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:372:0)
[16:50:36.548] Timer tick, asking Buildbucket for the build status
[16:50:36.678] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:36.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:373:0) after 1m0s
[16:51:37.021] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:373:0)
[16:51:37.021] Timer tick, asking Buildbucket for the build status
[16:51:37.129] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:37.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:374:0) after 1m0s
[16:52:37.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:374:0)
[16:52:37.238] Timer tick, asking Buildbucket for the build status
[16:52:37.429] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:37.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:375:0) after 1m0s
[16:53:37.411] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:375:0)
[16:53:37.411] Timer tick, asking Buildbucket for the build status
[16:53:37.725] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:37.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:376:0) after 1m0s
[16:54:37.757] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:376:0)
[16:54:37.757] Timer tick, asking Buildbucket for the build status
[16:54:37.937] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:37.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:377:0) after 1m0s
[16:55:37.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:377:0)
[16:55:37.960] Timer tick, asking Buildbucket for the build status
[16:55:39.042] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:39.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:378:0) after 1m0s
[16:56:39.130] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:378:0)
[16:56:39.130] Timer tick, asking Buildbucket for the build status
[16:56:39.325] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:39.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:379:0) after 1m0s
[16:57:39.355] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:379:0)
[16:57:39.355] Timer tick, asking Buildbucket for the build status
[16:57:40.107] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:40.107] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:380:0) after 1m0s
[16:58:40.337] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:380:0)
[16:58:40.338] Timer tick, asking Buildbucket for the build status
[16:58:40.430] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:40.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:381:0) after 1m0s
[16:59:40.438] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:381:0)
[16:59:40.438] Timer tick, asking Buildbucket for the build status
[16:59:40.527] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:40.527] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:382:0) after 1m0s
[17:00:40.664] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:382:0)
[17:00:40.664] Timer tick, asking Buildbucket for the build status
[17:00:40.818] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:40.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:383:0) after 1m0s
[17:01:40.871] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:383:0)
[17:01:40.871] Timer tick, asking Buildbucket for the build status
[17:01:41.050] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:41.050] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:384:0) after 1m0s
[17:02:41.053] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:384:0)
[17:02:41.053] Timer tick, asking Buildbucket for the build status
[17:02:41.157] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:41.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:385:0) after 1m0s
[17:03:41.216] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:385:0)
[17:03:41.216] Timer tick, asking Buildbucket for the build status
[17:03:41.392] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:41.392] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:386:0) after 1m0s
[17:04:41.450] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:386:0)
[17:04:41.450] Timer tick, asking Buildbucket for the build status
[17:04:44.174] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:44.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:387:0) after 1m0s
[17:05:44.293] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:387:0)
[17:05:44.293] Timer tick, asking Buildbucket for the build status
[17:05:44.609] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:44.609] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:388:0) after 1m0s
[17:06:44.697] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:388:0)
[17:06:44.697] Timer tick, asking Buildbucket for the build status
[17:06:44.815] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:44.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:389:0) after 1m0s
[17:07:44.930] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:389:0)
[17:07:44.930] Timer tick, asking Buildbucket for the build status
[17:07:45.066] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:45.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:390:0) after 1m0s
[17:08:45.181] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:390:0)
[17:08:45.181] Timer tick, asking Buildbucket for the build status
[17:08:45.431] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:45.431] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:391:0) after 1m0s
[17:09:45.531] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:391:0)
[17:09:45.531] Timer tick, asking Buildbucket for the build status
[17:09:45.682] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:45.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:392:0) after 1m0s
[17:10:46.053] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:392:0)
[17:10:46.053] Timer tick, asking Buildbucket for the build status
[17:10:46.966] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:46.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:393:0) after 1m0s
[17:11:47.076] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:393:0)
[17:11:47.076] Timer tick, asking Buildbucket for the build status
[17:11:49.409] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:49.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:394:0) after 1m0s
[17:12:49.404] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:394:0)
[17:12:49.404] Timer tick, asking Buildbucket for the build status
[17:12:49.537] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:49.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:395:0) after 1m0s
[17:13:49.576] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:395:0)
[17:13:49.576] Timer tick, asking Buildbucket for the build status
[17:13:49.661] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:49.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:396:0) after 1m0s
[17:14:49.692] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:396:0)
[17:14:49.692] Timer tick, asking Buildbucket for the build status
[17:14:49.788] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:49.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:397:0) after 1m0s
[17:15:49.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:397:0)
[17:15:49.844] Timer tick, asking Buildbucket for the build status
[17:15:50.540] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:50.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:398:0) after 1m0s
[17:16:50.623] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:398:0)
[17:16:50.623] Timer tick, asking Buildbucket for the build status
[17:16:50.836] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:50.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:399:0) after 1m0s
[17:17:50.867] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:399:0)
[17:17:50.867] Timer tick, asking Buildbucket for the build status
[17:17:51.028] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:51.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:400:0) after 1m0s
[17:18:51.062] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:400:0)
[17:18:51.062] Timer tick, asking Buildbucket for the build status
[17:18:51.175] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:51.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:401:0) after 1m0s
[17:19:51.228] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:401:0)
[17:19:51.228] Timer tick, asking Buildbucket for the build status
[17:19:51.314] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:51.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:402:0) after 1m0s
[17:20:51.356] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:402:0)
[17:20:51.356] Timer tick, asking Buildbucket for the build status
[17:20:51.488] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:51.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:403:0) after 1m0s
[17:21:51.566] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:403:0)
[17:21:51.566] Timer tick, asking Buildbucket for the build status
[17:21:51.810] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:51.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:404:0) after 1m0s
[17:22:52.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:404:0)
[17:22:52.186] Timer tick, asking Buildbucket for the build status
[17:22:52.458] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:52.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:405:0) after 1m0s
[17:23:53.056] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:405:0)
[17:23:53.056] Timer tick, asking Buildbucket for the build status
[17:23:53.291] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:53.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:406:0) after 1m0s
[17:24:55.474] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:406:0)
[17:24:55.474] Timer tick, asking Buildbucket for the build status
[17:24:56.005] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:56.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:407:0) after 1m0s
[17:25:56.417] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:407:0)
[17:25:56.417] Timer tick, asking Buildbucket for the build status
[17:25:56.525] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:56.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:408:0) after 1m0s
[17:26:56.728] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:408:0)
[17:26:56.728] Timer tick, asking Buildbucket for the build status
[17:26:56.836] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:56.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:409:0) after 1m0s
[17:27:57.254] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:409:0)
[17:27:57.254] Timer tick, asking Buildbucket for the build status
[17:27:57.573] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:57.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:410:0) after 1m0s
[17:28:57.637] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:410:0)
[17:28:57.637] Timer tick, asking Buildbucket for the build status
[17:28:57.731] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:57.731] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:411:0) after 1m0s
[17:29:57.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:411:0)
[17:29:57.793] Timer tick, asking Buildbucket for the build status
[17:29:58.212] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:58.212] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:412:0) after 1m0s
[17:30:58.243] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:412:0)
[17:30:58.243] Timer tick, asking Buildbucket for the build status
[17:30:58.368] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:58.368] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:413:0) after 1m0s
[17:31:58.455] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:413:0)
[17:31:58.455] Timer tick, asking Buildbucket for the build status
[17:31:58.589] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:58.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:414:0) after 1m0s
[17:32:58.601] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:414:0)
[17:32:58.601] Timer tick, asking Buildbucket for the build status
[17:32:58.683] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:58.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:415:0) after 1m0s
[17:33:58.727] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:415:0)
[17:33:58.727] Timer tick, asking Buildbucket for the build status
[17:33:58.807] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:58.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:416:0) after 1m0s
[17:34:58.839] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:416:0)
[17:34:58.839] Timer tick, asking Buildbucket for the build status
[17:34:59.165] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:59.165] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:417:0) after 1m0s
[17:35:59.179] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:417:0)
[17:35:59.179] Timer tick, asking Buildbucket for the build status
[17:35:59.276] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:59.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:418:0) after 1m0s
[17:36:59.335] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:418:0)
[17:36:59.335] Timer tick, asking Buildbucket for the build status
[17:36:59.726] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:59.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:419:0) after 1m0s
[17:37:59.760] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:419:0)
[17:37:59.760] Timer tick, asking Buildbucket for the build status
[17:37:59.846] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:59.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:420:0) after 1m0s
[17:38:59.898] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:420:0)
[17:38:59.898] Timer tick, asking Buildbucket for the build status
[17:39:00.199] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:00.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:421:0) after 1m0s
[17:40:00.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:421:0)
[17:40:00.251] Timer tick, asking Buildbucket for the build status
[17:40:00.528] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:00.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:422:0) after 1m0s
[17:41:00.558] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:422:0)
[17:41:00.558] Timer tick, asking Buildbucket for the build status
[17:41:00.689] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:00.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:423:0) after 1m0s
[17:42:01.109] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:423:0)
[17:42:01.109] Timer tick, asking Buildbucket for the build status
[17:42:01.193] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:01.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:424:0) after 1m0s
[17:43:01.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:424:0)
[17:43:01.238] Timer tick, asking Buildbucket for the build status
[17:43:03.127] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:03.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:425:0) after 1m0s
[17:44:03.244] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:425:0)
[17:44:03.244] Timer tick, asking Buildbucket for the build status
[17:44:03.345] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:03.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:426:0) after 1m0s
[17:45:03.397] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:426:0)
[17:45:03.397] Timer tick, asking Buildbucket for the build status
[17:45:03.849] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:03.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:427:0) after 1m0s
[17:46:03.883] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:427:0)
[17:46:03.883] Timer tick, asking Buildbucket for the build status
[17:46:03.964] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:03.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:428:0) after 1m0s
[17:47:03.995] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:428:0)
[17:47:03.995] Timer tick, asking Buildbucket for the build status
[17:47:05.032] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:05.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:429:0) after 1m0s
[17:48:05.100] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:429:0)
[17:48:05.100] Timer tick, asking Buildbucket for the build status
[17:48:05.188] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:05.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:430:0) after 1m0s
[17:49:05.234] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:430:0)
[17:49:05.234] Timer tick, asking Buildbucket for the build status
[17:49:05.320] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
--- the log has been cut here ---
[21:19:30.654] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:30.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:640:0) after 1m0s
[21:20:30.688] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:640:0)
[21:20:30.688] Timer tick, asking Buildbucket for the build status
[21:20:30.794] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:30.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:641:0) after 1m0s
[21:21:30.810] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:641:0)
[21:21:30.810] Timer tick, asking Buildbucket for the build status
[21:21:30.892] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:30.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:642:0) after 1m0s
[21:22:30.956] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:642:0)
[21:22:30.956] Timer tick, asking Buildbucket for the build status
[21:22:31.045] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:31.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:643:0) after 1m0s
[21:23:31.254] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:643:0)
[21:23:31.254] Timer tick, asking Buildbucket for the build status
[21:23:31.351] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:31.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:644:0) after 1m0s
[21:24:31.473] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:644:0)
[21:24:31.473] Timer tick, asking Buildbucket for the build status
[21:24:31.581] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:31.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:645:0) after 1m0s
[21:25:31.564] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:645:0)
[21:25:31.564] Timer tick, asking Buildbucket for the build status
[21:25:31.648] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:31.648] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:646:0) after 1m0s
[21:26:31.720] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:646:0)
[21:26:31.720] Timer tick, asking Buildbucket for the build status
[21:26:31.866] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:31.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:647:0) after 1m0s
[21:27:31.914] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:647:0)
[21:27:31.914] Timer tick, asking Buildbucket for the build status
[21:27:32.046] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:32.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:648:0) after 1m0s
[21:28:32.119] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:648:0)
[21:28:32.119] Timer tick, asking Buildbucket for the build status
[21:28:33.314] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:33.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:649:0) after 1m0s
[21:29:34.206] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:649:0)
[21:29:34.206] Timer tick, asking Buildbucket for the build status
[21:29:34.327] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:34.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:650:0) after 1m0s
[21:30:34.436] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:650:0)
[21:30:34.436] Timer tick, asking Buildbucket for the build status
[21:30:34.549] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:34.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:651:0) after 1m0s
[21:31:34.702] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:651:0)
[21:31:34.702] Timer tick, asking Buildbucket for the build status
[21:31:34.774] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:34.774] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:652:0) after 1m0s
[21:32:34.772] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:652:0)
[21:32:34.772] Timer tick, asking Buildbucket for the build status
[21:32:34.836] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:34.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:653:0) after 1m0s
[21:33:34.891] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:653:0)
[21:33:34.891] Timer tick, asking Buildbucket for the build status
[21:33:35.058] Build 8853968027915921040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:35.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9019398091268177712:654:0) after 1m0s
[21:33:57.264] Received PubSub notification, asking Buildbucket for the build status
[21:33:57.332] Build 8853968027915921040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:33:57.332] Buildbucket build:
{
"build": {
"bucket": "luci.nacl.ci",
"canary_preference": "PROD",
"completed_ts": "1614634436578770",
"created_by": "project:nacl",
"created_ts": "1614595115702275",
"id": "8853968027915921040",
"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\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\", \"title\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}}",
"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\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\", \"title\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-flex-ci-xenial-11-b766\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.nacl\", \"buildername\": \"linux-64-validator-opt\", \"buildnumber\": 168, \"got_revision\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_7400dfb32d29ad49c88b7f88800b69b6d930e3bb5ad8d0eecfbdfeb7918fe3eb_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-flex-ci-xenial-11-b766\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614595834024046",
"status": "COMPLETED",
"status_changed_ts": "1614634436958802",
"tags": [
"build_address:luci.nacl.ci/linux-64-validator-opt/168",
"builder:linux-64-validator-opt",
"buildset:commit/git/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/b76bff4a0db45a20d41646ddd76b7e9ab7bf4a6a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019398091268177712",
"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/8853968027915921040/+/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:52062fdd52287b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614634436983947",
"url": "https://ci.chromium.org/b/8853968027915921040",
"utcnow_ts": "1614634437325212"
}
}
[21:33:57.332] Invocation finished in 10h55m24.211507506s with status SUCCEEDED