[22:48:45.165] New invocation is queued and will start shortly
[22:48:46.350] Starting the invocation (attempt 1)
[22:48:46.387] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:48:46.387] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:48:46.387] Buildbucket request:
{
"bucket": "luci.nacl.ci",
"client_operation_id": "9035025426220201216",
"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\":\"69a0d6e8affc94187af10e0673592d1b238c6eb0\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@69a0d6e8affc94187af10e0673592d1b238c6eb0\",\"title\":\"69a0d6e8affc94187af10e0673592d1b238c6eb0\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/69a0d6e8affc94187af10e0673592d1b238c6eb0\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"69a0d6e8affc94187af10e0673592d1b238c6eb0\"}}",
"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:9035025426220201216",
"scheduler_job_id:nacl/linux-64-validator-opt",
"user_agent:luci-scheduler",
"buildset:commit/git/69a0d6e8affc94187af10e0673592d1b238c6eb0",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/69a0d6e8affc94187af10e0673592d1b238c6eb0",
"gitiles_ref:refs/heads/master"
]
}
[22:48:47.819] Buildbucket response:
{
"build": {
"bucket": "luci.nacl.ci",
"canary_preference": "PROD",
"created_by": "project:nacl",
"created_ts": "1599691726478067",
"id": "8869595364174498400",
"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\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"title\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/69a0d6e8affc94187af10e0673592d1b238c6eb0\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\"}}",
"project": "nacl",
"result_details_json": "{\"properties\": {}}",
"service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599691727514552",
"tags": [
"build_address:luci.nacl.ci/linux-64-validator-opt/150",
"builder:linux-64-validator-opt",
"buildset:commit/git/69a0d6e8affc94187af10e0673592d1b238c6eb0",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/69a0d6e8affc94187af10e0673592d1b238c6eb0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035025426220201216",
"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/8869595364174498400/+/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": "1599691727515183",
"url": "https://ci.chromium.org/b/8869595364174498400",
"utcnow_ts": "1599691727805586"
}
}
[22:48:47.819] Task URL: https://ci.chromium.org/b/8869595364174498400
[22:48:47.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:2:0) after 1m0s
[22:49:42.023] Received PubSub notification, asking Buildbucket for the build status
[22:49:42.358] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:48.222] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:2:0)
[22:49:48.222] Timer tick, asking Buildbucket for the build status
[22:49:49.073] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:49.073] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:4:0) after 1m0s
[22:50:49.187] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:4:0)
[22:50:49.187] Timer tick, asking Buildbucket for the build status
[22:50:49.741] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:49.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:5:0) after 1m0s
[22:51:50.438] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:5:0)
[22:51:50.439] Timer tick, asking Buildbucket for the build status
[22:51:50.779] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:50.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:6:0) after 1m0s
[22:52:50.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:6:0)
[22:52:50.929] Timer tick, asking Buildbucket for the build status
[22:52:51.037] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:51.037] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:7:0) after 1m0s
[22:53:52.196] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:7:0)
[22:53:52.196] Timer tick, asking Buildbucket for the build status
[22:53:52.335] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:52.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:8:0) after 1m0s
[22:54:52.640] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:8:0)
[22:54:52.641] Timer tick, asking Buildbucket for the build status
[22:54:53.041] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:53.041] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:9:0) after 1m0s
[22:55:53.311] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:9:0)
[22:55:53.311] Timer tick, asking Buildbucket for the build status
[22:55:53.375] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:53.375] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:10:0) after 1m0s
[22:56:53.592] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:10:0)
[22:56:53.592] Timer tick, asking Buildbucket for the build status
[22:56:53.824] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:53.824] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:11:0) after 1m0s
[22:57:54.067] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:11:0)
[22:57:54.067] Timer tick, asking Buildbucket for the build status
[22:57:54.161] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:54.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:12:0) after 1m0s
[22:58:54.372] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:12:0)
[22:58:54.372] Timer tick, asking Buildbucket for the build status
[22:58:54.576] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:54.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:13:0) after 1m0s
[22:59:54.706] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:13:0)
[22:59:54.706] Timer tick, asking Buildbucket for the build status
[22:59:54.848] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:54.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:14:0) after 1m0s
[23:00:55.399] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:14:0)
[23:00:55.400] Timer tick, asking Buildbucket for the build status
[23:00:55.493] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:55.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:15:0) after 1m0s
[23:01:55.501] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:15:0)
[23:01:55.501] Timer tick, asking Buildbucket for the build status
[23:01:55.566] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:55.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:16:0) after 1m0s
[23:02:55.615] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:16:0)
[23:02:55.615] Timer tick, asking Buildbucket for the build status
[23:02:55.677] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:55.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:17:0) after 1m0s
[23:03:55.690] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:17:0)
[23:03:55.690] Timer tick, asking Buildbucket for the build status
[23:03:55.972] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:55.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:18:0) after 1m0s
[23:04:56.082] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:18:0)
[23:04:56.082] Timer tick, asking Buildbucket for the build status
[23:04:56.703] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:56.703] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:19:0) after 1m0s
[23:05:56.801] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:19:0)
[23:05:56.801] Timer tick, asking Buildbucket for the build status
[23:05:56.871] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:56.871] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:20:0) after 1m0s
[23:06:56.971] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:20:0)
[23:06:56.971] Timer tick, asking Buildbucket for the build status
[23:06:57.034] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:57.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:21:0) after 1m0s
[23:07:57.091] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:21:0)
[23:07:57.091] Timer tick, asking Buildbucket for the build status
[23:07:57.203] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:57.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:22:0) after 1m0s
[23:08:57.293] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:22:0)
[23:08:57.293] Timer tick, asking Buildbucket for the build status
[23:08:57.560] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:57.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:23:0) after 1m0s
[23:09:57.551] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:23:0)
[23:09:57.551] Timer tick, asking Buildbucket for the build status
[23:09:57.947] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:57.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:24:0) after 1m0s
[23:10:58.065] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:24:0)
[23:10:58.065] Timer tick, asking Buildbucket for the build status
[23:10:58.146] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:58.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:25:0) after 1m0s
[23:11:58.226] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:25:0)
[23:11:58.226] Timer tick, asking Buildbucket for the build status
[23:11:58.292] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:58.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:26:0) after 1m0s
[23:12:58.342] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:26:0)
[23:12:58.342] Timer tick, asking Buildbucket for the build status
[23:12:58.472] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:58.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:27:0) after 1m0s
[23:13:58.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:27:0)
[23:13:58.517] Timer tick, asking Buildbucket for the build status
[23:13:59.072] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:59.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:28:0) after 1m0s
[23:14:59.092] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:28:0)
[23:14:59.092] Timer tick, asking Buildbucket for the build status
[23:14:59.241] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:59.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:29:0) after 1m0s
[23:15:59.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:29:0)
[23:15:59.239] Timer tick, asking Buildbucket for the build status
[23:15:59.506] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:59.506] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:30:0) after 1m0s
[23:16:59.622] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:30:0)
[23:16:59.622] Timer tick, asking Buildbucket for the build status
[23:16:59.797] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:59.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:31:0) after 1m0s
[23:17:59.821] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:31:0)
[23:17:59.821] Timer tick, asking Buildbucket for the build status
[23:17:59.889] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:59.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:32:0) after 1m0s
[23:18:59.989] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:32:0)
[23:18:59.989] Timer tick, asking Buildbucket for the build status
[23:19:00.112] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:00.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:33:0) after 1m0s
[23:20:00.201] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:33:0)
[23:20:00.201] Timer tick, asking Buildbucket for the build status
[23:20:00.413] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:00.413] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:34:0) after 1m0s
[23:21:01.792] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:34:0)
[23:21:01.792] Timer tick, asking Buildbucket for the build status
[23:21:01.863] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:01.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:35:0) after 1m0s
[23:22:01.913] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:35:0)
[23:22:01.913] Timer tick, asking Buildbucket for the build status
[23:22:02.442] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:02.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:36:0) after 1m0s
[23:23:02.480] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:36:0)
[23:23:02.480] Timer tick, asking Buildbucket for the build status
[23:23:02.657] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:02.657] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:37:0) after 1m0s
[23:24:02.680] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:37:0)
[23:24:02.680] Timer tick, asking Buildbucket for the build status
[23:24:02.837] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:02.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:38:0) after 1m0s
[23:25:02.925] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:38:0)
[23:25:02.925] Timer tick, asking Buildbucket for the build status
[23:25:03.067] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:03.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:39:0) after 1m0s
[23:26:03.113] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:39:0)
[23:26:03.113] Timer tick, asking Buildbucket for the build status
[23:26:03.200] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:03.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:40:0) after 1m0s
[23:27:03.219] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:40:0)
[23:27:03.219] Timer tick, asking Buildbucket for the build status
[23:27:03.892] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:03.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:41:0) after 1m0s
[23:28:03.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:41:0)
[23:28:03.960] Timer tick, asking Buildbucket for the build status
[23:28:04.028] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:04.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:42:0) after 1m0s
[23:29:04.135] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:42:0)
[23:29:04.135] Timer tick, asking Buildbucket for the build status
[23:29:04.276] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:04.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:43:0) after 1m0s
[23:30:04.300] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:43:0)
[23:30:04.300] Timer tick, asking Buildbucket for the build status
[23:30:04.532] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:04.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:44:0) after 1m0s
[23:31:04.680] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:44:0)
[23:31:04.680] Timer tick, asking Buildbucket for the build status
[23:31:09.308] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:09.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:45:0) after 1m0s
[23:32:09.373] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:45:0)
[23:32:09.373] Timer tick, asking Buildbucket for the build status
[23:32:09.479] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:09.480] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:46:0) after 1m0s
[23:33:09.562] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:46:0)
[23:33:09.562] Timer tick, asking Buildbucket for the build status
[23:33:09.667] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:09.667] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:47:0) after 1m0s
[23:34:09.734] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:47:0)
[23:34:09.734] Timer tick, asking Buildbucket for the build status
[23:34:10.072] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:10.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:48:0) after 1m0s
[23:35:10.187] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:48:0)
[23:35:10.187] Timer tick, asking Buildbucket for the build status
[23:35:10.399] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:10.399] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:49:0) after 1m0s
[23:36:10.461] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:49:0)
[23:36:10.462] Timer tick, asking Buildbucket for the build status
[23:36:10.641] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:10.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:50:0) after 1m0s
[23:37:10.681] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:50:0)
[23:37:10.681] Timer tick, asking Buildbucket for the build status
[23:37:10.808] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:10.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:51:0) after 1m0s
[23:38:10.868] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:51:0)
[23:38:10.868] Timer tick, asking Buildbucket for the build status
[23:38:10.954] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:10.955] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:52:0) after 1m0s
[23:39:10.995] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:52:0)
[23:39:10.995] Timer tick, asking Buildbucket for the build status
[23:39:11.176] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:11.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:53:0) after 1m0s
[23:40:11.195] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:53:0)
[23:40:11.195] Timer tick, asking Buildbucket for the build status
[23:40:14.386] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:14.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:54:0) after 1m0s
[23:41:14.501] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:54:0)
[23:41:14.501] Timer tick, asking Buildbucket for the build status
[23:41:14.617] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:14.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:55:0) after 1m0s
[23:42:14.673] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:55:0)
[23:42:14.673] Timer tick, asking Buildbucket for the build status
[23:42:14.742] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:14.742] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:56:0) after 1m0s
[23:43:14.931] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:56:0)
[23:43:14.931] Timer tick, asking Buildbucket for the build status
[23:43:15.032] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:15.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:57:0) after 1m0s
[23:44:15.164] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:57:0)
[23:44:15.164] Timer tick, asking Buildbucket for the build status
[23:44:15.303] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:15.303] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:58:0) after 1m0s
[23:45:15.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:58:0)
[23:45:15.487] Timer tick, asking Buildbucket for the build status
[23:45:15.551] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:15.551] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:59:0) after 1m0s
[23:46:15.566] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:59:0)
[23:46:15.566] Timer tick, asking Buildbucket for the build status
[23:46:15.978] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:15.978] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:60:0) after 1m0s
[23:47:16.281] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:60:0)
[23:47:16.281] Timer tick, asking Buildbucket for the build status
[23:47:16.428] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:16.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:61:0) after 1m0s
[23:48:16.435] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:61:0)
[23:48:16.435] Timer tick, asking Buildbucket for the build status
[23:48:16.542] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:16.542] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:62:0) after 1m0s
[23:49:16.678] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:62:0)
[23:49:16.678] Timer tick, asking Buildbucket for the build status
[23:49:16.843] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:16.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:63:0) after 1m0s
[23:50:16.912] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:63:0)
[23:50:16.912] Timer tick, asking Buildbucket for the build status
[23:50:16.989] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:16.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:64:0) after 1m0s
[23:51:17.018] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:64:0)
[23:51:17.018] Timer tick, asking Buildbucket for the build status
[23:51:17.102] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:17.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:65:0) after 1m0s
[23:52:17.214] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:65:0)
[23:52:17.214] Timer tick, asking Buildbucket for the build status
[23:52:17.308] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:17.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:66:0) after 1m0s
[23:53:17.369] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:66:0)
[23:53:17.369] Timer tick, asking Buildbucket for the build status
[23:53:17.950] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:17.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:67:0) after 1m0s
[23:54:17.964] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:67:0)
[23:54:17.964] Timer tick, asking Buildbucket for the build status
[23:54:18.075] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:18.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:68:0) after 1m0s
[23:55:18.136] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:68:0)
[23:55:18.136] Timer tick, asking Buildbucket for the build status
[23:55:18.237] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:18.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:69:0) after 1m0s
[23:56:18.261] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:69:0)
[23:56:18.261] Timer tick, asking Buildbucket for the build status
[23:56:18.536] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:18.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:70:0) after 1m0s
[23:57:18.668] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:70:0)
[23:57:18.669] Timer tick, asking Buildbucket for the build status
[23:57:18.748] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:18.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:71:0) after 1m0s
[23:58:18.841] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:71:0)
[23:58:18.841] Timer tick, asking Buildbucket for the build status
[23:58:18.906] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:18.906] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:72:0) after 1m0s
[23:59:18.902] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:72:0)
[23:59:18.902] Timer tick, asking Buildbucket for the build status
[23:59:19.009] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:19.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:73:0) after 1m0s
[00:00:19.109] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:73:0)
[00:00:19.109] Timer tick, asking Buildbucket for the build status
[00:00:19.440] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:19.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:74:0) after 1m0s
[00:01:19.463] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:74:0)
[00:01:19.463] Timer tick, asking Buildbucket for the build status
[00:01:19.790] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:19.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:75:0) after 1m0s
[00:02:19.835] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:75:0)
[00:02:19.835] Timer tick, asking Buildbucket for the build status
[00:02:19.905] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:19.906] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:76:0) after 1m0s
[00:03:20.041] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:76:0)
[00:03:20.041] Timer tick, asking Buildbucket for the build status
[00:03:20.146] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:20.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:77:0) after 1m0s
[00:04:20.197] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:77:0)
[00:04:20.197] Timer tick, asking Buildbucket for the build status
[00:04:20.499] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:20.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:78:0) after 1m0s
[00:05:20.547] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:78:0)
[00:05:20.547] Timer tick, asking Buildbucket for the build status
[00:05:20.662] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:20.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:79:0) after 1m0s
[00:06:20.729] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:79:0)
[00:06:20.729] Timer tick, asking Buildbucket for the build status
[00:06:21.002] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:21.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:80:0) after 1m0s
[00:07:21.033] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:80:0)
[00:07:21.033] Timer tick, asking Buildbucket for the build status
[00:07:21.482] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:21.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:81:0) after 1m0s
[00:08:21.556] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:81:0)
[00:08:21.556] Timer tick, asking Buildbucket for the build status
[00:08:21.689] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:21.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:82:0) after 1m0s
[00:09:21.736] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:82:0)
[00:09:21.736] Timer tick, asking Buildbucket for the build status
[00:09:21.882] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:21.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:83:0) after 1m0s
[00:10:21.947] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:83:0)
[00:10:21.947] Timer tick, asking Buildbucket for the build status
[00:10:22.205] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:22.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:84:0) after 1m0s
[00:11:22.247] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:84:0)
[00:11:22.247] Timer tick, asking Buildbucket for the build status
[00:11:22.526] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:22.526] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:85:0) after 1m0s
[00:12:22.641] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:85:0)
[00:12:22.641] Timer tick, asking Buildbucket for the build status
[00:12:22.755] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:22.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:86:0) after 1m0s
[00:13:22.748] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:86:0)
[00:13:22.748] Timer tick, asking Buildbucket for the build status
[00:13:22.830] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:22.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:87:0) after 1m0s
[00:14:23.025] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:87:0)
[00:14:23.026] Timer tick, asking Buildbucket for the build status
[00:14:23.170] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:23.170] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:88:0) after 1m0s
[00:15:23.224] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:88:0)
[00:15:23.224] Timer tick, asking Buildbucket for the build status
[00:15:23.474] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:23.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:89:0) after 1m0s
[00:16:23.500] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:89:0)
[00:16:23.500] Timer tick, asking Buildbucket for the build status
[00:16:23.589] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:23.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:90:0) after 1m0s
[00:17:23.641] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:90:0)
[00:17:23.641] Timer tick, asking Buildbucket for the build status
[00:17:23.750] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:23.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:91:0) after 1m0s
[00:18:23.761] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:91:0)
[00:18:23.761] Timer tick, asking Buildbucket for the build status
[00:18:23.833] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:23.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:92:0) after 1m0s
[00:19:23.886] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:92:0)
[00:19:23.886] Timer tick, asking Buildbucket for the build status
[00:19:23.991] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:23.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:93:0) after 1m0s
[00:20:24.041] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:93:0)
[00:20:24.041] Timer tick, asking Buildbucket for the build status
[00:20:24.130] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:24.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:94:0) after 1m0s
[00:21:24.194] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:94:0)
[00:21:24.194] Timer tick, asking Buildbucket for the build status
[00:21:24.281] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:24.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:95:0) after 1m0s
[00:22:24.348] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:95:0)
[00:22:24.348] Timer tick, asking Buildbucket for the build status
[00:22:24.428] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:24.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:96:0) after 1m0s
[00:23:24.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:96:0)
[00:23:24.486] Timer tick, asking Buildbucket for the build status
[00:23:24.589] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:24.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:97:0) after 1m0s
[00:24:24.703] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:97:0)
[00:24:24.703] Timer tick, asking Buildbucket for the build status
[00:24:25.129] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:25.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:98:0) after 1m0s
[00:25:25.177] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:98:0)
[00:25:25.177] Timer tick, asking Buildbucket for the build status
[00:25:25.258] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:25.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:99:0) after 1m0s
[00:26:25.579] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:99:0)
[00:26:25.579] Timer tick, asking Buildbucket for the build status
[00:26:25.857] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:25.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:100:0) after 1m0s
[00:27:25.933] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:100:0)
[00:27:25.933] Timer tick, asking Buildbucket for the build status
[00:27:26.021] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:26.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:101:0) after 1m0s
[00:28:26.037] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:101:0)
[00:28:26.038] Timer tick, asking Buildbucket for the build status
[00:28:26.217] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:26.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:102:0) after 1m0s
[00:29:26.316] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:102:0)
[00:29:26.316] Timer tick, asking Buildbucket for the build status
[00:29:26.474] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:26.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:103:0) after 1m0s
[00:30:26.698] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:103:0)
[00:30:26.698] Timer tick, asking Buildbucket for the build status
[00:30:26.787] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:26.787] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:104:0) after 1m0s
[00:31:26.965] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:104:0)
[00:31:26.965] Timer tick, asking Buildbucket for the build status
[00:31:27.042] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:27.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:105:0) after 1m0s
[00:32:27.165] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:105:0)
[00:32:27.165] Timer tick, asking Buildbucket for the build status
[00:32:27.252] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:27.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:106:0) after 1m0s
[00:33:27.311] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:106:0)
[00:33:27.311] Timer tick, asking Buildbucket for the build status
[00:33:27.402] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:27.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:107:0) after 1m0s
[00:34:27.570] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:107:0)
[00:34:27.570] Timer tick, asking Buildbucket for the build status
[00:34:27.732] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:27.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:108:0) after 1m0s
[00:35:27.839] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:108:0)
[00:35:27.839] Timer tick, asking Buildbucket for the build status
[00:35:28.102] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:28.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:109:0) after 1m0s
[00:36:28.231] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:109:0)
[00:36:28.231] Timer tick, asking Buildbucket for the build status
[00:36:28.291] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:28.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:110:0) after 1m0s
[00:37:28.430] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:110:0)
[00:37:28.430] Timer tick, asking Buildbucket for the build status
[00:37:28.507] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:28.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:111:0) after 1m0s
[00:38:28.607] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:111:0)
[00:38:28.607] Timer tick, asking Buildbucket for the build status
[00:38:28.694] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:28.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:112:0) after 1m0s
[00:39:28.725] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:112:0)
[00:39:28.725] Timer tick, asking Buildbucket for the build status
[00:39:28.995] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:28.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:113:0) after 1m0s
[00:40:29.043] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:113:0)
[00:40:29.043] Timer tick, asking Buildbucket for the build status
[00:40:29.141] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:29.141] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:114:0) after 1m0s
[00:41:29.284] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:114:0)
[00:41:29.284] Timer tick, asking Buildbucket for the build status
[00:41:29.410] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:29.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:115:0) after 1m0s
[00:42:29.422] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:115:0)
[00:42:29.422] Timer tick, asking Buildbucket for the build status
[00:42:29.474] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:29.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:116:0) after 1m0s
[00:43:29.533] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:116:0)
[00:43:29.533] Timer tick, asking Buildbucket for the build status
[00:43:29.599] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:29.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:117:0) after 1m0s
[00:44:29.593] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:117:0)
[00:44:29.593] Timer tick, asking Buildbucket for the build status
[00:44:29.707] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:29.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:118:0) after 1m0s
[00:45:29.801] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:118:0)
[00:45:29.801] Timer tick, asking Buildbucket for the build status
[00:45:29.879] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:29.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:119:0) after 1m0s
[00:46:29.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:119:0)
[00:46:29.929] Timer tick, asking Buildbucket for the build status
[00:46:30.336] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:30.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:120:0) after 1m0s
[00:47:30.375] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:120:0)
[00:47:30.375] Timer tick, asking Buildbucket for the build status
[00:47:30.438] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:30.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:121:0) after 1m0s
[00:48:30.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:121:0)
[00:48:30.517] Timer tick, asking Buildbucket for the build status
[00:48:30.724] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:30.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:122:0) after 1m0s
[00:49:30.754] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:122:0)
[00:49:30.754] Timer tick, asking Buildbucket for the build status
[00:49:30.878] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:30.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:123:0) after 1m0s
[00:50:30.927] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:123:0)
[00:50:30.927] Timer tick, asking Buildbucket for the build status
[00:50:30.996] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:30.996] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:124:0) after 1m0s
[00:51:31.028] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:124:0)
[00:51:31.028] Timer tick, asking Buildbucket for the build status
[00:51:31.105] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:31.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:125:0) after 1m0s
[00:52:31.161] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:125:0)
[00:52:31.161] Timer tick, asking Buildbucket for the build status
[00:52:31.247] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:31.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:126:0) after 1m0s
[00:53:31.396] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:126:0)
[00:53:31.396] Timer tick, asking Buildbucket for the build status
[00:53:31.482] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:31.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:127:0) after 1m0s
[00:54:31.510] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:127:0)
[00:54:31.510] Timer tick, asking Buildbucket for the build status
[00:54:31.701] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:31.701] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:128:0) after 1m0s
[00:55:31.732] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:128:0)
[00:55:31.732] Timer tick, asking Buildbucket for the build status
[00:55:31.813] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:31.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:129:0) after 1m0s
[00:56:31.898] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:129:0)
[00:56:31.898] Timer tick, asking Buildbucket for the build status
[00:56:31.967] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:31.967] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:130:0) after 1m0s
[00:57:32.047] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:130:0)
[00:57:32.047] Timer tick, asking Buildbucket for the build status
[00:57:32.202] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:32.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:131:0) after 1m0s
[00:58:32.408] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:131:0)
[00:58:32.408] Timer tick, asking Buildbucket for the build status
[00:58:32.490] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:32.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:132:0) after 1m0s
[00:59:32.688] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:132:0)
[00:59:32.688] Timer tick, asking Buildbucket for the build status
[00:59:32.844] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:32.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:133:0) after 1m0s
[01:00:32.943] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:133:0)
[01:00:32.944] Timer tick, asking Buildbucket for the build status
[01:00:33.323] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:33.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:134:0) after 1m0s
[01:01:33.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:134:0)
[01:01:33.738] Timer tick, asking Buildbucket for the build status
[01:01:33.886] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:33.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:135:0) after 1m0s
[01:02:34.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:135:0)
[01:02:34.186] Timer tick, asking Buildbucket for the build status
[01:02:34.528] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:34.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:136:0) after 1m0s
[01:03:34.599] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:136:0)
[01:03:34.599] Timer tick, asking Buildbucket for the build status
[01:03:34.816] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:34.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:137:0) after 1m0s
[01:04:35.048] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:137:0)
[01:04:35.048] Timer tick, asking Buildbucket for the build status
[01:04:35.492] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:35.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:138:0) after 1m0s
[01:05:35.617] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:138:0)
[01:05:35.617] Timer tick, asking Buildbucket for the build status
[01:05:35.815] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:35.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:139:0) after 1m0s
[01:06:35.915] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:139:0)
[01:06:35.915] Timer tick, asking Buildbucket for the build status
[01:06:36.183] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:36.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:140:0) after 1m0s
[01:07:36.268] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:140:0)
[01:07:36.268] Timer tick, asking Buildbucket for the build status
[01:07:36.588] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:36.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:141:0) after 1m0s
[01:08:36.696] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:141:0)
[01:08:36.696] Timer tick, asking Buildbucket for the build status
[01:08:36.917] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:36.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:142:0) after 1m0s
[01:09:37.001] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:142:0)
[01:09:37.001] Timer tick, asking Buildbucket for the build status
[01:09:37.476] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:37.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:143:0) after 1m0s
[01:10:37.582] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:143:0)
[01:10:37.582] Timer tick, asking Buildbucket for the build status
[01:10:37.648] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:37.648] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:144:0) after 1m0s
[01:11:37.792] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:144:0)
[01:11:37.792] Timer tick, asking Buildbucket for the build status
[01:11:37.872] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:37.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:145:0) after 1m0s
[01:12:37.921] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:145:0)
[01:12:37.921] Timer tick, asking Buildbucket for the build status
[01:12:37.984] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:37.984] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:146:0) after 1m0s
[01:13:38.075] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:146:0)
[01:13:38.075] Timer tick, asking Buildbucket for the build status
[01:13:38.144] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:38.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:147:0) after 1m0s
[01:14:38.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:147:0)
[01:14:38.290] Timer tick, asking Buildbucket for the build status
[01:14:38.639] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:38.639] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:148:0) after 1m0s
[01:15:38.717] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:148:0)
[01:15:38.717] Timer tick, asking Buildbucket for the build status
[01:15:38.939] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:38.939] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:149:0) after 1m0s
[01:16:38.984] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:149:0)
[01:16:38.984] Timer tick, asking Buildbucket for the build status
[01:16:39.165] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:39.165] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:150:0) after 1m0s
[01:17:39.236] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:150:0)
[01:17:39.236] Timer tick, asking Buildbucket for the build status
[01:17:39.443] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:39.443] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:151:0) after 1m0s
[01:18:39.513] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:151:0)
[01:18:39.513] Timer tick, asking Buildbucket for the build status
[01:18:39.574] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:39.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:152:0) after 1m0s
[01:19:39.659] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:152:0)
[01:19:39.659] Timer tick, asking Buildbucket for the build status
[01:19:40.131] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:40.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:153:0) after 1m0s
[01:20:40.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:153:0)
[01:20:40.186] Timer tick, asking Buildbucket for the build status
[01:20:40.386] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:40.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:154:0) after 1m0s
[01:21:40.433] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:154:0)
[01:21:40.433] Timer tick, asking Buildbucket for the build status
[01:21:40.533] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:40.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:155:0) after 1m0s
[01:22:40.657] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:155:0)
[01:22:40.657] Timer tick, asking Buildbucket for the build status
[01:22:40.746] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:40.746] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:156:0) after 1m0s
[01:23:40.883] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:156:0)
[01:23:40.883] Timer tick, asking Buildbucket for the build status
[01:23:40.964] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:40.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:157:0) after 1m0s
[01:24:41.007] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:157:0)
[01:24:41.007] Timer tick, asking Buildbucket for the build status
[01:24:41.137] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:41.137] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:158:0) after 1m0s
[01:25:41.248] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:158:0)
[01:25:41.248] Timer tick, asking Buildbucket for the build status
[01:25:41.318] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:41.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:159:0) after 1m0s
[01:26:41.379] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:159:0)
[01:26:41.379] Timer tick, asking Buildbucket for the build status
[01:26:41.769] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:41.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:160:0) after 1m0s
[01:27:41.801] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:160:0)
[01:27:41.801] Timer tick, asking Buildbucket for the build status
[01:27:41.898] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:41.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:161:0) after 1m0s
[01:28:41.949] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:161:0)
[01:28:41.949] Timer tick, asking Buildbucket for the build status
[01:28:42.085] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:42.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:162:0) after 1m0s
[01:29:42.148] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:162:0)
[01:29:42.148] Timer tick, asking Buildbucket for the build status
[01:29:42.251] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:42.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:163:0) after 1m0s
[01:30:42.346] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:163:0)
[01:30:42.346] Timer tick, asking Buildbucket for the build status
[01:30:42.524] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:42.524] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:164:0) after 1m0s
[01:31:42.555] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:164:0)
[01:31:42.555] Timer tick, asking Buildbucket for the build status
[01:31:42.921] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:42.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:165:0) after 1m0s
[01:32:43.001] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:165:0)
[01:32:43.001] Timer tick, asking Buildbucket for the build status
[01:32:43.124] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:43.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:166:0) after 1m0s
[01:33:43.203] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:166:0)
[01:33:43.203] Timer tick, asking Buildbucket for the build status
[01:33:43.595] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:43.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:167:0) after 1m0s
[01:34:43.682] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:167:0)
[01:34:43.682] Timer tick, asking Buildbucket for the build status
[01:34:44.199] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:44.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:168:0) after 1m0s
[01:35:44.200] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:168:0)
[01:35:44.200] Timer tick, asking Buildbucket for the build status
[01:35:44.537] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:44.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:169:0) after 1m0s
[01:36:44.578] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:169:0)
[01:36:44.578] Timer tick, asking Buildbucket for the build status
[01:36:45.121] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:45.121] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:170:0) after 1m0s
[01:37:45.349] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:170:0)
[01:37:45.350] Timer tick, asking Buildbucket for the build status
[01:37:45.421] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:45.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:171:0) after 1m0s
[01:38:45.485] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:171:0)
[01:38:45.485] Timer tick, asking Buildbucket for the build status
[01:38:45.708] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:45.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:172:0) after 1m0s
[01:39:45.772] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:172:0)
[01:39:45.772] Timer tick, asking Buildbucket for the build status
[01:39:45.899] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:45.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:173:0) after 1m0s
[01:40:46.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:173:0)
[01:40:46.008] Timer tick, asking Buildbucket for the build status
[01:40:46.107] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:46.107] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:174:0) after 1m0s
[01:41:46.259] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:174:0)
[01:41:46.259] Timer tick, asking Buildbucket for the build status
[01:41:46.340] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:46.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:175:0) after 1m0s
[01:42:46.541] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:175:0)
[01:42:46.541] Timer tick, asking Buildbucket for the build status
[01:42:46.638] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:46.638] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:176:0) after 1m0s
[01:43:46.733] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:176:0)
[01:43:46.733] Timer tick, asking Buildbucket for the build status
[01:43:46.824] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:46.824] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:177:0) after 1m0s
[01:44:46.974] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:177:0)
[01:44:46.974] Timer tick, asking Buildbucket for the build status
[01:44:47.098] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:47.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:178:0) after 1m0s
[01:45:47.230] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:178:0)
[01:45:47.230] Timer tick, asking Buildbucket for the build status
[01:45:47.323] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:47.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:179:0) after 1m0s
[01:46:47.369] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:179:0)
[01:46:47.369] Timer tick, asking Buildbucket for the build status
[01:46:47.563] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:47.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:180:0) after 1m0s
[01:47:47.622] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:180:0)
[01:47:47.622] Timer tick, asking Buildbucket for the build status
[01:47:47.694] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:47.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:181:0) after 1m0s
[01:48:47.744] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:181:0)
[01:48:47.744] Timer tick, asking Buildbucket for the build status
[01:48:48.233] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:48.233] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:182:0) after 1m0s
[01:49:48.348] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:182:0)
[01:49:48.348] Timer tick, asking Buildbucket for the build status
[01:49:48.472] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:48.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:183:0) after 1m0s
[01:50:48.594] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:183:0)
[01:50:48.594] Timer tick, asking Buildbucket for the build status
[01:50:50.515] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:50.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:184:0) after 1m0s
[01:51:50.666] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:184:0)
[01:51:50.666] Timer tick, asking Buildbucket for the build status
[01:51:50.984] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:50.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:185:0) after 1m0s
[01:52:51.092] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:185:0)
[01:52:51.092] Timer tick, asking Buildbucket for the build status
[01:52:51.204] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:51.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:186:0) after 1m0s
[01:53:51.298] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:186:0)
[01:53:51.298] Timer tick, asking Buildbucket for the build status
[01:53:52.306] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:52.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:187:0) after 1m0s
[01:54:52.414] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:187:0)
[01:54:52.414] Timer tick, asking Buildbucket for the build status
[01:54:52.578] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:52.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:188:0) after 1m0s
[01:55:52.646] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:188:0)
[01:55:52.646] Timer tick, asking Buildbucket for the build status
[01:55:52.826] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:52.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:189:0) after 1m0s
[01:56:52.874] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:189:0)
[01:56:52.875] Timer tick, asking Buildbucket for the build status
[01:56:52.950] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:52.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:190:0) after 1m0s
[01:57:52.981] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:190:0)
[01:57:52.981] Timer tick, asking Buildbucket for the build status
[01:57:53.289] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:53.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:191:0) after 1m0s
[01:58:53.426] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:191:0)
[01:58:53.426] Timer tick, asking Buildbucket for the build status
[01:58:53.587] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:53.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:192:0) after 1m0s
[01:59:53.714] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:192:0)
[01:59:53.714] Timer tick, asking Buildbucket for the build status
[01:59:53.830] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:53.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:193:0) after 1m0s
[02:00:54.249] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:193:0)
[02:00:54.249] Timer tick, asking Buildbucket for the build status
[02:00:54.331] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:54.331] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:194:0) after 1m0s
[02:01:54.379] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:194:0)
[02:01:54.379] Timer tick, asking Buildbucket for the build status
[02:01:54.451] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:54.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:195:0) after 1m0s
[02:02:54.456] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:195:0)
[02:02:54.456] Timer tick, asking Buildbucket for the build status
[02:02:54.511] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:54.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:196:0) after 1m0s
[02:03:54.530] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:196:0)
[02:03:54.530] Timer tick, asking Buildbucket for the build status
[02:03:54.633] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:54.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:197:0) after 1m0s
[02:04:54.661] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:197:0)
[02:04:54.661] Timer tick, asking Buildbucket for the build status
[02:04:54.832] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:54.832] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:198:0) after 1m0s
[02:05:54.856] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:198:0)
[02:05:54.856] Timer tick, asking Buildbucket for the build status
[02:05:55.238] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:55.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:199:0) after 1m0s
[02:06:55.284] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:199:0)
[02:06:55.284] Timer tick, asking Buildbucket for the build status
[02:06:55.342] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:55.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:200:0) after 1m0s
[02:07:55.362] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:200:0)
[02:07:55.362] Timer tick, asking Buildbucket for the build status
[02:07:55.440] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:55.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:201:0) after 1m0s
[02:08:55.434] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:201:0)
[02:08:55.434] Timer tick, asking Buildbucket for the build status
[02:08:55.771] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:55.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:202:0) after 1m0s
[02:09:55.849] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:202:0)
[02:09:55.849] Timer tick, asking Buildbucket for the build status
[02:09:55.952] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:55.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:203:0) after 1m0s
[02:10:56.310] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:203:0)
[02:10:56.310] Timer tick, asking Buildbucket for the build status
[02:10:56.414] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:56.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:204:0) after 1m0s
[02:11:56.428] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:204:0)
[02:11:56.428] Timer tick, asking Buildbucket for the build status
[02:11:56.570] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:56.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:205:0) after 1m0s
[02:12:56.699] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:205:0)
[02:12:56.699] Timer tick, asking Buildbucket for the build status
[02:12:57.114] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:57.114] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:206:0) after 1m0s
[02:13:57.190] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:206:0)
[02:13:57.190] Timer tick, asking Buildbucket for the build status
[02:13:57.291] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:57.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:207:0) after 1m0s
[02:14:57.599] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:207:0)
[02:14:57.599] Timer tick, asking Buildbucket for the build status
[02:14:57.748] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:57.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:208:0) after 1m0s
[02:15:57.798] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:208:0)
[02:15:57.798] Timer tick, asking Buildbucket for the build status
[02:15:58.336] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:58.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:209:0) after 1m0s
[02:16:58.490] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:209:0)
[02:16:58.490] Timer tick, asking Buildbucket for the build status
[02:16:58.790] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:58.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:210:0) after 1m0s
[02:17:58.877] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:210:0)
[02:17:58.877] Timer tick, asking Buildbucket for the build status
[02:17:58.962] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:58.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:211:0) after 1m0s
[02:18:59.071] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:211:0)
[02:18:59.071] Timer tick, asking Buildbucket for the build status
[02:18:59.233] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:59.233] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:212:0) after 1m0s
[02:19:59.384] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:212:0)
[02:19:59.384] Timer tick, asking Buildbucket for the build status
[02:19:59.555] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:59.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:213:0) after 1m0s
[02:20:59.619] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:213:0)
[02:20:59.619] Timer tick, asking Buildbucket for the build status
[02:20:59.795] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:59.795] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:214:0) after 1m0s
[02:22:02.302] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:214:0)
[02:22:02.302] Timer tick, asking Buildbucket for the build status
[02:22:02.496] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:02.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:215:0) after 1m0s
[02:23:03.645] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:215:0)
[02:23:03.645] Timer tick, asking Buildbucket for the build status
[02:23:03.716] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:03.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:216:0) after 1m0s
[02:24:03.889] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:216:0)
[02:24:03.889] Timer tick, asking Buildbucket for the build status
[02:24:03.976] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:03.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:217:0) after 1m0s
[02:25:04.397] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:217:0)
[02:25:04.397] Timer tick, asking Buildbucket for the build status
[02:25:04.677] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:04.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:218:0) after 1m0s
[02:26:05.005] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:218:0)
[02:26:05.005] Timer tick, asking Buildbucket for the build status
[02:26:05.482] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:05.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:219:0) after 1m0s
[02:27:05.887] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:219:0)
[02:27:05.887] Timer tick, asking Buildbucket for the build status
[02:27:07.729] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:07.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:220:0) after 1m0s
[02:28:07.870] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:220:0)
[02:28:07.870] Timer tick, asking Buildbucket for the build status
[02:28:08.098] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:08.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:221:0) after 1m0s
[02:29:08.150] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:221:0)
[02:29:08.150] Timer tick, asking Buildbucket for the build status
[02:29:08.260] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:08.260] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:222:0) after 1m0s
[02:30:08.254] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:222:0)
[02:30:08.254] Timer tick, asking Buildbucket for the build status
[02:30:08.483] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:08.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:223:0) after 1m0s
[02:31:08.525] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:223:0)
[02:31:08.525] Timer tick, asking Buildbucket for the build status
[02:31:08.662] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:08.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:224:0) after 1m0s
[02:32:08.744] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:224:0)
[02:32:08.744] Timer tick, asking Buildbucket for the build status
[02:32:08.814] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:08.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:225:0) after 1m0s
[02:33:08.906] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:225:0)
[02:33:08.906] Timer tick, asking Buildbucket for the build status
[02:33:09.063] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:09.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:226:0) after 1m0s
[02:34:09.095] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:226:0)
[02:34:09.095] Timer tick, asking Buildbucket for the build status
[02:34:09.246] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:09.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:227:0) after 1m0s
[02:35:09.285] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:227:0)
[02:35:09.285] Timer tick, asking Buildbucket for the build status
[02:35:09.501] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:09.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:228:0) after 1m0s
[02:36:09.586] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:228:0)
[02:36:09.586] Timer tick, asking Buildbucket for the build status
[02:36:09.985] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:09.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:229:0) after 1m0s
[02:37:10.068] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:229:0)
[02:37:10.068] Timer tick, asking Buildbucket for the build status
[02:37:10.212] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:10.212] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:230:0) after 1m0s
[02:38:10.275] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:230:0)
[02:38:10.275] Timer tick, asking Buildbucket for the build status
[02:38:10.525] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:10.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:231:0) after 1m0s
[02:39:10.603] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:231:0)
[02:39:10.603] Timer tick, asking Buildbucket for the build status
[02:39:10.748] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:10.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:232:0) after 1m0s
[02:40:10.943] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:232:0)
[02:40:10.943] Timer tick, asking Buildbucket for the build status
[02:40:11.048] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:11.048] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:233:0) after 1m0s
[02:41:11.109] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:233:0)
[02:41:11.109] Timer tick, asking Buildbucket for the build status
[02:41:11.318] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:11.319] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:234:0) after 1m0s
[02:42:11.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:234:0)
[02:42:11.394] Timer tick, asking Buildbucket for the build status
[02:42:11.820] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:11.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:235:0) after 1m0s
[02:43:11.893] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:235:0)
[02:43:11.893] Timer tick, asking Buildbucket for the build status
[02:43:12.192] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:12.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:236:0) after 1m0s
[02:44:12.256] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:236:0)
[02:44:12.256] Timer tick, asking Buildbucket for the build status
[02:44:12.533] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:12.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:237:0) after 1m0s
[02:45:12.589] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:237:0)
[02:45:12.589] Timer tick, asking Buildbucket for the build status
[02:45:12.919] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:12.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:238:0) after 1m0s
[02:46:12.992] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:238:0)
[02:46:12.992] Timer tick, asking Buildbucket for the build status
[02:46:13.070] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:13.070] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:239:0) after 1m0s
[02:47:13.165] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:239:0)
[02:47:13.165] Timer tick, asking Buildbucket for the build status
[02:47:13.529] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:13.529] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:240:0) after 1m0s
[02:48:13.559] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:240:0)
[02:48:13.559] Timer tick, asking Buildbucket for the build status
[02:48:13.622] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:13.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:241:0) after 1m0s
[02:49:13.668] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:241:0)
[02:49:13.668] Timer tick, asking Buildbucket for the build status
[02:49:13.979] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:13.979] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:242:0) after 1m0s
[02:50:14.108] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:242:0)
[02:50:14.108] Timer tick, asking Buildbucket for the build status
[02:50:14.220] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:14.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:243:0) after 1m0s
[02:51:14.223] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:243:0)
[02:51:14.223] Timer tick, asking Buildbucket for the build status
[02:51:14.294] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:14.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:244:0) after 1m0s
[02:52:14.363] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:244:0)
[02:52:14.363] Timer tick, asking Buildbucket for the build status
[02:52:14.465] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:14.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:245:0) after 1m0s
[02:53:14.446] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:245:0)
[02:53:14.446] Timer tick, asking Buildbucket for the build status
[02:53:14.667] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:14.667] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:246:0) after 1m0s
[02:54:14.754] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:246:0)
[02:54:14.754] Timer tick, asking Buildbucket for the build status
[02:54:15.101] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:15.101] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:247:0) after 1m0s
[02:55:15.233] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:247:0)
[02:55:15.233] Timer tick, asking Buildbucket for the build status
[02:55:15.391] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:15.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:248:0) after 1m0s
[02:56:15.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:248:0)
[02:56:15.486] Timer tick, asking Buildbucket for the build status
[02:56:15.573] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:15.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:249:0) after 1m0s
[02:57:16.387] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:249:0)
[02:57:16.387] Timer tick, asking Buildbucket for the build status
[02:57:16.815] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:16.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:250:0) after 1m0s
[02:58:16.855] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:250:0)
[02:58:16.855] Timer tick, asking Buildbucket for the build status
[02:58:16.938] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:16.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:251:0) after 1m0s
[02:59:17.183] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:251:0)
[02:59:17.183] Timer tick, asking Buildbucket for the build status
[02:59:17.515] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:17.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:252:0) after 1m0s
[03:00:17.591] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:252:0)
[03:00:17.591] Timer tick, asking Buildbucket for the build status
[03:00:17.656] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:17.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:253:0) after 1m0s
[03:01:18.075] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:253:0)
[03:01:18.085] Timer tick, asking Buildbucket for the build status
[03:01:18.201] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:18.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:254:0) after 1m0s
[03:02:18.308] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:254:0)
[03:02:18.308] Timer tick, asking Buildbucket for the build status
[03:02:18.389] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:18.389] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:255:0) after 1m0s
[03:03:18.429] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:255:0)
[03:03:18.429] Timer tick, asking Buildbucket for the build status
[03:03:18.497] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:18.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:256:0) after 1m0s
[03:04:18.531] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:256:0)
[03:04:18.531] Timer tick, asking Buildbucket for the build status
[03:04:18.979] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:18.979] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:257:0) after 1m0s
[03:05:19.009] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:257:0)
[03:05:19.009] Timer tick, asking Buildbucket for the build status
[03:05:19.638] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:19.638] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:258:0) after 1m0s
[03:06:19.744] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:258:0)
[03:06:19.744] Timer tick, asking Buildbucket for the build status
[03:06:20.032] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:20.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:259:0) after 1m0s
[03:07:20.110] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:259:0)
[03:07:20.110] Timer tick, asking Buildbucket for the build status
[03:07:20.225] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:20.225] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:260:0) after 1m0s
[03:08:20.275] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:260:0)
[03:08:20.275] Timer tick, asking Buildbucket for the build status
[03:08:20.569] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:20.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:261:0) after 1m0s
[03:09:20.732] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:261:0)
[03:09:20.733] Timer tick, asking Buildbucket for the build status
[03:09:21.175] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:21.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:262:0) after 1m0s
[03:10:21.412] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:262:0)
[03:10:21.412] Timer tick, asking Buildbucket for the build status
[03:10:21.525] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:21.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:263:0) after 1m0s
[03:11:21.574] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:263:0)
[03:11:21.574] Timer tick, asking Buildbucket for the build status
[03:11:21.647] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:21.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:264:0) after 1m0s
[03:12:21.705] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:264:0)
[03:12:21.705] Timer tick, asking Buildbucket for the build status
[03:12:21.852] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:21.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:265:0) after 1m0s
[03:13:21.992] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:265:0)
[03:13:21.992] Timer tick, asking Buildbucket for the build status
[03:13:22.064] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:22.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:266:0) after 1m0s
[03:14:22.163] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:266:0)
[03:14:22.163] Timer tick, asking Buildbucket for the build status
[03:14:22.614] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:22.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:267:0) after 1m0s
[03:15:22.737] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:267:0)
[03:15:22.737] Timer tick, asking Buildbucket for the build status
[03:15:23.376] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:23.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:268:0) after 1m0s
[03:16:23.648] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:268:0)
[03:16:23.648] Timer tick, asking Buildbucket for the build status
[03:16:23.819] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:23.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:269:0) after 1m0s
[03:17:23.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:269:0)
[03:17:23.929] Timer tick, asking Buildbucket for the build status
[03:17:24.013] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:24.013] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:270:0) after 1m0s
[03:18:24.433] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:270:0)
[03:18:24.433] Timer tick, asking Buildbucket for the build status
[03:18:24.770] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:24.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:271:0) after 1m0s
[03:19:24.892] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:271:0)
[03:19:24.892] Timer tick, asking Buildbucket for the build status
[03:19:25.012] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:25.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:272:0) after 1m0s
[03:20:25.077] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:272:0)
[03:20:25.077] Timer tick, asking Buildbucket for the build status
[03:20:25.349] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:25.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:273:0) after 1m0s
[03:21:25.445] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:273:0)
[03:21:25.445] Timer tick, asking Buildbucket for the build status
[03:21:25.545] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:25.545] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:274:0) after 1m0s
[03:22:25.704] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:274:0)
[03:22:25.705] Timer tick, asking Buildbucket for the build status
[03:22:25.784] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:25.784] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:275:0) after 1m0s
[03:23:26.731] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:275:0)
[03:23:26.731] Timer tick, asking Buildbucket for the build status
[03:23:26.796] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:26.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:276:0) after 1m0s
[03:24:26.838] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:276:0)
[03:24:26.838] Timer tick, asking Buildbucket for the build status
[03:24:27.138] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:27.138] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:277:0) after 1m0s
[03:25:27.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:277:0)
[03:25:27.251] Timer tick, asking Buildbucket for the build status
[03:25:27.356] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:27.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:278:0) after 1m0s
[03:26:27.479] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:278:0)
[03:26:27.479] Timer tick, asking Buildbucket for the build status
[03:26:27.553] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:27.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:279:0) after 1m0s
[03:27:27.921] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:279:0)
[03:27:27.922] Timer tick, asking Buildbucket for the build status
[03:27:28.012] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:28.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:280:0) after 1m0s
[03:28:28.178] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:280:0)
[03:28:28.179] Timer tick, asking Buildbucket for the build status
[03:28:28.335] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:28.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:281:0) after 1m0s
[03:29:28.548] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:281:0)
[03:29:28.548] Timer tick, asking Buildbucket for the build status
[03:29:28.669] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:28.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:282:0) after 1m0s
[03:30:29.046] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:282:0)
[03:30:29.046] Timer tick, asking Buildbucket for the build status
[03:30:29.135] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:29.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:283:0) after 1m0s
[03:31:29.370] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:283:0)
[03:31:29.370] Timer tick, asking Buildbucket for the build status
[03:31:29.442] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:29.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:284:0) after 1m0s
[03:32:29.601] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:284:0)
[03:32:29.601] Timer tick, asking Buildbucket for the build status
[03:32:29.829] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:29.829] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:285:0) after 1m0s
[03:33:30.088] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:285:0)
[03:33:30.088] Timer tick, asking Buildbucket for the build status
[03:33:30.171] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:30.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:286:0) after 1m0s
[03:34:30.431] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:286:0)
[03:34:30.431] Timer tick, asking Buildbucket for the build status
[03:34:31.093] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:31.093] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:287:0) after 1m0s
[03:35:31.243] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:287:0)
[03:35:31.243] Timer tick, asking Buildbucket for the build status
[03:35:31.563] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:31.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:288:0) after 1m0s
[03:36:31.870] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:288:0)
[03:36:31.870] Timer tick, asking Buildbucket for the build status
[03:36:31.943] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:31.943] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:289:0) after 1m0s
[03:37:32.067] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:289:0)
[03:37:32.067] Timer tick, asking Buildbucket for the build status
[03:37:32.422] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:32.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:290:0) after 1m0s
[03:38:32.554] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:290:0)
[03:38:32.554] Timer tick, asking Buildbucket for the build status
[03:38:32.838] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:32.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:291:0) after 1m0s
[03:39:32.966] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:291:0)
[03:39:32.966] Timer tick, asking Buildbucket for the build status
[03:39:33.082] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:33.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:292:0) after 1m0s
[03:40:33.259] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:292:0)
[03:40:33.259] Timer tick, asking Buildbucket for the build status
[03:40:33.328] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:33.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:293:0) after 1m0s
[03:41:33.434] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:293:0)
[03:41:33.434] Timer tick, asking Buildbucket for the build status
[03:41:33.562] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:33.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:294:0) after 1m0s
[03:42:33.699] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:294:0)
[03:42:33.699] Timer tick, asking Buildbucket for the build status
[03:42:33.891] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:33.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:295:0) after 1m0s
[03:43:33.997] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:295:0)
[03:43:33.997] Timer tick, asking Buildbucket for the build status
[03:43:34.312] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:34.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:296:0) after 1m0s
[03:44:34.350] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:296:0)
[03:44:34.350] Timer tick, asking Buildbucket for the build status
[03:44:34.492] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:34.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:297:0) after 1m0s
[03:45:34.533] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:297:0)
[03:45:34.533] Timer tick, asking Buildbucket for the build status
[03:45:34.686] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:34.686] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:298:0) after 1m0s
[03:46:34.768] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:298:0)
[03:46:34.768] Timer tick, asking Buildbucket for the build status
[03:46:34.847] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:34.847] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:299:0) after 1m0s
[03:47:34.949] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:299:0)
[03:47:34.949] Timer tick, asking Buildbucket for the build status
[03:47:35.495] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:35.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:300:0) after 1m0s
[03:48:35.570] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:300:0)
[03:48:35.570] Timer tick, asking Buildbucket for the build status
[03:48:35.904] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:35.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:301:0) after 1m0s
[03:49:36.069] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:301:0)
[03:49:36.069] Timer tick, asking Buildbucket for the build status
[03:49:36.497] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:36.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:302:0) after 1m0s
[03:50:37.087] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:302:0)
[03:50:37.087] Timer tick, asking Buildbucket for the build status
[03:50:37.319] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:37.333] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:303:0) after 1m0s
[03:51:37.443] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:303:0)
[03:51:37.443] Timer tick, asking Buildbucket for the build status
[03:51:37.530] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:37.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:304:0) after 1m0s
[03:52:37.541] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:304:0)
[03:52:37.541] Timer tick, asking Buildbucket for the build status
[03:52:37.961] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:37.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:305:0) after 1m0s
[03:53:38.097] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:305:0)
[03:53:38.097] Timer tick, asking Buildbucket for the build status
[03:53:38.182] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:38.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:306:0) after 1m0s
[03:54:38.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:306:0)
[03:54:38.272] Timer tick, asking Buildbucket for the build status
[03:54:38.589] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:38.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:307:0) after 1m0s
[03:55:38.895] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:307:0)
[03:55:38.895] Timer tick, asking Buildbucket for the build status
[03:55:38.995] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:38.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:308:0) after 1m0s
[03:56:39.044] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:308:0)
[03:56:39.044] Timer tick, asking Buildbucket for the build status
[03:56:39.105] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:39.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:309:0) after 1m0s
[03:57:39.095] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:309:0)
[03:57:39.095] Timer tick, asking Buildbucket for the build status
[03:57:39.325] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:39.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:310:0) after 1m0s
[03:58:39.349] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:310:0)
[03:58:39.349] Timer tick, asking Buildbucket for the build status
[03:58:39.430] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:39.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:311:0) after 1m0s
[03:59:39.478] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:311:0)
[03:59:39.478] Timer tick, asking Buildbucket for the build status
[03:59:39.646] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:39.646] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:312:0) after 1m0s
[04:00:39.666] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:312:0)
[04:00:39.666] Timer tick, asking Buildbucket for the build status
[04:00:40.129] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:40.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:313:0) after 1m0s
[04:01:40.240] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:313:0)
[04:01:40.240] Timer tick, asking Buildbucket for the build status
[04:01:40.509] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:40.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:314:0) after 1m0s
[04:02:40.594] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:314:0)
[04:02:40.594] Timer tick, asking Buildbucket for the build status
[04:02:40.917] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:40.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:315:0) after 1m0s
[04:03:41.022] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:315:0)
[04:03:41.022] Timer tick, asking Buildbucket for the build status
[04:03:41.096] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:41.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:316:0) after 1m0s
[04:04:41.137] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:316:0)
[04:04:41.137] Timer tick, asking Buildbucket for the build status
[04:04:41.498] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:41.498] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:317:0) after 1m0s
[04:05:41.671] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:317:0)
[04:05:41.671] Timer tick, asking Buildbucket for the build status
[04:05:41.756] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:41.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:318:0) after 1m0s
[04:06:41.830] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:318:0)
[04:06:41.830] Timer tick, asking Buildbucket for the build status
[04:06:41.898] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:41.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:319:0) after 1m0s
[04:07:42.022] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:319:0)
[04:07:42.022] Timer tick, asking Buildbucket for the build status
[04:07:42.394] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:42.395] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:320:0) after 1m0s
[04:08:43.053] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:320:0)
[04:08:43.053] Timer tick, asking Buildbucket for the build status
[04:08:43.238] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:43.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:321:0) after 1m0s
[04:09:43.307] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:321:0)
[04:09:43.307] Timer tick, asking Buildbucket for the build status
[04:09:43.523] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:43.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:322:0) after 1m0s
[04:10:43.624] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:322:0)
[04:10:43.624] Timer tick, asking Buildbucket for the build status
[04:10:43.712] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:43.712] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:323:0) after 1m0s
[04:11:43.748] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:323:0)
[04:11:43.748] Timer tick, asking Buildbucket for the build status
[04:11:46.530] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:46.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:324:0) after 1m0s
[04:12:46.614] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:324:0)
[04:12:46.614] Timer tick, asking Buildbucket for the build status
[04:12:46.685] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:46.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:325:0) after 1m0s
[04:13:46.778] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:325:0)
[04:13:46.778] Timer tick, asking Buildbucket for the build status
[04:13:46.848] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:46.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:326:0) after 1m0s
[04:14:46.947] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:326:0)
[04:14:46.947] Timer tick, asking Buildbucket for the build status
[04:14:47.495] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:47.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:327:0) after 1m0s
[04:15:47.624] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:327:0)
[04:15:47.624] Timer tick, asking Buildbucket for the build status
[04:15:47.945] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:47.945] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:328:0) after 1m0s
[04:16:47.959] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:328:0)
[04:16:47.959] Timer tick, asking Buildbucket for the build status
[04:16:48.049] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:48.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:329:0) after 1m0s
[04:17:48.091] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:329:0)
[04:17:48.091] Timer tick, asking Buildbucket for the build status
[04:17:48.401] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:48.401] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:330:0) after 1m0s
[04:18:48.435] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:330:0)
[04:18:48.435] Timer tick, asking Buildbucket for the build status
[04:18:48.669] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:48.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:331:0) after 1m0s
[04:19:48.743] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:331:0)
[04:19:48.743] Timer tick, asking Buildbucket for the build status
[04:19:48.987] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:48.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:332:0) after 1m0s
[04:20:49.095] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:332:0)
[04:20:49.095] Timer tick, asking Buildbucket for the build status
[04:20:49.369] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:49.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:333:0) after 1m0s
[04:21:49.393] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:333:0)
[04:21:49.393] Timer tick, asking Buildbucket for the build status
[04:21:49.864] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:49.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:334:0) after 1m0s
[04:22:50.211] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:334:0)
[04:22:50.211] Timer tick, asking Buildbucket for the build status
[04:22:50.328] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:50.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:335:0) after 1m0s
[04:23:50.363] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:335:0)
[04:23:50.363] Timer tick, asking Buildbucket for the build status
[04:23:50.464] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:50.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:336:0) after 1m0s
[04:24:51.349] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:336:0)
[04:24:51.349] Timer tick, asking Buildbucket for the build status
[04:24:51.549] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:51.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:337:0) after 1m0s
[04:25:51.593] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:337:0)
[04:25:51.593] Timer tick, asking Buildbucket for the build status
[04:25:51.689] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:51.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:338:0) after 1m0s
[04:26:51.782] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:338:0)
[04:26:51.782] Timer tick, asking Buildbucket for the build status
[04:26:51.848] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:51.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:339:0) after 1m0s
[04:27:51.882] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:339:0)
[04:27:51.882] Timer tick, asking Buildbucket for the build status
[04:27:52.206] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:52.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:340:0) after 1m0s
[04:28:52.348] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:340:0)
[04:28:52.348] Timer tick, asking Buildbucket for the build status
[04:28:52.432] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:52.432] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:341:0) after 1m0s
[04:29:52.498] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:341:0)
[04:29:52.498] Timer tick, asking Buildbucket for the build status
[04:29:52.635] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:52.635] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:342:0) after 1m0s
[04:30:52.647] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:342:0)
[04:30:52.647] Timer tick, asking Buildbucket for the build status
[04:30:52.720] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:52.720] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:343:0) after 1m0s
[04:31:52.775] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:343:0)
[04:31:52.775] Timer tick, asking Buildbucket for the build status
[04:31:53.004] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:53.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:344:0) after 1m0s
[04:32:53.091] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:344:0)
[04:32:53.091] Timer tick, asking Buildbucket for the build status
[04:32:53.187] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:53.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:345:0) after 1m0s
[04:33:53.231] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:345:0)
[04:33:53.231] Timer tick, asking Buildbucket for the build status
[04:33:53.405] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:53.405] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:346:0) after 1m0s
[04:34:53.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:346:0)
[04:34:53.517] Timer tick, asking Buildbucket for the build status
[04:34:53.740] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:53.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:347:0) after 1m0s
[04:35:53.811] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:347:0)
[04:35:53.811] Timer tick, asking Buildbucket for the build status
[04:35:54.185] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:54.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:348:0) after 1m0s
[04:36:54.209] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:348:0)
[04:36:54.209] Timer tick, asking Buildbucket for the build status
[04:36:54.293] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:54.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:349:0) after 1m0s
[04:37:54.382] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:349:0)
[04:37:54.382] Timer tick, asking Buildbucket for the build status
[04:37:54.458] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:54.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:350:0) after 1m0s
[04:38:54.821] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:350:0)
[04:38:54.821] Timer tick, asking Buildbucket for the build status
[04:38:55.357] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:55.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:351:0) after 1m0s
[04:39:55.461] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:351:0)
[04:39:55.461] Timer tick, asking Buildbucket for the build status
[04:39:55.621] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:55.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:352:0) after 1m0s
[04:40:55.657] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:352:0)
[04:40:55.657] Timer tick, asking Buildbucket for the build status
[04:40:55.722] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:55.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:353:0) after 1m0s
[04:41:55.784] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:353:0)
[04:41:55.784] Timer tick, asking Buildbucket for the build status
[04:41:56.084] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:56.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:354:0) after 1m0s
[04:42:56.754] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:354:0)
[04:42:56.754] Timer tick, asking Buildbucket for the build status
[04:42:57.008] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:57.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:355:0) after 1m0s
[04:43:57.052] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:355:0)
[04:43:57.052] Timer tick, asking Buildbucket for the build status
[04:43:57.131] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:57.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:356:0) after 1m0s
[04:44:57.196] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:356:0)
[04:44:57.196] Timer tick, asking Buildbucket for the build status
[04:44:57.371] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:57.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:357:0) after 1m0s
[04:45:57.400] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:357:0)
[04:45:57.400] Timer tick, asking Buildbucket for the build status
[04:45:57.479] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:57.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:358:0) after 1m0s
[04:46:57.553] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:358:0)
[04:46:57.553] Timer tick, asking Buildbucket for the build status
[04:46:57.633] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:57.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:359:0) after 1m0s
[04:47:57.708] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:359:0)
[04:47:57.708] Timer tick, asking Buildbucket for the build status
[04:47:57.805] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:57.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:360:0) after 1m0s
[04:48:57.809] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:360:0)
[04:48:57.809] Timer tick, asking Buildbucket for the build status
[04:48:57.872] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:57.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:361:0) after 1m0s
[04:49:57.972] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:361:0)
[04:49:57.972] Timer tick, asking Buildbucket for the build status
[04:49:58.095] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:58.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:362:0) after 1m0s
[04:50:58.197] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:362:0)
[04:50:58.197] Timer tick, asking Buildbucket for the build status
[04:50:58.267] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:58.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:363:0) after 1m0s
[04:51:58.293] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:363:0)
[04:51:58.293] Timer tick, asking Buildbucket for the build status
[04:51:58.776] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:58.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:364:0) after 1m0s
[04:52:58.830] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:364:0)
[04:52:58.830] Timer tick, asking Buildbucket for the build status
[04:52:58.931] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:58.931] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:365:0) after 1m0s
[04:53:59.024] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:365:0)
[04:53:59.024] Timer tick, asking Buildbucket for the build status
[04:53:59.087] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:59.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:366:0) after 1m0s
[04:54:59.121] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:366:0)
[04:54:59.121] Timer tick, asking Buildbucket for the build status
[04:54:59.624] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:59.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:367:0) after 1m0s
[04:55:59.739] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:367:0)
[04:55:59.739] Timer tick, asking Buildbucket for the build status
[04:55:59.832] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:59.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:368:0) after 1m0s
[04:56:59.906] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:368:0)
[04:56:59.906] Timer tick, asking Buildbucket for the build status
[04:56:59.984] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:59.984] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:369:0) after 1m0s
[04:58:00.329] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:369:0)
[04:58:00.329] Timer tick, asking Buildbucket for the build status
[04:58:00.589] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:00.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:370:0) after 1m0s
[04:59:02.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:370:0)
[04:59:02.487] Timer tick, asking Buildbucket for the build status
[04:59:02.578] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:02.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:371:0) after 1m0s
[05:00:02.825] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:371:0)
[05:00:02.825] Timer tick, asking Buildbucket for the build status
[05:00:03.256] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:03.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:372:0) after 1m0s
[05:01:03.369] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:372:0)
[05:01:03.369] Timer tick, asking Buildbucket for the build status
[05:01:03.647] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:03.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:373:0) after 1m0s
[05:02:04.033] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:373:0)
[05:02:04.033] Timer tick, asking Buildbucket for the build status
[05:02:04.131] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:04.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:374:0) after 1m0s
[05:03:04.311] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:374:0)
[05:03:04.311] Timer tick, asking Buildbucket for the build status
[05:03:04.412] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:04.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:375:0) after 1m0s
[05:04:04.600] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:375:0)
[05:04:04.600] Timer tick, asking Buildbucket for the build status
[05:04:04.813] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:04.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:376:0) after 1m0s
[05:05:05.113] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:376:0)
[05:05:05.113] Timer tick, asking Buildbucket for the build status
[05:05:05.269] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:05.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:377:0) after 1m0s
[05:06:05.582] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:377:0)
[05:06:05.582] Timer tick, asking Buildbucket for the build status
[05:06:05.726] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:05.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:378:0) after 1m0s
[05:07:06.343] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:378:0)
[05:07:06.343] Timer tick, asking Buildbucket for the build status
[05:07:06.899] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:06.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:379:0) after 1m0s
[05:08:07.051] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:379:0)
[05:08:07.051] Timer tick, asking Buildbucket for the build status
[05:08:07.148] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:07.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:380:0) after 1m0s
[05:09:07.289] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:380:0)
[05:09:07.289] Timer tick, asking Buildbucket for the build status
[05:09:07.362] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:07.362] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:381:0) after 1m0s
[05:10:07.415] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:381:0)
[05:10:07.415] Timer tick, asking Buildbucket for the build status
[05:10:07.574] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:07.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:382:0) after 1m0s
[05:11:07.731] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:382:0)
[05:11:07.731] Timer tick, asking Buildbucket for the build status
[05:11:07.908] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:07.908] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:383:0) after 1m0s
[05:12:08.015] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:383:0)
[05:12:08.015] Timer tick, asking Buildbucket for the build status
[05:12:08.279] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:08.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:384:0) after 1m0s
[05:13:08.402] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:384:0)
[05:13:08.402] Timer tick, asking Buildbucket for the build status
[05:13:09.627] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:09.627] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:385:0) after 1m0s
[05:14:09.758] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:385:0)
[05:14:09.758] Timer tick, asking Buildbucket for the build status
[05:14:09.836] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:09.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:386:0) after 1m0s
[05:15:09.969] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:386:0)
[05:15:09.969] Timer tick, asking Buildbucket for the build status
[05:15:10.246] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:10.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:387:0) after 1m0s
[05:16:10.401] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:387:0)
[05:16:10.401] Timer tick, asking Buildbucket for the build status
[05:16:10.500] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:10.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:388:0) after 1m0s
[05:17:10.530] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:388:0)
[05:17:10.530] Timer tick, asking Buildbucket for the build status
[05:17:10.641] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:10.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:389:0) after 1m0s
[05:18:10.705] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:389:0)
[05:18:10.705] Timer tick, asking Buildbucket for the build status
[05:18:11.015] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:11.015] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:390:0) after 1m0s
[05:19:11.129] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:390:0)
[05:19:11.129] Timer tick, asking Buildbucket for the build status
[05:19:11.195] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:11.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:391:0) after 1m0s
[05:20:11.850] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:391:0)
[05:20:11.850] Timer tick, asking Buildbucket for the build status
[05:20:11.988] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:11.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:392:0) after 1m0s
[05:21:12.909] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:392:0)
[05:21:12.909] Timer tick, asking Buildbucket for the build status
[05:21:13.007] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:13.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:393:0) after 1m0s
[05:22:13.061] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:393:0)
[05:22:13.061] Timer tick, asking Buildbucket for the build status
[05:22:13.136] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:13.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:394:0) after 1m0s
[05:23:13.284] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:394:0)
[05:23:13.284] Timer tick, asking Buildbucket for the build status
[05:23:13.514] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:13.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:395:0) after 1m0s
[05:24:13.575] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:395:0)
[05:24:13.575] Timer tick, asking Buildbucket for the build status
[05:24:13.823] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:13.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:396:0) after 1m0s
[05:25:13.830] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:396:0)
[05:25:13.830] Timer tick, asking Buildbucket for the build status
[05:25:14.307] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:14.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:397:0) after 1m0s
[05:26:14.329] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:397:0)
[05:26:14.329] Timer tick, asking Buildbucket for the build status
[05:26:14.843] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:14.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:398:0) after 1m0s
[05:27:15.555] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:398:0)
[05:27:15.555] Timer tick, asking Buildbucket for the build status
[05:27:15.886] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:15.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:399:0) after 1m0s
[05:28:16.016] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:399:0)
[05:28:16.016] Timer tick, asking Buildbucket for the build status
[05:28:16.220] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:16.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:400:0) after 1m0s
[05:29:16.353] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:400:0)
[05:29:16.353] Timer tick, asking Buildbucket for the build status
[05:29:16.475] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:16.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:401:0) after 1m0s
[05:30:16.911] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:401:0)
[05:30:16.911] Timer tick, asking Buildbucket for the build status
[05:30:17.022] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:17.023] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:402:0) after 1m0s
[05:31:17.338] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:402:0)
[05:31:17.338] Timer tick, asking Buildbucket for the build status
[05:31:17.556] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:17.556] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:403:0) after 1m0s
[05:32:17.639] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:403:0)
[05:32:17.639] Timer tick, asking Buildbucket for the build status
[05:32:17.747] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:17.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:404:0) after 1m0s
[05:33:17.790] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:404:0)
[05:33:17.790] Timer tick, asking Buildbucket for the build status
[05:33:17.968] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:17.968] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:405:0) after 1m0s
[05:34:18.027] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:405:0)
[05:34:18.027] Timer tick, asking Buildbucket for the build status
[05:34:18.427] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:18.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:406:0) after 1m0s
[05:35:18.509] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:406:0)
[05:35:18.509] Timer tick, asking Buildbucket for the build status
[05:35:18.597] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:18.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:407:0) after 1m0s
[05:36:18.708] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:407:0)
[05:36:18.708] Timer tick, asking Buildbucket for the build status
[05:36:19.182] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:19.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:408:0) after 1m0s
[05:37:19.280] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:408:0)
[05:37:19.280] Timer tick, asking Buildbucket for the build status
[05:37:19.358] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:19.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:409:0) after 1m0s
[05:38:19.504] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:409:0)
[05:38:19.504] Timer tick, asking Buildbucket for the build status
[05:38:19.863] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:19.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:410:0) after 1m0s
[05:39:19.941] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:410:0)
[05:39:19.941] Timer tick, asking Buildbucket for the build status
[05:39:20.096] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:20.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:411:0) after 1m0s
[05:40:20.323] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:411:0)
[05:40:20.323] Timer tick, asking Buildbucket for the build status
[05:40:20.434] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:20.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:412:0) after 1m0s
[05:41:20.905] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:412:0)
[05:41:20.905] Timer tick, asking Buildbucket for the build status
[05:41:21.139] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:21.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:413:0) after 1m0s
[05:42:21.375] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:413:0)
[05:42:21.375] Timer tick, asking Buildbucket for the build status
[05:42:21.818] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:21.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:414:0) after 1m0s
[05:43:22.174] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:414:0)
[05:43:22.174] Timer tick, asking Buildbucket for the build status
[05:43:22.267] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:22.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:415:0) after 1m0s
[05:44:22.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:415:0)
[05:44:22.360] Timer tick, asking Buildbucket for the build status
[05:44:22.461] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:22.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:416:0) after 1m0s
[05:45:22.572] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:416:0)
[05:45:22.572] Timer tick, asking Buildbucket for the build status
[05:45:22.648] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:22.648] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:417:0) after 1m0s
[05:46:22.696] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:417:0)
[05:46:22.696] Timer tick, asking Buildbucket for the build status
[05:46:22.890] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:22.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:418:0) after 1m0s
[05:47:22.986] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:418:0)
[05:47:22.986] Timer tick, asking Buildbucket for the build status
[05:47:23.386] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:23.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:419:0) after 1m0s
[05:48:23.500] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:419:0)
[05:48:23.500] Timer tick, asking Buildbucket for the build status
[05:48:23.580] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:23.580] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:420:0) after 1m0s
[05:49:23.648] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:420:0)
[05:49:23.648] Timer tick, asking Buildbucket for the build status
[05:49:23.764] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:23.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:421:0) after 1m0s
[05:50:23.852] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:421:0)
[05:50:23.852] Timer tick, asking Buildbucket for the build status
[05:50:24.684] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:24.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:422:0) after 1m0s
[05:51:24.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:422:0)
[05:51:24.788] Timer tick, asking Buildbucket for the build status
[05:51:24.851] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:24.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:423:0) after 1m0s
[05:52:24.942] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:423:0)
[05:52:24.942] Timer tick, asking Buildbucket for the build status
[05:52:25.056] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:25.056] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:424:0) after 1m0s
[05:53:25.147] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:424:0)
[05:53:25.147] Timer tick, asking Buildbucket for the build status
[05:53:25.377] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:25.377] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:425:0) after 1m0s
[05:54:25.417] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:425:0)
[05:54:25.417] Timer tick, asking Buildbucket for the build status
[05:54:25.532] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:25.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:426:0) after 1m0s
[05:55:25.595] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:426:0)
[05:55:25.595] Timer tick, asking Buildbucket for the build status
[05:55:25.830] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:25.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:427:0) after 1m0s
[05:56:26.935] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:427:0)
[05:56:26.936] Timer tick, asking Buildbucket for the build status
[05:56:27.180] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:27.180] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:428:0) after 1m0s
[05:57:27.841] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:428:0)
[05:57:27.841] Timer tick, asking Buildbucket for the build status
[05:57:28.165] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:28.165] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:429:0) after 1m0s
[05:58:28.228] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:429:0)
[05:58:28.228] Timer tick, asking Buildbucket for the build status
[05:58:28.311] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:28.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:430:0) after 1m0s
[05:59:28.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:430:0)
[05:59:28.405] Timer tick, asking Buildbucket for the build status
[05:59:28.602] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
--- the log has been cut here ---
[09:07:39.584] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:39.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:618:0) after 1m0s
[09:08:39.614] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:618:0)
[09:08:39.614] Timer tick, asking Buildbucket for the build status
[09:08:39.695] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:39.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:619:0) after 1m0s
[09:09:39.831] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:619:0)
[09:09:39.831] Timer tick, asking Buildbucket for the build status
[09:09:40.397] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:40.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:620:0) after 1m0s
[09:10:40.437] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:620:0)
[09:10:40.437] Timer tick, asking Buildbucket for the build status
[09:10:40.514] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:40.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:621:0) after 1m0s
[09:11:40.541] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:621:0)
[09:11:40.541] Timer tick, asking Buildbucket for the build status
[09:11:40.615] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:40.615] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:622:0) after 1m0s
[09:12:40.754] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:622:0)
[09:12:40.754] Timer tick, asking Buildbucket for the build status
[09:12:41.282] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:41.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:623:0) after 1m0s
[09:13:41.388] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:623:0)
[09:13:41.388] Timer tick, asking Buildbucket for the build status
[09:13:41.471] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:41.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:624:0) after 1m0s
[09:14:41.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:624:0)
[09:14:41.544] Timer tick, asking Buildbucket for the build status
[09:14:41.883] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:41.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:625:0) after 1m0s
[09:15:41.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:625:0)
[09:15:41.960] Timer tick, asking Buildbucket for the build status
[09:15:42.062] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:42.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:626:0) after 1m0s
[09:16:42.111] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:626:0)
[09:16:42.111] Timer tick, asking Buildbucket for the build status
[09:16:42.186] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:42.186] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:627:0) after 1m0s
[09:17:42.271] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:627:0)
[09:17:42.271] Timer tick, asking Buildbucket for the build status
[09:17:42.394] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:42.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:628:0) after 1m0s
[09:18:42.632] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:628:0)
[09:18:42.632] Timer tick, asking Buildbucket for the build status
[09:18:42.704] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:42.704] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:629:0) after 1m0s
[09:19:42.838] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:629:0)
[09:19:42.838] Timer tick, asking Buildbucket for the build status
[09:19:43.297] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:43.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:630:0) after 1m0s
[09:20:43.612] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:630:0)
[09:20:43.612] Timer tick, asking Buildbucket for the build status
[09:20:43.933] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:43.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:631:0) after 1m0s
[09:21:43.966] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:631:0)
[09:21:43.966] Timer tick, asking Buildbucket for the build status
[09:21:44.129] Build 8869595364174498400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:44.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9035025426220201216:632:0) after 1m0s
[09:22:18.181] Received PubSub notification, asking Buildbucket for the build status
[09:22:18.393] Build 8869595364174498400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:22:18.393] Buildbucket build:
{
"build": {
"bucket": "luci.nacl.ci",
"canary_preference": "PROD",
"completed_ts": "1599729731975729",
"created_by": "project:nacl",
"created_ts": "1599691726478067",
"id": "8869595364174498400",
"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\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"title\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/69a0d6e8affc94187af10e0673592d1b238c6eb0\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\"}}",
"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\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"title\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/69a0d6e8affc94187af10e0673592d1b238c6eb0\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-flex-ci-xenial-12-ywh6\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-64-validator-opt\", \"buildnumber\": 150, \"got_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"mastername\": \"client.nacl\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_149fed94fc0315f63a3ac899b53d3cfedce2ab533d8d891f9abe32610aa3106a_v2\", \"builder_a00b1023121ea85e703f19c9cb4a0ba6469d60176e935a395f443f8a2c5759bb_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-flex-ci-xenial-12-ywh6\"], \"image\": [\"chrome-xenial-20090600-f98a2a06cf8\"], \"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\": [\"5513-ee65082\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599691781271508",
"status": "COMPLETED",
"status_changed_ts": "1599729736837616",
"tags": [
"build_address:luci.nacl.ci/linux-64-validator-opt/150",
"builder:linux-64-validator-opt",
"buildset:commit/git/69a0d6e8affc94187af10e0673592d1b238c6eb0",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/69a0d6e8affc94187af10e0673592d1b238c6eb0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035025426220201216",
"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/8869595364174498400/+/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:4e8de0342d73e610",
"user_agent:luci-scheduler"
],
"updated_ts": "1599729736886917",
"url": "https://ci.chromium.org/b/8869595364174498400",
"utcnow_ts": "1599729738373897"
}
}
[09:22:18.393] Invocation finished in 10h33m33.249310795s with status SUCCEEDED