[09:32:01.238] New invocation is queued and will start shortly
[09:32:02.649] Starting the invocation (attempt 1)
[09:32:02.710] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:32:02.710] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:32:02.710] Buildbucket request:
{
"bucket": "luci.nacl.ci",
"client_operation_id": "9023479140566308144",
"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\":\"cb31feffa500401c95c6c44d88b7c358236bca36\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@cb31feffa500401c95c6c44d88b7c358236bca36\",\"title\":\"cb31feffa500401c95c6c44d88b7c358236bca36\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/cb31feffa500401c95c6c44d88b7c358236bca36\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"cb31feffa500401c95c6c44d88b7c358236bca36\"}}",
"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:9023479140566308144",
"scheduler_job_id:nacl/linux-64-validator-opt",
"user_agent:luci-scheduler",
"buildset:commit/git/cb31feffa500401c95c6c44d88b7c358236bca36",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/cb31feffa500401c95c6c44d88b7c358236bca36",
"gitiles_ref:refs/heads/master"
]
}
[09:32:03.729] Buildbucket response:
{
"build": {
"bucket": "luci.nacl.ci",
"canary_preference": "PROD",
"created_by": "project:nacl",
"created_ts": "1610703122863311",
"id": "8858049078199488224",
"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\": \"cb31feffa500401c95c6c44d88b7c358236bca36\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@cb31feffa500401c95c6c44d88b7c358236bca36\", \"title\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/cb31feffa500401c95c6c44d88b7c358236bca36\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\"}}",
"project": "nacl",
"result_details_json": "{\"properties\": {}}",
"service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610703123517247",
"tags": [
"build_address:luci.nacl.ci/linux-64-validator-opt/158",
"builder:linux-64-validator-opt",
"buildset:commit/git/cb31feffa500401c95c6c44d88b7c358236bca36",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/cb31feffa500401c95c6c44d88b7c358236bca36",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023479140566308144",
"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/8858049078199488224/+/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": "1610703123517770",
"url": "https://ci.chromium.org/b/8858049078199488224",
"utcnow_ts": "1610703123721583"
}
}
[09:32:03.729] Task URL: https://ci.chromium.org/b/8858049078199488224
[09:32:03.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:2:0) after 1m0s
[09:33:04.121] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:2:0)
[09:33:04.121] Timer tick, asking Buildbucket for the build status
[09:33:04.223] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:33:04.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:3:0) after 1m0s
[09:34:04.526] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:3:0)
[09:34:04.526] Timer tick, asking Buildbucket for the build status
[09:34:04.891] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:34:04.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:4:0) after 1m0s
[09:35:05.143] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:4:0)
[09:35:05.143] Timer tick, asking Buildbucket for the build status
[09:35:05.459] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:05.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:5:0) after 1m0s
[09:36:05.477] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:5:0)
[09:36:05.477] Timer tick, asking Buildbucket for the build status
[09:36:05.591] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:05.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:6:0) after 1m0s
[09:37:05.623] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:6:0)
[09:37:05.623] Timer tick, asking Buildbucket for the build status
[09:37:05.868] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:05.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:7:0) after 1m0s
[09:38:05.893] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:7:0)
[09:38:05.893] Timer tick, asking Buildbucket for the build status
[09:38:06.409] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:06.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:8:0) after 1m0s
[09:39:06.675] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:8:0)
[09:39:06.675] Timer tick, asking Buildbucket for the build status
[09:39:06.956] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:06.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:9:0) after 1m0s
[09:40:07.179] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:9:0)
[09:40:07.179] Timer tick, asking Buildbucket for the build status
[09:40:07.383] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:07.383] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:10:0) after 1m0s
[09:41:07.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:10:0)
[09:41:07.544] Timer tick, asking Buildbucket for the build status
[09:41:07.637] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:07.637] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:11:0) after 1m0s
[09:42:07.734] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:11:0)
[09:42:07.734] Timer tick, asking Buildbucket for the build status
[09:42:07.896] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:07.896] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:12:0) after 1m0s
[09:43:08.023] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:12:0)
[09:43:08.023] Timer tick, asking Buildbucket for the build status
[09:43:08.391] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:08.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:13:0) after 1m0s
[09:44:08.572] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:13:0)
[09:44:08.572] Timer tick, asking Buildbucket for the build status
[09:44:08.645] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:08.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:14:0) after 1m0s
[09:45:08.768] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:14:0)
[09:45:08.768] Timer tick, asking Buildbucket for the build status
[09:45:08.994] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:08.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:15:0) after 1m0s
[09:46:09.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:15:0)
[09:46:09.008] Timer tick, asking Buildbucket for the build status
[09:46:09.205] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:46:09.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:16:0) after 1m0s
[09:47:09.253] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:16:0)
[09:47:09.253] Timer tick, asking Buildbucket for the build status
[09:47:09.368] Build 8858049078199488224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:47:09.368] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:17:0) after 1m0s
[09:47:26.567] Received PubSub notification, asking Buildbucket for the build status
[09:47:26.652] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:09.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:17:0)
[09:48:09.394] Timer tick, asking Buildbucket for the build status
[09:48:09.545] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:09.545] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:19:0) after 1m0s
[09:49:09.569] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:19:0)
[09:49:09.569] Timer tick, asking Buildbucket for the build status
[09:49:10.219] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:10.219] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:20:0) after 1m0s
[09:50:10.205] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:20:0)
[09:50:10.205] Timer tick, asking Buildbucket for the build status
[09:50:10.338] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:10.338] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:21:0) after 1m0s
[09:51:10.404] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:21:0)
[09:51:10.404] Timer tick, asking Buildbucket for the build status
[09:51:10.574] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:10.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:22:0) after 1m0s
[09:52:10.602] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:22:0)
[09:52:10.602] Timer tick, asking Buildbucket for the build status
[09:52:10.899] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:10.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:23:0) after 1m0s
[09:53:10.902] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:23:0)
[09:53:10.902] Timer tick, asking Buildbucket for the build status
[09:53:11.128] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:11.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:24:0) after 1m0s
[09:54:11.176] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:24:0)
[09:54:11.176] Timer tick, asking Buildbucket for the build status
[09:54:11.262] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:11.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:25:0) after 1m0s
[09:55:11.328] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:25:0)
[09:55:11.328] Timer tick, asking Buildbucket for the build status
[09:55:11.431] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:11.431] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:26:0) after 1m0s
[09:56:11.469] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:26:0)
[09:56:11.469] Timer tick, asking Buildbucket for the build status
[09:56:11.842] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:11.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:27:0) after 1m0s
[09:57:11.854] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:27:0)
[09:57:11.854] Timer tick, asking Buildbucket for the build status
[09:57:12.428] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:12.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:28:0) after 1m0s
[09:58:12.470] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:28:0)
[09:58:12.470] Timer tick, asking Buildbucket for the build status
[09:58:12.706] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:12.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:29:0) after 1m0s
[09:59:12.718] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:29:0)
[09:59:12.718] Timer tick, asking Buildbucket for the build status
[09:59:12.786] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:12.786] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:30:0) after 1m0s
[10:00:12.893] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:30:0)
[10:00:12.893] Timer tick, asking Buildbucket for the build status
[10:00:13.223] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:13.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:31:0) after 1m0s
[10:01:13.246] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:31:0)
[10:01:13.246] Timer tick, asking Buildbucket for the build status
[10:01:13.321] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:13.321] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:32:0) after 1m0s
[10:02:13.318] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:32:0)
[10:02:13.318] Timer tick, asking Buildbucket for the build status
[10:02:14.000] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:14.000] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:33:0) after 1m0s
[10:03:14.101] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:33:0)
[10:03:14.101] Timer tick, asking Buildbucket for the build status
[10:03:14.175] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:14.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:34:0) after 1m0s
[10:04:14.215] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:34:0)
[10:04:14.215] Timer tick, asking Buildbucket for the build status
[10:04:14.427] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:14.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:35:0) after 1m0s
[10:05:14.450] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:35:0)
[10:05:14.450] Timer tick, asking Buildbucket for the build status
[10:05:14.519] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:14.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:36:0) after 1m0s
[10:06:14.608] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:36:0)
[10:06:14.608] Timer tick, asking Buildbucket for the build status
[10:06:14.686] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:14.686] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:37:0) after 1m0s
[10:07:14.741] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:37:0)
[10:07:14.741] Timer tick, asking Buildbucket for the build status
[10:07:14.885] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:14.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:38:0) after 1m0s
[10:08:14.909] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:38:0)
[10:08:14.909] Timer tick, asking Buildbucket for the build status
[10:08:15.131] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:15.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:39:0) after 1m0s
[10:09:15.205] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:39:0)
[10:09:15.205] Timer tick, asking Buildbucket for the build status
[10:09:15.289] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:15.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:40:0) after 1m0s
[10:10:15.320] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:40:0)
[10:10:15.320] Timer tick, asking Buildbucket for the build status
[10:10:15.374] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:15.374] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:41:0) after 1m0s
[10:11:15.384] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:41:0)
[10:11:15.384] Timer tick, asking Buildbucket for the build status
[10:11:15.543] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:15.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:42:0) after 1m0s
[10:12:15.614] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:42:0)
[10:12:15.614] Timer tick, asking Buildbucket for the build status
[10:12:15.709] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:15.709] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:43:0) after 1m0s
[10:13:15.759] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:43:0)
[10:13:15.759] Timer tick, asking Buildbucket for the build status
[10:13:15.847] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:15.847] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:44:0) after 1m0s
[10:14:15.877] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:44:0)
[10:14:15.877] Timer tick, asking Buildbucket for the build status
[10:14:16.139] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:16.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:45:0) after 1m0s
[10:15:16.196] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:45:0)
[10:15:16.196] Timer tick, asking Buildbucket for the build status
[10:15:16.513] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:16.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:46:0) after 1m0s
[10:16:16.537] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:46:0)
[10:16:16.537] Timer tick, asking Buildbucket for the build status
[10:16:16.795] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:16.795] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:47:0) after 1m0s
[10:17:16.832] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:47:0)
[10:17:16.832] Timer tick, asking Buildbucket for the build status
[10:17:16.999] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:16.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:48:0) after 1m0s
[10:18:17.063] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:48:0)
[10:18:17.063] Timer tick, asking Buildbucket for the build status
[10:18:17.133] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:17.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:49:0) after 1m0s
[10:19:17.217] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:49:0)
[10:19:17.217] Timer tick, asking Buildbucket for the build status
[10:19:17.281] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:17.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:50:0) after 1m0s
[10:20:17.323] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:50:0)
[10:20:17.323] Timer tick, asking Buildbucket for the build status
[10:20:17.453] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:17.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:51:0) after 1m0s
[10:21:17.477] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:51:0)
[10:21:17.477] Timer tick, asking Buildbucket for the build status
[10:21:17.741] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:17.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:52:0) after 1m0s
[10:22:17.726] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:52:0)
[10:22:17.726] Timer tick, asking Buildbucket for the build status
[10:22:17.853] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:17.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:53:0) after 1m0s
[10:23:17.946] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:53:0)
[10:23:17.946] Timer tick, asking Buildbucket for the build status
[10:23:18.038] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:18.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:54:0) after 1m0s
[10:24:18.063] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:54:0)
[10:24:18.063] Timer tick, asking Buildbucket for the build status
[10:24:18.131] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:18.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:55:0) after 1m0s
[10:25:18.414] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:55:0)
[10:25:18.414] Timer tick, asking Buildbucket for the build status
[10:25:18.503] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:18.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:56:0) after 1m0s
[10:26:18.525] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:56:0)
[10:26:18.525] Timer tick, asking Buildbucket for the build status
[10:26:18.823] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:18.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:57:0) after 1m0s
[10:27:18.853] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:57:0)
[10:27:18.853] Timer tick, asking Buildbucket for the build status
[10:27:18.942] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:18.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:58:0) after 1m0s
[10:28:19.066] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:58:0)
[10:28:19.066] Timer tick, asking Buildbucket for the build status
[10:28:19.132] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:19.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:59:0) after 1m0s
[10:29:19.174] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:59:0)
[10:29:19.174] Timer tick, asking Buildbucket for the build status
[10:29:19.231] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:19.231] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:60:0) after 1m0s
[10:30:19.323] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:60:0)
[10:30:19.323] Timer tick, asking Buildbucket for the build status
[10:30:19.501] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:19.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:61:0) after 1m0s
[10:31:19.555] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:61:0)
[10:31:19.555] Timer tick, asking Buildbucket for the build status
[10:31:19.633] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:19.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:62:0) after 1m0s
[10:32:19.671] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:62:0)
[10:32:19.671] Timer tick, asking Buildbucket for the build status
[10:32:19.790] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:19.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:63:0) after 1m0s
[10:33:19.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:63:0)
[10:33:19.834] Timer tick, asking Buildbucket for the build status
[10:33:19.905] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:19.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:64:0) after 1m0s
[10:34:19.955] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:64:0)
[10:34:19.955] Timer tick, asking Buildbucket for the build status
[10:34:20.036] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:20.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:65:0) after 1m0s
[10:35:20.079] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:65:0)
[10:35:20.079] Timer tick, asking Buildbucket for the build status
[10:35:20.179] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:20.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:66:0) after 1m0s
[10:36:20.205] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:66:0)
[10:36:20.205] Timer tick, asking Buildbucket for the build status
[10:36:20.398] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:20.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:67:0) after 1m0s
[10:37:20.404] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:67:0)
[10:37:20.404] Timer tick, asking Buildbucket for the build status
[10:37:20.627] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:20.627] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:68:0) after 1m0s
[10:38:20.758] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:68:0)
[10:38:20.758] Timer tick, asking Buildbucket for the build status
[10:38:20.929] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:20.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:69:0) after 1m0s
[10:39:21.105] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:69:0)
[10:39:21.105] Timer tick, asking Buildbucket for the build status
[10:39:21.217] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:21.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:70:0) after 1m0s
[10:40:21.491] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:70:0)
[10:40:21.491] Timer tick, asking Buildbucket for the build status
[10:40:21.581] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:21.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:71:0) after 1m0s
[10:41:21.722] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:71:0)
[10:41:21.722] Timer tick, asking Buildbucket for the build status
[10:41:22.079] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:22.079] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:72:0) after 1m0s
[10:42:22.197] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:72:0)
[10:42:22.197] Timer tick, asking Buildbucket for the build status
[10:42:22.727] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:22.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:73:0) after 1m0s
[10:43:22.718] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:73:0)
[10:43:22.718] Timer tick, asking Buildbucket for the build status
[10:43:22.807] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:22.807] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:74:0) after 1m0s
[10:44:22.978] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:74:0)
[10:44:22.978] Timer tick, asking Buildbucket for the build status
[10:44:23.208] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:23.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:75:0) after 1m0s
[10:45:23.309] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:75:0)
[10:45:23.309] Timer tick, asking Buildbucket for the build status
[10:45:23.383] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:23.383] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:76:0) after 1m0s
[10:46:23.363] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:76:0)
[10:46:23.363] Timer tick, asking Buildbucket for the build status
[10:46:23.464] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:23.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:77:0) after 1m0s
[10:47:23.440] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:77:0)
[10:47:23.440] Timer tick, asking Buildbucket for the build status
[10:47:23.689] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:23.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:78:0) after 1m0s
[10:48:23.733] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:78:0)
[10:48:23.733] Timer tick, asking Buildbucket for the build status
[10:48:23.806] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:23.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:79:0) after 1m0s
[10:49:23.854] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:79:0)
[10:49:23.854] Timer tick, asking Buildbucket for the build status
[10:49:23.953] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:23.953] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:80:0) after 1m0s
[10:50:23.966] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:80:0)
[10:50:23.966] Timer tick, asking Buildbucket for the build status
[10:50:24.028] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:24.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:81:0) after 1m0s
[10:51:24.060] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:81:0)
[10:51:24.060] Timer tick, asking Buildbucket for the build status
[10:51:24.300] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:24.300] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:82:0) after 1m0s
[10:52:24.348] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:82:0)
[10:52:24.348] Timer tick, asking Buildbucket for the build status
[10:52:24.487] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:24.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:83:0) after 1m0s
[10:53:24.535] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:83:0)
[10:53:24.535] Timer tick, asking Buildbucket for the build status
[10:53:24.659] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:24.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:84:0) after 1m0s
[10:54:25.164] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:84:0)
[10:54:25.164] Timer tick, asking Buildbucket for the build status
[10:54:25.228] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:25.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:85:0) after 1m0s
[10:55:27.428] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:85:0)
[10:55:27.428] Timer tick, asking Buildbucket for the build status
[10:55:27.669] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:27.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:86:0) after 1m0s
[10:56:27.740] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:86:0)
[10:56:27.740] Timer tick, asking Buildbucket for the build status
[10:56:27.892] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:27.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:87:0) after 1m0s
[10:57:27.967] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:87:0)
[10:57:27.967] Timer tick, asking Buildbucket for the build status
[10:57:28.601] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:28.601] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:88:0) after 1m0s
[10:58:28.704] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:88:0)
[10:58:28.704] Timer tick, asking Buildbucket for the build status
[10:58:28.779] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:28.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:89:0) after 1m0s
[10:59:28.811] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:89:0)
[10:59:28.811] Timer tick, asking Buildbucket for the build status
[10:59:28.898] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:28.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:90:0) after 1m0s
[11:00:28.915] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:90:0)
[11:00:28.915] Timer tick, asking Buildbucket for the build status
[11:00:29.197] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:29.197] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:91:0) after 1m0s
[11:01:29.223] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:91:0)
[11:01:29.223] Timer tick, asking Buildbucket for the build status
[11:01:29.297] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:29.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:92:0) after 1m0s
[11:02:29.366] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:92:0)
[11:02:29.366] Timer tick, asking Buildbucket for the build status
[11:02:29.893] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:29.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:93:0) after 1m0s
[11:03:30.001] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:93:0)
[11:03:30.001] Timer tick, asking Buildbucket for the build status
[11:03:30.063] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:30.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:94:0) after 1m0s
[11:04:30.104] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:94:0)
[11:04:30.104] Timer tick, asking Buildbucket for the build status
[11:04:30.161] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:30.161] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:95:0) after 1m0s
[11:05:30.225] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:95:0)
[11:05:30.225] Timer tick, asking Buildbucket for the build status
[11:05:30.294] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:30.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:96:0) after 1m0s
[11:06:30.325] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:96:0)
[11:06:30.325] Timer tick, asking Buildbucket for the build status
[11:06:30.446] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:30.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:97:0) after 1m0s
[11:07:30.522] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:97:0)
[11:07:30.522] Timer tick, asking Buildbucket for the build status
[11:07:30.710] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:30.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:98:0) after 1m0s
[11:08:30.816] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:98:0)
[11:08:30.816] Timer tick, asking Buildbucket for the build status
[11:08:30.902] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:30.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:99:0) after 1m0s
[11:09:31.044] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:99:0)
[11:09:31.044] Timer tick, asking Buildbucket for the build status
[11:09:31.232] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:31.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:100:0) after 1m0s
[11:10:31.393] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:100:0)
[11:10:31.393] Timer tick, asking Buildbucket for the build status
[11:10:31.470] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:31.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:101:0) after 1m0s
[11:11:31.522] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:101:0)
[11:11:31.522] Timer tick, asking Buildbucket for the build status
[11:11:31.685] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:31.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:102:0) after 1m0s
[11:12:31.721] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:102:0)
[11:12:31.721] Timer tick, asking Buildbucket for the build status
[11:12:31.815] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:31.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:103:0) after 1m0s
[11:13:31.874] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:103:0)
[11:13:31.874] Timer tick, asking Buildbucket for the build status
[11:13:32.141] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:32.141] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:104:0) after 1m0s
[11:14:32.215] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:104:0)
[11:14:32.215] Timer tick, asking Buildbucket for the build status
[11:14:32.273] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:32.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:105:0) after 1m0s
[11:15:32.336] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:105:0)
[11:15:32.336] Timer tick, asking Buildbucket for the build status
[11:15:32.509] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:32.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:106:0) after 1m0s
[11:16:32.576] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:106:0)
[11:16:32.576] Timer tick, asking Buildbucket for the build status
[11:16:32.665] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:32.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:107:0) after 1m0s
[11:17:32.729] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:107:0)
[11:17:32.729] Timer tick, asking Buildbucket for the build status
[11:17:32.852] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:32.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:108:0) after 1m0s
[11:18:32.886] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:108:0)
[11:18:32.886] Timer tick, asking Buildbucket for the build status
[11:18:32.958] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:32.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:109:0) after 1m0s
[11:19:33.022] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:109:0)
[11:19:33.022] Timer tick, asking Buildbucket for the build status
[11:19:33.175] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:33.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:110:0) after 1m0s
[11:20:33.220] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:110:0)
[11:20:33.220] Timer tick, asking Buildbucket for the build status
[11:20:33.578] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:33.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:111:0) after 1m0s
[11:21:33.616] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:111:0)
[11:21:33.616] Timer tick, asking Buildbucket for the build status
[11:21:33.684] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:33.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:112:0) after 1m0s
[11:22:34.221] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:112:0)
[11:22:34.221] Timer tick, asking Buildbucket for the build status
[11:22:34.938] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:34.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:113:0) after 1m0s
[11:23:35.041] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:113:0)
[11:23:35.041] Timer tick, asking Buildbucket for the build status
[11:23:35.098] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:35.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:114:0) after 1m0s
[11:24:35.214] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:114:0)
[11:24:35.214] Timer tick, asking Buildbucket for the build status
[11:24:35.284] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:35.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:115:0) after 1m0s
[11:25:35.538] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:115:0)
[11:25:35.538] Timer tick, asking Buildbucket for the build status
[11:25:35.621] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:35.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:116:0) after 1m0s
[11:26:35.770] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:116:0)
[11:26:35.770] Timer tick, asking Buildbucket for the build status
[11:26:35.842] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:35.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:117:0) after 1m0s
[11:27:35.949] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:117:0)
[11:27:35.949] Timer tick, asking Buildbucket for the build status
[11:27:36.066] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:36.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:118:0) after 1m0s
[11:28:36.164] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:118:0)
[11:28:36.164] Timer tick, asking Buildbucket for the build status
[11:28:36.240] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:36.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:119:0) after 1m0s
[11:29:36.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:119:0)
[11:29:36.290] Timer tick, asking Buildbucket for the build status
[11:29:37.649] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:37.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:120:0) after 1m0s
[11:30:37.826] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:120:0)
[11:30:37.826] Timer tick, asking Buildbucket for the build status
[11:30:37.887] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:37.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:121:0) after 1m0s
[11:31:37.982] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:121:0)
[11:31:37.982] Timer tick, asking Buildbucket for the build status
[11:31:38.058] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:38.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:122:0) after 1m0s
[11:32:38.128] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:122:0)
[11:32:38.128] Timer tick, asking Buildbucket for the build status
[11:32:38.536] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:38.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:123:0) after 1m0s
[11:33:38.561] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:123:0)
[11:33:38.561] Timer tick, asking Buildbucket for the build status
[11:33:38.618] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:38.618] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:124:0) after 1m0s
[11:34:38.662] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:124:0)
[11:34:38.662] Timer tick, asking Buildbucket for the build status
[11:34:39.006] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:39.006] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:125:0) after 1m0s
[11:35:39.069] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:125:0)
[11:35:39.069] Timer tick, asking Buildbucket for the build status
[11:35:39.298] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:39.298] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:126:0) after 1m0s
[11:36:39.363] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:126:0)
[11:36:39.363] Timer tick, asking Buildbucket for the build status
[11:36:40.109] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:40.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:127:0) after 1m0s
[11:37:40.127] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:127:0)
[11:37:40.127] Timer tick, asking Buildbucket for the build status
[11:37:40.297] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:40.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:128:0) after 1m0s
[11:38:40.344] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:128:0)
[11:38:40.344] Timer tick, asking Buildbucket for the build status
[11:38:40.442] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:40.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:129:0) after 1m0s
[11:39:40.587] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:129:0)
[11:39:40.587] Timer tick, asking Buildbucket for the build status
[11:39:40.656] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:40.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:130:0) after 1m0s
[11:40:40.707] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:130:0)
[11:40:40.707] Timer tick, asking Buildbucket for the build status
[11:40:41.235] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:41.235] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:131:0) after 1m0s
[11:41:41.252] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:131:0)
[11:41:41.252] Timer tick, asking Buildbucket for the build status
[11:41:41.714] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:41.714] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:132:0) after 1m0s
[11:42:41.704] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:132:0)
[11:42:41.704] Timer tick, asking Buildbucket for the build status
[11:42:41.822] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:41.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:133:0) after 1m0s
[11:43:41.849] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:133:0)
[11:43:41.849] Timer tick, asking Buildbucket for the build status
[11:43:42.211] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:42.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:134:0) after 1m0s
[11:44:42.242] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:134:0)
[11:44:42.242] Timer tick, asking Buildbucket for the build status
[11:44:42.313] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:42.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:135:0) after 1m0s
[11:45:42.373] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:135:0)
[11:45:42.373] Timer tick, asking Buildbucket for the build status
[11:45:42.756] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:42.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:136:0) after 1m0s
[11:46:42.819] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:136:0)
[11:46:42.819] Timer tick, asking Buildbucket for the build status
[11:46:42.885] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:42.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:137:0) after 1m0s
[11:47:42.978] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:137:0)
[11:47:42.978] Timer tick, asking Buildbucket for the build status
[11:47:43.096] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:43.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:138:0) after 1m0s
[11:48:43.229] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:138:0)
[11:48:43.229] Timer tick, asking Buildbucket for the build status
[11:48:43.300] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:43.300] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:139:0) after 1m0s
[11:49:43.393] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:139:0)
[11:49:43.393] Timer tick, asking Buildbucket for the build status
[11:49:43.446] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:43.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:140:0) after 1m0s
[11:50:43.514] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:140:0)
[11:50:43.514] Timer tick, asking Buildbucket for the build status
[11:50:43.733] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:43.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:141:0) after 1m0s
[11:51:43.796] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:141:0)
[11:51:43.796] Timer tick, asking Buildbucket for the build status
[11:51:43.852] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:43.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:142:0) after 1m0s
[11:52:43.885] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:142:0)
[11:52:43.885] Timer tick, asking Buildbucket for the build status
[11:52:44.036] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:44.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:143:0) after 1m0s
[11:53:44.073] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:143:0)
[11:53:44.073] Timer tick, asking Buildbucket for the build status
[11:53:44.419] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:44.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:144:0) after 1m0s
[11:54:44.464] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:144:0)
[11:54:44.464] Timer tick, asking Buildbucket for the build status
[11:54:44.547] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:44.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:145:0) after 1m0s
[11:55:44.598] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:145:0)
[11:55:44.598] Timer tick, asking Buildbucket for the build status
[11:55:44.943] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:44.943] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:146:0) after 1m0s
[11:56:44.988] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:146:0)
[11:56:44.988] Timer tick, asking Buildbucket for the build status
[11:56:45.093] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:45.093] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:147:0) after 1m0s
[11:57:45.142] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:147:0)
[11:57:45.142] Timer tick, asking Buildbucket for the build status
[11:57:45.254] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:45.254] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:148:0) after 1m0s
[11:58:45.254] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:148:0)
[11:58:45.254] Timer tick, asking Buildbucket for the build status
[11:58:45.431] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:45.431] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:149:0) after 1m0s
[11:59:45.488] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:149:0)
[11:59:45.488] Timer tick, asking Buildbucket for the build status
[11:59:45.560] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:45.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:150:0) after 1m0s
[12:00:45.676] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:150:0)
[12:00:45.676] Timer tick, asking Buildbucket for the build status
[12:00:45.765] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:45.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:151:0) after 1m0s
[12:01:45.888] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:151:0)
[12:01:45.888] Timer tick, asking Buildbucket for the build status
[12:01:46.097] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:46.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:152:0) after 1m0s
[12:02:46.131] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:152:0)
[12:02:46.131] Timer tick, asking Buildbucket for the build status
[12:02:46.584] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:46.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:153:0) after 1m0s
[12:03:46.620] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:153:0)
[12:03:46.620] Timer tick, asking Buildbucket for the build status
[12:03:46.733] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:46.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:154:0) after 1m0s
[12:04:46.777] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:154:0)
[12:04:46.777] Timer tick, asking Buildbucket for the build status
[12:04:47.054] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:47.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:155:0) after 1m0s
[12:05:47.110] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:155:0)
[12:05:47.110] Timer tick, asking Buildbucket for the build status
[12:05:47.186] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:47.186] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:156:0) after 1m0s
[12:06:47.288] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:156:0)
[12:06:47.288] Timer tick, asking Buildbucket for the build status
[12:06:47.413] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:47.413] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:157:0) after 1m0s
[12:07:47.473] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:157:0)
[12:07:47.473] Timer tick, asking Buildbucket for the build status
[12:07:47.592] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:47.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:158:0) after 1m0s
[12:08:47.660] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:158:0)
[12:08:47.660] Timer tick, asking Buildbucket for the build status
[12:08:47.720] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:47.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:159:0) after 1m0s
[12:09:47.750] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:159:0)
[12:09:47.750] Timer tick, asking Buildbucket for the build status
[12:09:47.840] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:47.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:160:0) after 1m0s
[12:10:47.897] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:160:0)
[12:10:47.897] Timer tick, asking Buildbucket for the build status
[12:10:47.999] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:47.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:161:0) after 1m0s
[12:11:48.089] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:161:0)
[12:11:48.089] Timer tick, asking Buildbucket for the build status
[12:11:48.157] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:48.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:162:0) after 1m0s
[12:12:48.285] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:162:0)
[12:12:48.285] Timer tick, asking Buildbucket for the build status
[12:12:48.387] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:48.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:163:0) after 1m0s
[12:13:48.505] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:163:0)
[12:13:48.505] Timer tick, asking Buildbucket for the build status
[12:13:48.626] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:48.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:164:0) after 1m0s
[12:14:48.734] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:164:0)
[12:14:48.734] Timer tick, asking Buildbucket for the build status
[12:14:48.805] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:48.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:165:0) after 1m0s
[12:15:48.838] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:165:0)
[12:15:48.838] Timer tick, asking Buildbucket for the build status
[12:15:48.927] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:48.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:166:0) after 1m0s
[12:16:48.997] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:166:0)
[12:16:48.997] Timer tick, asking Buildbucket for the build status
[12:16:49.064] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:49.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:167:0) after 1m0s
[12:17:49.176] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:167:0)
[12:17:49.176] Timer tick, asking Buildbucket for the build status
[12:17:49.313] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:49.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:168:0) after 1m0s
[12:18:49.437] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:168:0)
[12:18:49.437] Timer tick, asking Buildbucket for the build status
[12:18:49.496] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:49.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:169:0) after 1m0s
[12:19:49.551] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:169:0)
[12:19:49.551] Timer tick, asking Buildbucket for the build status
[12:19:49.708] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:49.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:170:0) after 1m0s
[12:20:49.734] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:170:0)
[12:20:49.734] Timer tick, asking Buildbucket for the build status
[12:20:50.031] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:50.031] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:171:0) after 1m0s
[12:21:50.038] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:171:0)
[12:21:50.038] Timer tick, asking Buildbucket for the build status
[12:21:51.231] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:51.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:172:0) after 1m0s
[12:22:51.346] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:172:0)
[12:22:51.346] Timer tick, asking Buildbucket for the build status
[12:22:51.460] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:51.460] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:173:0) after 1m0s
[12:23:51.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:173:0)
[12:23:51.494] Timer tick, asking Buildbucket for the build status
[12:23:51.560] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:51.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:174:0) after 1m0s
[12:24:51.628] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:174:0)
[12:24:51.628] Timer tick, asking Buildbucket for the build status
[12:24:51.925] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:51.925] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:175:0) after 1m0s
[12:25:51.957] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:175:0)
[12:25:51.957] Timer tick, asking Buildbucket for the build status
[12:25:52.918] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:52.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:176:0) after 1m0s
[12:26:52.927] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:176:0)
[12:26:52.928] Timer tick, asking Buildbucket for the build status
[12:26:52.993] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:52.993] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:177:0) after 1m0s
[12:27:52.969] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:177:0)
[12:27:52.969] Timer tick, asking Buildbucket for the build status
[12:27:53.079] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:53.079] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:178:0) after 1m0s
[12:28:53.083] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:178:0)
[12:28:53.083] Timer tick, asking Buildbucket for the build status
[12:28:53.225] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:53.225] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:179:0) after 1m0s
[12:29:53.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:179:0)
[12:29:53.360] Timer tick, asking Buildbucket for the build status
[12:29:53.537] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:53.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:180:0) after 1m0s
[12:30:53.540] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:180:0)
[12:30:53.540] Timer tick, asking Buildbucket for the build status
[12:30:53.603] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:53.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:181:0) after 1m0s
[12:31:53.635] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:181:0)
[12:31:53.635] Timer tick, asking Buildbucket for the build status
[12:31:54.293] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:54.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:182:0) after 1m0s
[12:32:54.345] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:182:0)
[12:32:54.345] Timer tick, asking Buildbucket for the build status
[12:32:54.458] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:54.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:183:0) after 1m0s
[12:33:54.478] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:183:0)
[12:33:54.478] Timer tick, asking Buildbucket for the build status
[12:33:54.543] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:54.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:184:0) after 1m0s
[12:34:54.579] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:184:0)
[12:34:54.579] Timer tick, asking Buildbucket for the build status
[12:34:54.808] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:54.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:185:0) after 1m0s
[12:35:54.869] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:185:0)
[12:35:54.869] Timer tick, asking Buildbucket for the build status
[12:35:55.257] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:55.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:186:0) after 1m0s
[12:36:55.359] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:186:0)
[12:36:55.359] Timer tick, asking Buildbucket for the build status
[12:36:55.436] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:55.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:187:0) after 1m0s
[12:37:55.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:187:0)
[12:37:55.486] Timer tick, asking Buildbucket for the build status
[12:37:55.747] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:55.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:188:0) after 1m0s
[12:38:55.781] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:188:0)
[12:38:55.782] Timer tick, asking Buildbucket for the build status
[12:38:55.835] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:55.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:189:0) after 1m0s
[12:39:55.874] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:189:0)
[12:39:55.874] Timer tick, asking Buildbucket for the build status
[12:39:56.274] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:56.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:190:0) after 1m0s
[12:40:56.321] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:190:0)
[12:40:56.321] Timer tick, asking Buildbucket for the build status
[12:40:56.495] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:56.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:191:0) after 1m0s
[12:41:56.523] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:191:0)
[12:41:56.523] Timer tick, asking Buildbucket for the build status
[12:41:56.597] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:56.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:192:0) after 1m0s
[12:42:56.632] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:192:0)
[12:42:56.632] Timer tick, asking Buildbucket for the build status
[12:42:57.222] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:57.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:193:0) after 1m0s
[12:43:57.265] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:193:0)
[12:43:57.265] Timer tick, asking Buildbucket for the build status
[12:43:57.494] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:57.494] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:194:0) after 1m0s
[12:44:57.521] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:194:0)
[12:44:57.521] Timer tick, asking Buildbucket for the build status
[12:44:57.725] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:57.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:195:0) after 1m0s
[12:45:57.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:195:0)
[12:45:57.745] Timer tick, asking Buildbucket for the build status
[12:45:57.835] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:57.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:196:0) after 1m0s
[12:46:57.865] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:196:0)
[12:46:57.865] Timer tick, asking Buildbucket for the build status
[12:46:57.929] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:57.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:197:0) after 1m0s
[12:47:57.974] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:197:0)
[12:47:57.974] Timer tick, asking Buildbucket for the build status
[12:47:58.165] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:58.165] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:198:0) after 1m0s
[12:48:58.210] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:198:0)
[12:48:58.210] Timer tick, asking Buildbucket for the build status
[12:48:58.331] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:58.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:199:0) after 1m0s
[12:49:58.433] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:199:0)
[12:49:58.433] Timer tick, asking Buildbucket for the build status
[12:49:58.669] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:58.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:200:0) after 1m0s
[12:50:58.733] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:200:0)
[12:50:58.733] Timer tick, asking Buildbucket for the build status
[12:50:58.802] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:58.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:201:0) after 1m0s
[12:51:58.894] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:201:0)
[12:51:58.894] Timer tick, asking Buildbucket for the build status
[12:51:59.092] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:59.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:202:0) after 1m0s
[12:52:59.158] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:202:0)
[12:52:59.158] Timer tick, asking Buildbucket for the build status
[12:52:59.299] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:59.299] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:203:0) after 1m0s
[12:53:59.370] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:203:0)
[12:53:59.370] Timer tick, asking Buildbucket for the build status
[12:53:59.514] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:59.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:204:0) after 1m0s
[12:54:59.628] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:204:0)
[12:54:59.628] Timer tick, asking Buildbucket for the build status
[12:54:59.703] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:59.703] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:205:0) after 1m0s
[12:55:59.829] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:205:0)
[12:55:59.829] Timer tick, asking Buildbucket for the build status
[12:55:59.909] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:59.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:206:0) after 1m0s
[12:56:59.914] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:206:0)
[12:56:59.914] Timer tick, asking Buildbucket for the build status
[12:57:00.150] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:00.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:207:0) after 1m0s
[12:58:00.241] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:207:0)
[12:58:00.241] Timer tick, asking Buildbucket for the build status
[12:58:00.411] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:00.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:208:0) after 1m0s
[12:59:00.469] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:208:0)
[12:59:00.469] Timer tick, asking Buildbucket for the build status
[12:59:00.681] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:00.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:209:0) after 1m0s
[13:00:00.715] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:209:0)
[13:00:00.715] Timer tick, asking Buildbucket for the build status
[13:00:01.487] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:01.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:210:0) after 1m0s
[13:01:01.634] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:210:0)
[13:01:01.634] Timer tick, asking Buildbucket for the build status
[13:01:02.128] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:02.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:211:0) after 1m0s
[13:02:02.294] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:211:0)
[13:02:02.294] Timer tick, asking Buildbucket for the build status
[13:02:02.423] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:02.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:212:0) after 1m0s
[13:03:02.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:212:0)
[13:03:02.487] Timer tick, asking Buildbucket for the build status
[13:03:02.681] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:02.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:213:0) after 1m0s
[13:04:02.710] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:213:0)
[13:04:02.710] Timer tick, asking Buildbucket for the build status
[13:04:02.997] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:02.997] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:214:0) after 1m0s
[13:05:03.015] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:214:0)
[13:05:03.015] Timer tick, asking Buildbucket for the build status
[13:05:03.317] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:03.317] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:215:0) after 1m0s
[13:06:03.325] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:215:0)
[13:06:03.325] Timer tick, asking Buildbucket for the build status
[13:06:03.531] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:03.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:216:0) after 1m0s
[13:07:03.591] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:216:0)
[13:07:03.591] Timer tick, asking Buildbucket for the build status
[13:07:03.679] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:03.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:217:0) after 1m0s
[13:08:03.723] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:217:0)
[13:08:03.723] Timer tick, asking Buildbucket for the build status
[13:08:03.897] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:03.897] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:218:0) after 1m0s
[13:09:03.927] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:218:0)
[13:09:03.927] Timer tick, asking Buildbucket for the build status
[13:09:03.993] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:03.993] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:219:0) after 1m0s
[13:10:04.051] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:219:0)
[13:10:04.051] Timer tick, asking Buildbucket for the build status
[13:10:04.153] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:04.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:220:0) after 1m0s
[13:11:04.232] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:220:0)
[13:11:04.232] Timer tick, asking Buildbucket for the build status
[13:11:04.325] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:04.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:221:0) after 1m0s
[13:12:04.362] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:221:0)
[13:12:04.362] Timer tick, asking Buildbucket for the build status
[13:12:04.624] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:04.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:222:0) after 1m0s
[13:13:04.664] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:222:0)
[13:13:04.664] Timer tick, asking Buildbucket for the build status
[13:13:04.909] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:04.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:223:0) after 1m0s
[13:14:04.989] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:223:0)
[13:14:04.989] Timer tick, asking Buildbucket for the build status
[13:14:05.102] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:05.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:224:0) after 1m0s
[13:15:05.144] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:224:0)
[13:15:05.144] Timer tick, asking Buildbucket for the build status
[13:15:05.214] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:05.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:225:0) after 1m0s
[13:16:05.216] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:225:0)
[13:16:05.216] Timer tick, asking Buildbucket for the build status
[13:16:05.499] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:05.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:226:0) after 1m0s
[13:17:05.533] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:226:0)
[13:17:05.533] Timer tick, asking Buildbucket for the build status
[13:17:05.599] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:05.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:227:0) after 1m0s
[13:18:05.720] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:227:0)
[13:18:05.721] Timer tick, asking Buildbucket for the build status
[13:18:06.053] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:06.053] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:228:0) after 1m0s
[13:19:06.103] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:228:0)
[13:19:06.103] Timer tick, asking Buildbucket for the build status
[13:19:07.110] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:07.110] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:229:0) after 1m0s
[13:20:07.116] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:229:0)
[13:20:07.116] Timer tick, asking Buildbucket for the build status
[13:20:07.262] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:07.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:230:0) after 1m0s
[13:21:07.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:230:0)
[13:21:07.394] Timer tick, asking Buildbucket for the build status
[13:21:07.788] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:07.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:231:0) after 1m0s
[13:22:07.894] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:231:0)
[13:22:07.894] Timer tick, asking Buildbucket for the build status
[13:22:08.020] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:08.020] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:232:0) after 1m0s
[13:23:08.054] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:232:0)
[13:23:08.054] Timer tick, asking Buildbucket for the build status
[13:23:08.184] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:08.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:233:0) after 1m0s
[13:24:08.221] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:233:0)
[13:24:08.221] Timer tick, asking Buildbucket for the build status
[13:24:08.288] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:08.288] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:234:0) after 1m0s
[13:25:08.350] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:234:0)
[13:25:08.350] Timer tick, asking Buildbucket for the build status
[13:25:08.566] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:08.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:235:0) after 1m0s
[13:26:08.723] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:235:0)
[13:26:08.723] Timer tick, asking Buildbucket for the build status
[13:26:08.809] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:08.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:236:0) after 1m0s
[13:27:08.858] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:236:0)
[13:27:08.858] Timer tick, asking Buildbucket for the build status
[13:27:09.119] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:09.119] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:237:0) after 1m0s
[13:28:09.159] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:237:0)
[13:28:09.159] Timer tick, asking Buildbucket for the build status
[13:28:09.513] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:09.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:238:0) after 1m0s
[13:29:09.616] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:238:0)
[13:29:09.616] Timer tick, asking Buildbucket for the build status
[13:29:09.680] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:09.680] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:239:0) after 1m0s
[13:30:09.764] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:239:0)
[13:30:09.764] Timer tick, asking Buildbucket for the build status
[13:30:09.990] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:09.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:240:0) after 1m0s
[13:31:10.026] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:240:0)
[13:31:10.026] Timer tick, asking Buildbucket for the build status
[13:31:10.109] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:10.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:241:0) after 1m0s
[13:32:10.122] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:241:0)
[13:32:10.122] Timer tick, asking Buildbucket for the build status
[13:32:10.305] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:10.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:242:0) after 1m0s
[13:33:10.378] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:242:0)
[13:33:10.378] Timer tick, asking Buildbucket for the build status
[13:33:10.492] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:10.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:243:0) after 1m0s
[13:34:10.522] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:243:0)
[13:34:10.522] Timer tick, asking Buildbucket for the build status
[13:34:10.609] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:10.609] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:244:0) after 1m0s
[13:35:10.639] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:244:0)
[13:35:10.639] Timer tick, asking Buildbucket for the build status
[13:35:11.112] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:11.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:245:0) after 1m0s
[13:36:11.132] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:245:0)
[13:36:11.132] Timer tick, asking Buildbucket for the build status
[13:36:11.208] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:11.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:246:0) after 1m0s
[13:37:11.252] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:246:0)
[13:37:11.252] Timer tick, asking Buildbucket for the build status
[13:37:11.319] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:11.319] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:247:0) after 1m0s
[13:38:11.407] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:247:0)
[13:38:11.407] Timer tick, asking Buildbucket for the build status
[13:38:11.515] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:11.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:248:0) after 1m0s
[13:39:11.578] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:248:0)
[13:39:11.578] Timer tick, asking Buildbucket for the build status
[13:39:11.654] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:11.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:249:0) after 1m0s
[13:40:11.710] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:249:0)
[13:40:11.710] Timer tick, asking Buildbucket for the build status
[13:40:11.787] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:11.787] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:250:0) after 1m0s
[13:41:11.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:250:0)
[13:41:11.844] Timer tick, asking Buildbucket for the build status
[13:41:11.904] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:11.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:251:0) after 1m0s
[13:42:11.989] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:251:0)
[13:42:11.989] Timer tick, asking Buildbucket for the build status
[13:42:12.417] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:12.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:252:0) after 1m0s
[13:43:12.474] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:252:0)
[13:43:12.474] Timer tick, asking Buildbucket for the build status
[13:43:12.607] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:12.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:253:0) after 1m0s
[13:44:12.666] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:253:0)
[13:44:12.666] Timer tick, asking Buildbucket for the build status
[13:44:12.741] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:12.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:254:0) after 1m0s
[13:45:12.777] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:254:0)
[13:45:12.777] Timer tick, asking Buildbucket for the build status
[13:45:12.869] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:12.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:255:0) after 1m0s
[13:46:12.923] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:255:0)
[13:46:12.923] Timer tick, asking Buildbucket for the build status
[13:46:13.003] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:13.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:256:0) after 1m0s
[13:47:13.089] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:256:0)
[13:47:13.089] Timer tick, asking Buildbucket for the build status
[13:47:13.158] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:13.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:257:0) after 1m0s
[13:48:13.220] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:257:0)
[13:48:13.220] Timer tick, asking Buildbucket for the build status
[13:48:13.410] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:13.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:258:0) after 1m0s
[13:49:13.606] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:258:0)
[13:49:13.606] Timer tick, asking Buildbucket for the build status
[13:49:13.688] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:13.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:259:0) after 1m0s
[13:50:13.715] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:259:0)
[13:50:13.715] Timer tick, asking Buildbucket for the build status
[13:50:13.844] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:13.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:260:0) after 1m0s
[13:51:13.907] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:260:0)
[13:51:13.907] Timer tick, asking Buildbucket for the build status
[13:51:14.112] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:14.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:261:0) after 1m0s
[13:52:14.113] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:261:0)
[13:52:14.113] Timer tick, asking Buildbucket for the build status
[13:52:14.195] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:14.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:262:0) after 1m0s
[13:53:14.248] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:262:0)
[13:53:14.248] Timer tick, asking Buildbucket for the build status
[13:53:14.349] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:14.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:263:0) after 1m0s
[13:54:14.437] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:263:0)
[13:54:14.437] Timer tick, asking Buildbucket for the build status
[13:54:14.501] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:14.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:264:0) after 1m0s
[13:55:14.710] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:264:0)
[13:55:14.710] Timer tick, asking Buildbucket for the build status
[13:55:14.780] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:14.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:265:0) after 1m0s
[13:56:14.887] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:265:0)
[13:56:14.887] Timer tick, asking Buildbucket for the build status
[13:56:14.968] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:14.968] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:266:0) after 1m0s
[13:57:14.996] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:266:0)
[13:57:14.996] Timer tick, asking Buildbucket for the build status
[13:57:15.110] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:15.110] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:267:0) after 1m0s
[13:58:15.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:267:0)
[13:58:15.156] Timer tick, asking Buildbucket for the build status
[13:58:15.259] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:15.259] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:268:0) after 1m0s
[13:59:15.451] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:268:0)
[13:59:15.451] Timer tick, asking Buildbucket for the build status
[13:59:15.531] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:15.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:269:0) after 1m0s
[14:00:15.645] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:269:0)
[14:00:15.645] Timer tick, asking Buildbucket for the build status
[14:00:15.734] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:15.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:270:0) after 1m0s
[14:01:15.868] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:270:0)
[14:01:15.868] Timer tick, asking Buildbucket for the build status
[14:01:15.943] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:15.943] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:271:0) after 1m0s
[14:02:15.975] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:271:0)
[14:02:15.975] Timer tick, asking Buildbucket for the build status
[14:02:16.028] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:16.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:272:0) after 1m0s
[14:03:16.126] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:272:0)
[14:03:16.126] Timer tick, asking Buildbucket for the build status
[14:03:16.486] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:16.486] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:273:0) after 1m0s
[14:04:16.536] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:273:0)
[14:04:16.536] Timer tick, asking Buildbucket for the build status
[14:04:16.826] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:16.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:274:0) after 1m0s
[14:05:16.852] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:274:0)
[14:05:16.852] Timer tick, asking Buildbucket for the build status
[14:05:17.422] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:17.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:275:0) after 1m0s
[14:06:17.461] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:275:0)
[14:06:17.461] Timer tick, asking Buildbucket for the build status
[14:06:17.530] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:17.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:276:0) after 1m0s
[14:07:17.621] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:276:0)
[14:07:17.621] Timer tick, asking Buildbucket for the build status
[14:07:17.900] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:17.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:277:0) after 1m0s
[14:08:17.968] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:277:0)
[14:08:17.968] Timer tick, asking Buildbucket for the build status
[14:08:18.532] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:18.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:278:0) after 1m0s
[14:09:18.599] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:278:0)
[14:09:18.599] Timer tick, asking Buildbucket for the build status
[14:09:18.949] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:18.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:279:0) after 1m0s
[14:10:18.978] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:279:0)
[14:10:18.978] Timer tick, asking Buildbucket for the build status
[14:10:19.094] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:19.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:280:0) after 1m0s
[14:11:19.123] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:280:0)
[14:11:19.123] Timer tick, asking Buildbucket for the build status
[14:11:19.439] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:19.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:281:0) after 1m0s
[14:12:19.540] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:281:0)
[14:12:19.540] Timer tick, asking Buildbucket for the build status
[14:12:19.604] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:19.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:282:0) after 1m0s
[14:13:19.769] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:282:0)
[14:13:19.769] Timer tick, asking Buildbucket for the build status
[14:13:22.406] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:22.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:283:0) after 1m0s
[14:14:22.611] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:283:0)
[14:14:22.611] Timer tick, asking Buildbucket for the build status
[14:14:22.919] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:22.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:284:0) after 1m0s
[14:15:23.009] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:284:0)
[14:15:23.009] Timer tick, asking Buildbucket for the build status
[14:15:23.098] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:23.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:285:0) after 1m0s
[14:16:23.163] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:285:0)
[14:16:23.163] Timer tick, asking Buildbucket for the build status
[14:16:23.233] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:23.233] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:286:0) after 1m0s
[14:17:23.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:286:0)
[14:17:23.272] Timer tick, asking Buildbucket for the build status
[14:17:23.446] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:23.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:287:0) after 1m0s
[14:18:25.193] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:287:0)
[14:18:25.193] Timer tick, asking Buildbucket for the build status
[14:18:25.267] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:25.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:288:0) after 1m0s
[14:19:25.649] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:288:0)
[14:19:25.649] Timer tick, asking Buildbucket for the build status
[14:19:25.743] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:25.743] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:289:0) after 1m0s
[14:20:25.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:289:0)
[14:20:25.844] Timer tick, asking Buildbucket for the build status
[14:20:25.910] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:25.910] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:290:0) after 1m0s
[14:21:26.033] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:290:0)
[14:21:26.033] Timer tick, asking Buildbucket for the build status
[14:21:26.096] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:26.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:291:0) after 1m0s
[14:22:26.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:291:0)
[14:22:26.186] Timer tick, asking Buildbucket for the build status
[14:22:26.427] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:26.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:292:0) after 1m0s
[14:23:26.536] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:292:0)
[14:23:26.536] Timer tick, asking Buildbucket for the build status
[14:23:26.641] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:26.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:293:0) after 1m0s
[14:24:26.646] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:293:0)
[14:24:26.646] Timer tick, asking Buildbucket for the build status
[14:24:26.732] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:26.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:294:0) after 1m0s
[14:25:26.846] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:294:0)
[14:25:26.846] Timer tick, asking Buildbucket for the build status
[14:25:26.922] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:26.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:295:0) after 1m0s
[14:26:27.048] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:295:0)
[14:26:27.048] Timer tick, asking Buildbucket for the build status
[14:26:27.422] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:27.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:296:0) after 1m0s
[14:27:27.423] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:296:0)
[14:27:27.423] Timer tick, asking Buildbucket for the build status
[14:27:27.561] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:27.561] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:297:0) after 1m0s
[14:28:27.641] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:297:0)
[14:28:27.641] Timer tick, asking Buildbucket for the build status
[14:28:27.826] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:27.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:298:0) after 1m0s
[14:29:27.853] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:298:0)
[14:29:27.853] Timer tick, asking Buildbucket for the build status
[14:29:28.021] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:28.021] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:299:0) after 1m0s
[14:30:28.075] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:299:0)
[14:30:28.075] Timer tick, asking Buildbucket for the build status
[14:30:28.196] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:28.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:300:0) after 1m0s
[14:31:28.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:300:0)
[14:31:28.330] Timer tick, asking Buildbucket for the build status
[14:31:28.458] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:28.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:301:0) after 1m0s
[14:32:28.606] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:301:0)
[14:32:28.606] Timer tick, asking Buildbucket for the build status
[14:32:28.731] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:28.731] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:302:0) after 1m0s
[14:33:28.753] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:302:0)
[14:33:28.753] Timer tick, asking Buildbucket for the build status
[14:33:28.830] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:28.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:303:0) after 1m0s
[14:34:28.943] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:303:0)
[14:34:28.943] Timer tick, asking Buildbucket for the build status
[14:34:29.005] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:29.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:304:0) after 1m0s
[14:35:29.097] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:304:0)
[14:35:29.097] Timer tick, asking Buildbucket for the build status
[14:35:29.372] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:29.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:305:0) after 1m0s
[14:36:29.511] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:305:0)
[14:36:29.511] Timer tick, asking Buildbucket for the build status
[14:36:29.618] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:29.618] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:306:0) after 1m0s
[14:37:30.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:306:0)
[14:37:30.405] Timer tick, asking Buildbucket for the build status
[14:37:30.593] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:30.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:307:0) after 1m0s
[14:38:30.650] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:307:0)
[14:38:30.650] Timer tick, asking Buildbucket for the build status
[14:38:30.845] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:30.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:308:0) after 1m0s
[14:39:30.839] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:308:0)
[14:39:30.839] Timer tick, asking Buildbucket for the build status
[14:39:30.893] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:30.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:309:0) after 1m0s
[14:40:30.893] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:309:0)
[14:40:30.893] Timer tick, asking Buildbucket for the build status
[14:40:30.960] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:30.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:310:0) after 1m0s
[14:41:31.003] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:310:0)
[14:41:31.003] Timer tick, asking Buildbucket for the build status
[14:41:31.061] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:31.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:311:0) after 1m0s
[14:42:31.129] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:311:0)
[14:42:31.129] Timer tick, asking Buildbucket for the build status
[14:42:31.379] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:31.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:312:0) after 1m0s
[14:43:31.465] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:312:0)
[14:43:31.465] Timer tick, asking Buildbucket for the build status
[14:43:31.683] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:31.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:313:0) after 1m0s
[14:44:31.705] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:313:0)
[14:44:31.705] Timer tick, asking Buildbucket for the build status
[14:44:32.115] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:32.115] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:314:0) after 1m0s
[14:45:32.395] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:314:0)
[14:45:32.395] Timer tick, asking Buildbucket for the build status
[14:45:32.530] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:32.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:315:0) after 1m0s
[14:46:32.600] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:315:0)
[14:46:32.600] Timer tick, asking Buildbucket for the build status
[14:46:32.750] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:32.750] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:316:0) after 1m0s
[14:47:32.853] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:316:0)
[14:47:32.853] Timer tick, asking Buildbucket for the build status
[14:47:32.996] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:32.996] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:317:0) after 1m0s
[14:48:33.073] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:317:0)
[14:48:33.073] Timer tick, asking Buildbucket for the build status
[14:48:33.190] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:33.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:318:0) after 1m0s
[14:49:33.444] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:318:0)
[14:49:33.444] Timer tick, asking Buildbucket for the build status
[14:49:33.554] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:33.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:319:0) after 1m0s
[14:50:33.797] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:319:0)
[14:50:33.797] Timer tick, asking Buildbucket for the build status
[14:50:33.883] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:33.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:320:0) after 1m0s
[14:51:34.052] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:320:0)
[14:51:34.052] Timer tick, asking Buildbucket for the build status
[14:51:34.436] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:34.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:321:0) after 1m0s
[14:52:34.503] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:321:0)
[14:52:34.503] Timer tick, asking Buildbucket for the build status
[14:52:34.630] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:34.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:322:0) after 1m0s
[14:53:34.752] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:322:0)
[14:53:34.752] Timer tick, asking Buildbucket for the build status
[14:53:34.995] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:34.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:323:0) after 1m0s
[14:54:35.100] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:323:0)
[14:54:35.100] Timer tick, asking Buildbucket for the build status
[14:54:35.340] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:35.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:324:0) after 1m0s
[14:55:35.473] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:324:0)
[14:55:35.473] Timer tick, asking Buildbucket for the build status
[14:55:35.569] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:35.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:325:0) after 1m0s
[14:56:35.697] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:325:0)
[14:56:35.697] Timer tick, asking Buildbucket for the build status
[14:56:35.776] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:35.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:326:0) after 1m0s
[14:57:35.912] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:326:0)
[14:57:35.912] Timer tick, asking Buildbucket for the build status
[14:57:36.044] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:36.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:327:0) after 1m0s
[14:58:36.117] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:327:0)
[14:58:36.117] Timer tick, asking Buildbucket for the build status
[14:58:36.191] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:36.191] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:328:0) after 1m0s
[14:59:36.366] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:328:0)
[14:59:36.367] Timer tick, asking Buildbucket for the build status
[14:59:36.451] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:36.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:329:0) after 1m0s
[15:00:36.643] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:329:0)
[15:00:36.643] Timer tick, asking Buildbucket for the build status
[15:00:36.760] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:36.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:330:0) after 1m0s
[15:01:36.852] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:330:0)
[15:01:36.852] Timer tick, asking Buildbucket for the build status
[15:01:37.063] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:37.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:331:0) after 1m0s
[15:02:37.133] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:331:0)
[15:02:37.133] Timer tick, asking Buildbucket for the build status
[15:02:37.252] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:37.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:332:0) after 1m0s
[15:03:37.322] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:332:0)
[15:03:37.322] Timer tick, asking Buildbucket for the build status
[15:03:37.603] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:37.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:333:0) after 1m0s
[15:04:37.641] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:333:0)
[15:04:37.641] Timer tick, asking Buildbucket for the build status
[15:04:37.730] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:37.730] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:334:0) after 1m0s
[15:05:37.853] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:334:0)
[15:05:37.853] Timer tick, asking Buildbucket for the build status
[15:05:38.119] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:38.119] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:335:0) after 1m0s
[15:06:38.212] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:335:0)
[15:06:38.212] Timer tick, asking Buildbucket for the build status
[15:06:38.307] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:38.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:336:0) after 1m0s
[15:07:38.371] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:336:0)
[15:07:38.371] Timer tick, asking Buildbucket for the build status
[15:07:38.820] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:38.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:337:0) after 1m0s
[15:08:38.900] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:337:0)
[15:08:38.900] Timer tick, asking Buildbucket for the build status
[15:08:38.966] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:38.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:338:0) after 1m0s
[15:09:39.031] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:338:0)
[15:09:39.031] Timer tick, asking Buildbucket for the build status
[15:09:39.199] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:39.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:339:0) after 1m0s
[15:10:39.243] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:339:0)
[15:10:39.243] Timer tick, asking Buildbucket for the build status
[15:10:39.384] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:39.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:340:0) after 1m0s
[15:11:39.465] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:340:0)
[15:11:39.465] Timer tick, asking Buildbucket for the build status
[15:11:39.541] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:39.541] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:341:0) after 1m0s
[15:12:39.632] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:341:0)
[15:12:39.632] Timer tick, asking Buildbucket for the build status
[15:12:39.748] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:39.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:342:0) after 1m0s
[15:13:39.825] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:342:0)
[15:13:39.825] Timer tick, asking Buildbucket for the build status
[15:13:39.928] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:39.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:343:0) after 1m0s
[15:14:41.792] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:343:0)
[15:14:41.792] Timer tick, asking Buildbucket for the build status
[15:14:41.866] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:41.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:344:0) after 1m0s
[15:15:41.880] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:344:0)
[15:15:41.880] Timer tick, asking Buildbucket for the build status
[15:15:41.948] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:41.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:345:0) after 1m0s
[15:16:41.991] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:345:0)
[15:16:41.991] Timer tick, asking Buildbucket for the build status
[15:16:42.127] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:42.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:346:0) after 1m0s
[15:17:42.184] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:346:0)
[15:17:42.184] Timer tick, asking Buildbucket for the build status
[15:17:42.304] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:42.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:347:0) after 1m0s
[15:18:42.384] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:347:0)
[15:18:42.384] Timer tick, asking Buildbucket for the build status
[15:18:42.527] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:42.527] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:348:0) after 1m0s
[15:19:42.591] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:348:0)
[15:19:42.591] Timer tick, asking Buildbucket for the build status
[15:19:42.702] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:42.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:349:0) after 1m0s
[15:20:42.752] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:349:0)
[15:20:42.752] Timer tick, asking Buildbucket for the build status
[15:20:42.991] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:42.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:350:0) after 1m0s
[15:21:42.980] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:350:0)
[15:21:42.980] Timer tick, asking Buildbucket for the build status
[15:21:43.123] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:43.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:351:0) after 1m0s
[15:22:43.190] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:351:0)
[15:22:43.191] Timer tick, asking Buildbucket for the build status
[15:22:43.551] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:43.551] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:352:0) after 1m0s
[15:23:43.592] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:352:0)
[15:23:43.592] Timer tick, asking Buildbucket for the build status
[15:23:43.666] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:43.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:353:0) after 1m0s
[15:24:43.711] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:353:0)
[15:24:43.711] Timer tick, asking Buildbucket for the build status
[15:24:43.791] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:43.791] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:354:0) after 1m0s
[15:25:43.914] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:354:0)
[15:25:43.914] Timer tick, asking Buildbucket for the build status
[15:25:44.094] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:44.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:355:0) after 1m0s
[15:26:44.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:355:0)
[15:26:44.156] Timer tick, asking Buildbucket for the build status
[15:26:44.229] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:44.229] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:356:0) after 1m0s
[15:27:44.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:356:0)
[15:27:44.251] Timer tick, asking Buildbucket for the build status
[15:27:44.434] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:44.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:357:0) after 1m0s
[15:28:44.533] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:357:0)
[15:28:44.533] Timer tick, asking Buildbucket for the build status
[15:28:44.604] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:44.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:358:0) after 1m0s
[15:29:44.714] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:358:0)
[15:29:44.714] Timer tick, asking Buildbucket for the build status
[15:29:44.813] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:44.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:359:0) after 1m0s
[15:30:44.890] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:359:0)
[15:30:44.890] Timer tick, asking Buildbucket for the build status
[15:30:45.078] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:45.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:360:0) after 1m0s
[15:31:45.141] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:360:0)
[15:31:45.141] Timer tick, asking Buildbucket for the build status
[15:31:45.317] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:45.317] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:361:0) after 1m0s
[15:32:45.414] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:361:0)
[15:32:45.414] Timer tick, asking Buildbucket for the build status
[15:32:45.565] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:45.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:362:0) after 1m0s
[15:33:45.701] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:362:0)
[15:33:45.701] Timer tick, asking Buildbucket for the build status
[15:33:45.889] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:45.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:363:0) after 1m0s
[15:34:46.000] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:363:0)
[15:34:46.000] Timer tick, asking Buildbucket for the build status
[15:34:46.078] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:46.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:364:0) after 1m0s
[15:35:46.150] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:364:0)
[15:35:46.150] Timer tick, asking Buildbucket for the build status
[15:35:46.222] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:46.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:365:0) after 1m0s
[15:36:46.255] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:365:0)
[15:36:46.255] Timer tick, asking Buildbucket for the build status
[15:36:46.334] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:46.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:366:0) after 1m0s
[15:37:46.417] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:366:0)
[15:37:46.417] Timer tick, asking Buildbucket for the build status
[15:37:46.532] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:46.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:367:0) after 1m0s
[15:38:46.603] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:367:0)
[15:38:46.603] Timer tick, asking Buildbucket for the build status
[15:38:46.685] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:46.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:368:0) after 1m0s
[15:39:46.746] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:368:0)
[15:39:46.746] Timer tick, asking Buildbucket for the build status
[15:39:46.925] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:46.925] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:369:0) after 1m0s
[15:40:47.124] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:369:0)
[15:40:47.124] Timer tick, asking Buildbucket for the build status
[15:40:47.364] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:47.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:370:0) after 1m0s
[15:41:47.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:370:0)
[15:41:47.494] Timer tick, asking Buildbucket for the build status
[15:41:47.720] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:47.720] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:371:0) after 1m0s
[15:42:47.908] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:371:0)
[15:42:47.908] Timer tick, asking Buildbucket for the build status
[15:42:48.512] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:48.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:372:0) after 1m0s
[15:43:48.613] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:372:0)
[15:43:48.613] Timer tick, asking Buildbucket for the build status
[15:43:48.688] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:48.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:373:0) after 1m0s
[15:44:48.774] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:373:0)
[15:44:48.774] Timer tick, asking Buildbucket for the build status
[15:44:48.858] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:48.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:374:0) after 1m0s
[15:45:49.068] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:374:0)
[15:45:49.068] Timer tick, asking Buildbucket for the build status
[15:45:49.222] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:49.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:375:0) after 1m0s
[15:46:49.343] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:375:0)
[15:46:49.343] Timer tick, asking Buildbucket for the build status
[15:46:49.518] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:49.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:376:0) after 1m0s
[15:47:49.559] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:376:0)
[15:47:49.559] Timer tick, asking Buildbucket for the build status
[15:47:49.675] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:49.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:377:0) after 1m0s
[15:48:49.713] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:377:0)
[15:48:49.713] Timer tick, asking Buildbucket for the build status
[15:48:49.782] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:49.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:378:0) after 1m0s
[15:49:49.868] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:378:0)
[15:49:49.868] Timer tick, asking Buildbucket for the build status
[15:49:50.246] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:50.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:379:0) after 1m0s
[15:50:50.357] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:379:0)
[15:50:50.357] Timer tick, asking Buildbucket for the build status
[15:50:50.434] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:50.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:380:0) after 1m0s
[15:51:50.576] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:380:0)
[15:51:50.576] Timer tick, asking Buildbucket for the build status
[15:51:50.728] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:50.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:381:0) after 1m0s
[15:52:50.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:381:0)
[15:52:50.844] Timer tick, asking Buildbucket for the build status
[15:52:51.221] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:51.221] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:382:0) after 1m0s
[15:53:51.351] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:382:0)
[15:53:51.351] Timer tick, asking Buildbucket for the build status
[15:53:52.126] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:52.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:383:0) after 1m0s
[15:54:52.291] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:383:0)
[15:54:52.292] Timer tick, asking Buildbucket for the build status
[15:54:52.364] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:52.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:384:0) after 1m0s
[15:55:52.472] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:384:0)
[15:55:52.472] Timer tick, asking Buildbucket for the build status
[15:55:53.137] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:53.137] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:385:0) after 1m0s
[15:56:53.260] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:385:0)
[15:56:53.260] Timer tick, asking Buildbucket for the build status
[15:56:53.335] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:53.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:386:0) after 1m0s
[15:57:53.476] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:386:0)
[15:57:53.476] Timer tick, asking Buildbucket for the build status
[15:57:53.580] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:53.580] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:387:0) after 1m0s
[15:58:53.635] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:387:0)
[15:58:53.635] Timer tick, asking Buildbucket for the build status
[15:58:53.713] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:53.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:388:0) after 1m0s
[15:59:53.801] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:388:0)
[15:59:53.802] Timer tick, asking Buildbucket for the build status
[15:59:53.898] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:53.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:389:0) after 1m0s
[16:00:53.962] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:389:0)
[16:00:53.962] Timer tick, asking Buildbucket for the build status
[16:00:54.276] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:54.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:390:0) after 1m0s
[16:01:54.430] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:390:0)
[16:01:54.430] Timer tick, asking Buildbucket for the build status
[16:01:54.493] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:54.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:391:0) after 1m0s
[16:02:54.574] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:391:0)
[16:02:54.574] Timer tick, asking Buildbucket for the build status
[16:02:55.272] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:55.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:392:0) after 1m0s
[16:03:55.390] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:392:0)
[16:03:55.390] Timer tick, asking Buildbucket for the build status
[16:03:55.471] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:55.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:393:0) after 1m0s
[16:04:55.670] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:393:0)
[16:04:55.670] Timer tick, asking Buildbucket for the build status
[16:04:55.753] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:55.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:394:0) after 1m0s
[16:05:55.860] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:394:0)
[16:05:55.860] Timer tick, asking Buildbucket for the build status
[16:05:55.941] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:55.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:395:0) after 1m0s
[16:06:55.997] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:395:0)
[16:06:55.997] Timer tick, asking Buildbucket for the build status
[16:06:56.356] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:56.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:396:0) after 1m0s
[16:07:56.463] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:396:0)
[16:07:56.463] Timer tick, asking Buildbucket for the build status
[16:07:56.696] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:56.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:397:0) after 1m0s
[16:08:56.758] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:397:0)
[16:08:56.758] Timer tick, asking Buildbucket for the build status
[16:08:56.818] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:56.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:398:0) after 1m0s
[16:09:56.874] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:398:0)
[16:09:56.874] Timer tick, asking Buildbucket for the build status
[16:09:57.302] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:57.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:399:0) after 1m0s
[16:10:57.432] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:399:0)
[16:10:57.432] Timer tick, asking Buildbucket for the build status
[16:10:57.716] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:57.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:400:0) after 1m0s
[16:11:57.804] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:400:0)
[16:11:57.804] Timer tick, asking Buildbucket for the build status
[16:11:58.995] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:58.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:401:0) after 1m0s
[16:12:59.077] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:401:0)
[16:12:59.077] Timer tick, asking Buildbucket for the build status
[16:12:59.384] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:59.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:402:0) after 1m0s
[16:13:59.501] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:402:0)
[16:13:59.501] Timer tick, asking Buildbucket for the build status
[16:13:59.598] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:59.598] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:403:0) after 1m0s
[16:14:59.635] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:403:0)
[16:14:59.635] Timer tick, asking Buildbucket for the build status
[16:14:59.705] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:59.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:404:0) after 1m0s
[16:15:59.773] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:404:0)
[16:15:59.773] Timer tick, asking Buildbucket for the build status
[16:15:59.849] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:59.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:405:0) after 1m0s
[16:16:59.910] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:405:0)
[16:16:59.910] Timer tick, asking Buildbucket for the build status
[16:16:59.974] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:59.974] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:406:0) after 1m0s
[16:18:00.160] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:406:0)
[16:18:00.160] Timer tick, asking Buildbucket for the build status
[16:18:00.310] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:00.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:407:0) after 1m0s
[16:19:00.337] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:407:0)
[16:19:00.337] Timer tick, asking Buildbucket for the build status
[16:19:00.397] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:00.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:408:0) after 1m0s
[16:20:00.543] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:408:0)
[16:20:00.543] Timer tick, asking Buildbucket for the build status
[16:20:01.010] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:01.010] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:409:0) after 1m0s
[16:21:01.107] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:409:0)
[16:21:01.107] Timer tick, asking Buildbucket for the build status
[16:21:01.195] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:01.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:410:0) after 1m0s
[16:22:01.283] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:410:0)
[16:22:01.283] Timer tick, asking Buildbucket for the build status
[16:22:01.364] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:01.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:411:0) after 1m0s
[16:23:01.439] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:411:0)
[16:23:01.439] Timer tick, asking Buildbucket for the build status
[16:23:01.578] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:01.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:412:0) after 1m0s
[16:24:01.661] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:412:0)
[16:24:01.661] Timer tick, asking Buildbucket for the build status
[16:24:01.830] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:01.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:413:0) after 1m0s
[16:25:01.962] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:413:0)
[16:25:01.962] Timer tick, asking Buildbucket for the build status
[16:25:02.105] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:02.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:414:0) after 1m0s
[16:26:02.214] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:414:0)
[16:26:02.214] Timer tick, asking Buildbucket for the build status
[16:26:02.357] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:02.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:415:0) after 1m0s
[16:27:02.447] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:415:0)
[16:27:02.447] Timer tick, asking Buildbucket for the build status
[16:27:02.594] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:02.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:416:0) after 1m0s
[16:28:02.647] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:416:0)
[16:28:02.648] Timer tick, asking Buildbucket for the build status
[16:28:02.768] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:02.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:417:0) after 1m0s
[16:29:02.835] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:417:0)
[16:29:02.835] Timer tick, asking Buildbucket for the build status
[16:29:03.325] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:03.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:418:0) after 1m0s
[16:30:03.461] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:418:0)
[16:30:03.461] Timer tick, asking Buildbucket for the build status
[16:30:03.550] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:03.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:419:0) after 1m0s
[16:31:03.686] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:419:0)
[16:31:03.686] Timer tick, asking Buildbucket for the build status
[16:31:03.751] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:03.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:420:0) after 1m0s
[16:32:03.979] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:420:0)
[16:32:03.979] Timer tick, asking Buildbucket for the build status
[16:32:04.075] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:04.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:421:0) after 1m0s
[16:33:05.511] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:421:0)
[16:33:05.511] Timer tick, asking Buildbucket for the build status
[16:33:05.730] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:05.730] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:422:0) after 1m0s
[16:34:05.740] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:422:0)
[16:34:05.740] Timer tick, asking Buildbucket for the build status
[16:34:05.806] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:05.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:423:0) after 1m0s
[16:35:05.838] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:423:0)
[16:35:05.838] Timer tick, asking Buildbucket for the build status
[16:35:05.946] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:05.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:424:0) after 1m0s
[16:36:05.980] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:424:0)
[16:36:05.980] Timer tick, asking Buildbucket for the build status
[16:36:06.498] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:06.498] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:425:0) after 1m0s
[16:37:06.536] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:425:0)
[16:37:06.536] Timer tick, asking Buildbucket for the build status
[16:37:06.599] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:06.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:426:0) after 1m0s
[16:38:06.736] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:426:0)
[16:38:06.736] Timer tick, asking Buildbucket for the build status
[16:38:07.104] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:07.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:427:0) after 1m0s
[16:39:07.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:427:0)
[16:39:07.405] Timer tick, asking Buildbucket for the build status
[16:39:07.501] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:07.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:428:0) after 1m0s
[16:40:08.088] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:428:0)
[16:40:08.088] Timer tick, asking Buildbucket for the build status
[16:40:08.607] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:08.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:429:0) after 1m0s
[16:41:09.096] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:429:0)
[16:41:09.096] Timer tick, asking Buildbucket for the build status
[16:41:09.267] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:09.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:430:0) after 1m0s
--- the log has been cut here ---
[19:56:03.204] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:03.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:624:0) after 1m0s
[19:57:03.213] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:624:0)
[19:57:03.213] Timer tick, asking Buildbucket for the build status
[19:57:03.406] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:03.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:625:0) after 1m0s
[19:58:03.444] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:625:0)
[19:58:03.444] Timer tick, asking Buildbucket for the build status
[19:58:03.565] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:03.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:626:0) after 1m0s
[19:59:03.588] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:626:0)
[19:59:03.588] Timer tick, asking Buildbucket for the build status
[19:59:03.665] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:03.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:627:0) after 1m0s
[20:00:03.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:627:0)
[20:00:03.738] Timer tick, asking Buildbucket for the build status
[20:00:03.979] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:03.979] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:628:0) after 1m0s
[20:01:04.089] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:628:0)
[20:01:04.089] Timer tick, asking Buildbucket for the build status
[20:01:04.221] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:04.221] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:629:0) after 1m0s
[20:02:04.318] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:629:0)
[20:02:04.318] Timer tick, asking Buildbucket for the build status
[20:02:04.429] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:04.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:630:0) after 1m0s
[20:03:04.515] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:630:0)
[20:03:04.515] Timer tick, asking Buildbucket for the build status
[20:03:04.658] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:04.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:631:0) after 1m0s
[20:04:04.746] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:631:0)
[20:04:04.746] Timer tick, asking Buildbucket for the build status
[20:04:04.883] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:04.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:632:0) after 1m0s
[20:05:04.901] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:632:0)
[20:05:04.901] Timer tick, asking Buildbucket for the build status
[20:05:05.009] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:05.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:633:0) after 1m0s
[20:06:05.061] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:633:0)
[20:06:05.061] Timer tick, asking Buildbucket for the build status
[20:06:05.184] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:05.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:634:0) after 1m0s
[20:07:05.226] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:634:0)
[20:07:05.226] Timer tick, asking Buildbucket for the build status
[20:07:05.522] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:05.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:635:0) after 1m0s
[20:08:05.594] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:635:0)
[20:08:05.594] Timer tick, asking Buildbucket for the build status
[20:08:06.371] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:06.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:636:0) after 1m0s
[20:09:06.451] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:636:0)
[20:09:06.451] Timer tick, asking Buildbucket for the build status
[20:09:06.599] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:06.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:637:0) after 1m0s
[20:10:06.679] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:637:0)
[20:10:06.679] Timer tick, asking Buildbucket for the build status
[20:10:06.831] Build 8858049078199488224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:06.831] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9023479140566308144:638:0) after 1m0s
[20:10:39.959] Received PubSub notification, asking Buildbucket for the build status
[20:10:40.151] Build 8858049078199488224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:10:40.151] Buildbucket build:
{
"build": {
"bucket": "luci.nacl.ci",
"canary_preference": "PROD",
"completed_ts": "1610741439338238",
"created_by": "project:nacl",
"created_ts": "1610703122863311",
"id": "8858049078199488224",
"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\": \"cb31feffa500401c95c6c44d88b7c358236bca36\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@cb31feffa500401c95c6c44d88b7c358236bca36\", \"title\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/cb31feffa500401c95c6c44d88b7c358236bca36\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\"}}",
"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\": \"cb31feffa500401c95c6c44d88b7c358236bca36\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@cb31feffa500401c95c6c44d88b7c358236bca36\", \"title\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/cb31feffa500401c95c6c44d88b7c358236bca36\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-flex-ci-xenial-6-08fy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.nacl\", \"buildername\": \"linux-64-validator-opt\", \"buildnumber\": 158, \"got_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0e6ebad26b9e32a509ae96418948ac3b5176ae2e1b3e5b45f3f012a04921fe7b_v2\", \"builder_1e6d0abe69a68a2aa6dacdd88a423d501535e2ffcca7b599f74b31063cfa633e_v2\", \"builder_5933f35f60c9cfd4ea3825b861e1da6026fb207afa6984d1676a69bf7e72d4fa_v2\", \"builder_a20b1ade66d3cd92c501ea59e0fa76fddd60e1587b9432210d1936953c00db76_v2\", \"git\", \"gocache\", \"goma_v2\", \"gopath\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-flex-ci-xenial-6-08fy\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.flex.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610704045885334",
"status": "COMPLETED",
"status_changed_ts": "1610741439659087",
"tags": [
"build_address:luci.nacl.ci/linux-64-validator-opt/158",
"builder:linux-64-validator-opt",
"buildset:commit/git/cb31feffa500401c95c6c44d88b7c358236bca36",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/cb31feffa500401c95c6c44d88b7c358236bca36",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023479140566308144",
"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/8858049078199488224/+/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:511e34c2807ebe10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610741439669414",
"url": "https://ci.chromium.org/b/8858049078199488224",
"utcnow_ts": "1610741440098386"
}
}
[20:10:40.151] Invocation finished in 10h38m38.929272793s with status SUCCEEDED