[00:22:42.193] New invocation is queued and will start shortly
[00:22:43.484] Starting the invocation (attempt 1)
[00:22:43.528] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:22:43.528] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:22:43.528] Buildbucket request:
{
"bucket": "luci.nacl.ci",
"client_operation_id": "9092548589028403632",
"parameters_json": "{\"builder_name\":\"linux-64-validator-opt\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"af5947d13e6794eac489365ff58fd45c0dd4ca2a\"}}",
"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:9092548589028403632",
"scheduler_job_id:nacl/linux-64-validator-opt",
"user_agent:luci-scheduler",
"buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"gitiles_ref:refs/heads/master"
]
}
[00:22:44.828] Buildbucket response:
{
"build": {
"bucket": "luci.nacl.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1544833363607219",
"id": "8927118526880904544",
"lease_expiration_ts": "1544984564490363",
"lease_key": "103958956",
"parameters_json": "{\"builder_name\": \"linux-64-validator-opt\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"af5947d13e6794eac489365ff58fd45c0dd4ca2a\"}}",
"project": "nacl",
"result_details_json": "null",
"service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1544833364704077",
"tags": [
"build_address:luci.nacl.ci/linux-64-validator-opt/87",
"builder:linux-64-validator-opt",
"buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9092548589028403632",
"scheduler_job_id:nacl/linux-64-validator-opt",
"swarming_dimension:caches:builder_ec3024801e8fae9a0c90cf0b91bc8fd309d619937749998ead917e6c37a3a5b5_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.flex.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.nacl.ci/linux-64-validator-opt/87",
"swarming_tag:buildbucket_bucket:nacl/ci",
"swarming_tag:buildbucket_build_id:8927118526880904544",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
"swarming_tag:builder:linux-64-validator-opt",
"swarming_tag:buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"swarming_tag:caches:builder_ec3024801e8fae9a0c90cf0b91bc8fd309d619937749998ead917e6c37a3a5b5_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8927118526880904544/+/annotations",
"swarming_tag:luci_project:nacl",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.flex.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:nacl",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9092548589028403632",
"swarming_tag:scheduler_job_id:nacl/linux-64-validator-opt",
"swarming_tag:service_account:nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:ee62e96c73f38e03db7f2d5dd18fea50e0f44727",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41c80ff9361bc810",
"user_agent:luci-scheduler"
],
"updated_ts": "1544833364704162",
"url": "https://ci.chromium.org/b/8927118526880904544",
"utcnow_ts": "1544833364813932"
}
}
[00:22:44.828] Task URL: https://ci.chromium.org/b/8927118526880904544
[00:22:44.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:2:0) after 1m0s
[00:23:28.650] Received PubSub notification, asking Buildbucket for the build status
[00:23:28.838] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:44.851] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:2:0)
[00:23:44.851] Timer tick, asking Buildbucket for the build status
[00:23:44.992] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:44.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:4:0) after 1m0s
[00:24:45.007] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:4:0)
[00:24:45.007] Timer tick, asking Buildbucket for the build status
[00:24:45.238] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:45.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:5:0) after 1m0s
[00:25:45.265] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:5:0)
[00:25:45.265] Timer tick, asking Buildbucket for the build status
[00:25:45.314] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:45.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:6:0) after 1m0s
[00:26:45.371] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:6:0)
[00:26:45.371] Timer tick, asking Buildbucket for the build status
[00:26:45.461] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:45.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:7:0) after 1m0s
[00:27:45.484] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:7:0)
[00:27:45.484] Timer tick, asking Buildbucket for the build status
[00:27:45.693] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:45.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:8:0) after 1m0s
[00:28:45.710] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:8:0)
[00:28:45.710] Timer tick, asking Buildbucket for the build status
[00:28:45.960] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:45.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:9:0) after 1m0s
[00:29:45.979] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:9:0)
[00:29:45.979] Timer tick, asking Buildbucket for the build status
[00:29:46.058] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:46.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:10:0) after 1m0s
[00:30:46.080] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:10:0)
[00:30:46.080] Timer tick, asking Buildbucket for the build status
[00:30:46.214] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:46.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:11:0) after 1m0s
[00:31:46.246] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:11:0)
[00:31:46.246] Timer tick, asking Buildbucket for the build status
[00:31:46.342] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:46.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:12:0) after 1m0s
[00:32:46.364] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:12:0)
[00:32:46.364] Timer tick, asking Buildbucket for the build status
[00:32:46.477] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:46.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:13:0) after 1m0s
[00:33:46.510] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:13:0)
[00:33:46.510] Timer tick, asking Buildbucket for the build status
[00:33:46.621] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:46.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:14:0) after 1m0s
[00:34:46.638] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:14:0)
[00:34:46.638] Timer tick, asking Buildbucket for the build status
[00:34:46.947] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:46.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:15:0) after 1m0s
[00:35:46.980] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:15:0)
[00:35:46.980] Timer tick, asking Buildbucket for the build status
[00:35:47.054] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:47.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:16:0) after 1m0s
[00:36:47.099] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:16:0)
[00:36:47.099] Timer tick, asking Buildbucket for the build status
[00:36:47.201] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:47.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:17:0) after 1m0s
[00:37:47.252] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:17:0)
[00:37:47.252] Timer tick, asking Buildbucket for the build status
[00:37:47.308] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:47.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:18:0) after 1m0s
[00:38:47.326] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:18:0)
[00:38:47.326] Timer tick, asking Buildbucket for the build status
[00:38:47.435] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:47.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:19:0) after 1m0s
[00:39:47.469] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:19:0)
[00:39:47.469] Timer tick, asking Buildbucket for the build status
[00:39:47.613] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:47.613] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:20:0) after 1m0s
[00:40:47.633] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:20:0)
[00:40:47.633] Timer tick, asking Buildbucket for the build status
[00:40:47.771] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:47.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:21:0) after 1m0s
[00:41:47.805] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:21:0)
[00:41:47.805] Timer tick, asking Buildbucket for the build status
[00:41:47.951] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:47.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:22:0) after 1m0s
[00:42:47.977] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:22:0)
[00:42:47.977] Timer tick, asking Buildbucket for the build status
[00:42:48.029] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:48.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:23:0) after 1m0s
[00:43:48.087] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:23:0)
[00:43:48.087] Timer tick, asking Buildbucket for the build status
[00:43:48.223] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:48.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:24:0) after 1m0s
[00:44:48.244] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:24:0)
[00:44:48.244] Timer tick, asking Buildbucket for the build status
[00:44:48.289] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:48.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:25:0) after 1m0s
[00:45:48.311] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:25:0)
[00:45:48.311] Timer tick, asking Buildbucket for the build status
[00:45:48.495] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:48.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:26:0) after 1m0s
[00:46:48.514] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:26:0)
[00:46:48.514] Timer tick, asking Buildbucket for the build status
[00:46:48.636] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:48.636] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:27:0) after 1m0s
[00:47:48.655] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:27:0)
[00:47:48.655] Timer tick, asking Buildbucket for the build status
[00:47:48.729] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:48.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:28:0) after 1m0s
[00:48:48.749] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:28:0)
[00:48:48.749] Timer tick, asking Buildbucket for the build status
[00:48:48.897] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:48.897] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:29:0) after 1m0s
[00:49:48.916] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:29:0)
[00:49:48.916] Timer tick, asking Buildbucket for the build status
[00:49:48.987] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:48.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:30:0) after 1m0s
[00:50:49.005] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:30:0)
[00:50:49.005] Timer tick, asking Buildbucket for the build status
[00:50:49.242] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:49.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:31:0) after 1m0s
[00:51:49.280] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:31:0)
[00:51:49.280] Timer tick, asking Buildbucket for the build status
[00:51:49.323] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:49.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:32:0) after 1m0s
[00:52:49.369] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:32:0)
[00:52:49.369] Timer tick, asking Buildbucket for the build status
[00:52:49.530] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:49.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:33:0) after 1m0s
[00:53:49.595] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:33:0)
[00:53:49.596] Timer tick, asking Buildbucket for the build status
[00:53:49.762] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:49.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:34:0) after 1m0s
[00:54:49.782] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:34:0)
[00:54:49.782] Timer tick, asking Buildbucket for the build status
[00:54:49.874] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:49.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:35:0) after 1m0s
[00:55:49.900] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:35:0)
[00:55:49.900] Timer tick, asking Buildbucket for the build status
[00:55:49.958] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:49.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:36:0) after 1m0s
[00:56:49.983] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:36:0)
[00:56:49.983] Timer tick, asking Buildbucket for the build status
[00:56:50.046] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:50.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:37:0) after 1m0s
[00:57:50.071] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:37:0)
[00:57:50.071] Timer tick, asking Buildbucket for the build status
[00:57:50.345] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:50.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:38:0) after 1m0s
[00:58:50.365] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:38:0)
[00:58:50.365] Timer tick, asking Buildbucket for the build status
[00:58:50.408] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:50.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:39:0) after 1m0s
[00:59:50.427] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:39:0)
[00:59:50.427] Timer tick, asking Buildbucket for the build status
[00:59:50.481] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:50.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:40:0) after 1m0s
[01:00:50.499] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:40:0)
[01:00:50.499] Timer tick, asking Buildbucket for the build status
[01:00:50.576] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:50.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:41:0) after 1m0s
[01:01:50.595] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:41:0)
[01:01:50.595] Timer tick, asking Buildbucket for the build status
[01:01:50.705] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:50.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:42:0) after 1m0s
[01:02:50.726] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:42:0)
[01:02:50.726] Timer tick, asking Buildbucket for the build status
[01:02:50.810] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:50.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:43:0) after 1m0s
[01:03:50.835] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:43:0)
[01:03:50.835] Timer tick, asking Buildbucket for the build status
[01:03:51.036] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:51.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:44:0) after 1m0s
[01:04:51.054] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:44:0)
[01:04:51.054] Timer tick, asking Buildbucket for the build status
[01:04:51.238] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:51.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:45:0) after 1m0s
[01:05:51.256] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:45:0)
[01:05:51.256] Timer tick, asking Buildbucket for the build status
[01:05:51.356] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:51.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:46:0) after 1m0s
[01:06:51.379] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:46:0)
[01:06:51.379] Timer tick, asking Buildbucket for the build status
[01:06:51.462] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:51.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:47:0) after 1m0s
[01:07:51.481] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:47:0)
[01:07:51.481] Timer tick, asking Buildbucket for the build status
[01:07:51.539] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:51.539] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:48:0) after 1m0s
[01:08:51.561] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:48:0)
[01:08:51.561] Timer tick, asking Buildbucket for the build status
[01:08:51.659] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:51.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:49:0) after 1m0s
[01:09:51.682] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:49:0)
[01:09:51.682] Timer tick, asking Buildbucket for the build status
[01:09:51.835] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:51.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:50:0) after 1m0s
[01:10:51.854] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:50:0)
[01:10:51.854] Timer tick, asking Buildbucket for the build status
[01:10:51.902] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:51.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:51:0) after 1m0s
[01:11:51.927] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:51:0)
[01:11:51.927] Timer tick, asking Buildbucket for the build status
[01:11:52.014] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:52.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:52:0) after 1m0s
[01:12:52.033] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:52:0)
[01:12:52.033] Timer tick, asking Buildbucket for the build status
[01:12:52.154] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:52.154] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:53:0) after 1m0s
[01:13:52.176] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:53:0)
[01:13:52.176] Timer tick, asking Buildbucket for the build status
[01:13:52.241] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:52.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:54:0) after 1m0s
[01:14:52.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:54:0)
[01:14:52.272] Timer tick, asking Buildbucket for the build status
[01:14:52.386] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:52.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:55:0) after 1m0s
[01:15:52.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:55:0)
[01:15:52.405] Timer tick, asking Buildbucket for the build status
[01:15:52.553] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:52.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:56:0) after 1m0s
[01:16:52.573] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:56:0)
[01:16:52.573] Timer tick, asking Buildbucket for the build status
[01:16:52.642] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:52.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:57:0) after 1m0s
[01:17:52.676] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:57:0)
[01:17:52.676] Timer tick, asking Buildbucket for the build status
[01:17:52.749] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:52.749] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:58:0) after 1m0s
[01:18:52.769] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:58:0)
[01:18:52.769] Timer tick, asking Buildbucket for the build status
[01:18:52.930] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:52.930] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:59:0) after 1m0s
[01:19:52.949] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:59:0)
[01:19:52.949] Timer tick, asking Buildbucket for the build status
[01:19:53.004] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:53.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:60:0) after 1m0s
[01:20:53.026] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:60:0)
[01:20:53.026] Timer tick, asking Buildbucket for the build status
[01:20:53.212] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:53.212] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:61:0) after 1m0s
[01:21:53.232] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:61:0)
[01:21:53.232] Timer tick, asking Buildbucket for the build status
[01:21:53.452] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:53.452] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:62:0) after 1m0s
[01:22:53.471] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:62:0)
[01:22:53.471] Timer tick, asking Buildbucket for the build status
[01:22:53.559] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:53.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:63:0) after 1m0s
[01:23:53.583] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:63:0)
[01:23:53.583] Timer tick, asking Buildbucket for the build status
[01:23:53.735] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:53.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:64:0) after 1m0s
[01:24:53.755] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:64:0)
[01:24:53.755] Timer tick, asking Buildbucket for the build status
[01:24:53.853] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:53.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:65:0) after 1m0s
[01:25:53.923] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:65:0)
[01:25:53.923] Timer tick, asking Buildbucket for the build status
[01:25:53.976] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:53.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:66:0) after 1m0s
[01:26:54.000] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:66:0)
[01:26:54.000] Timer tick, asking Buildbucket for the build status
[01:26:54.051] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:54.051] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:67:0) after 1m0s
[01:27:54.081] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:67:0)
[01:27:54.081] Timer tick, asking Buildbucket for the build status
[01:27:54.202] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:54.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:68:0) after 1m0s
[01:28:54.224] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:68:0)
[01:28:54.224] Timer tick, asking Buildbucket for the build status
[01:28:54.341] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:54.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:69:0) after 1m0s
[01:29:54.363] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:69:0)
[01:29:54.363] Timer tick, asking Buildbucket for the build status
[01:29:54.439] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:54.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:70:0) after 1m0s
[01:30:54.458] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:70:0)
[01:30:54.458] Timer tick, asking Buildbucket for the build status
[01:30:54.521] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:54.521] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:71:0) after 1m0s
[01:31:54.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:71:0)
[01:31:54.544] Timer tick, asking Buildbucket for the build status
[01:31:54.644] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:54.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:72:0) after 1m0s
[01:32:54.671] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:72:0)
[01:32:54.671] Timer tick, asking Buildbucket for the build status
[01:32:54.733] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:54.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:73:0) after 1m0s
[01:33:54.766] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:73:0)
[01:33:54.766] Timer tick, asking Buildbucket for the build status
[01:33:54.956] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:54.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:74:0) after 1m0s
[01:34:54.985] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:74:0)
[01:34:54.985] Timer tick, asking Buildbucket for the build status
[01:34:55.282] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:55.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:75:0) after 1m0s
[01:35:55.302] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:75:0)
[01:35:55.302] Timer tick, asking Buildbucket for the build status
[01:35:55.352] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:55.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:76:0) after 1m0s
[01:36:55.430] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:76:0)
[01:36:55.430] Timer tick, asking Buildbucket for the build status
[01:36:55.618] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:55.618] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:77:0) after 1m0s
[01:37:55.665] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:77:0)
[01:37:55.665] Timer tick, asking Buildbucket for the build status
[01:37:55.716] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:55.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:78:0) after 1m0s
[01:38:55.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:78:0)
[01:38:55.745] Timer tick, asking Buildbucket for the build status
[01:38:56.048] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:56.048] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:79:0) after 1m0s
[01:39:56.092] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:79:0)
[01:39:56.092] Timer tick, asking Buildbucket for the build status
[01:39:56.233] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:56.233] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:80:0) after 1m0s
[01:40:56.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:80:0)
[01:40:56.251] Timer tick, asking Buildbucket for the build status
[01:40:56.305] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:56.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:81:0) after 1m0s
[01:41:56.325] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:81:0)
[01:41:56.325] Timer tick, asking Buildbucket for the build status
[01:41:57.789] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:57.789] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:82:0) after 1m0s
[01:42:57.898] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:82:0)
[01:42:57.898] Timer tick, asking Buildbucket for the build status
[01:42:57.965] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:57.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:83:0) after 1m0s
[01:43:57.984] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:83:0)
[01:43:57.984] Timer tick, asking Buildbucket for the build status
[01:43:58.220] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:58.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:84:0) after 1m0s
[01:44:58.257] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:84:0)
[01:44:58.257] Timer tick, asking Buildbucket for the build status
[01:44:58.343] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:58.343] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:85:0) after 1m0s
[01:45:58.363] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:85:0)
[01:45:58.363] Timer tick, asking Buildbucket for the build status
[01:45:58.559] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:58.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:86:0) after 1m0s
[01:46:58.619] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:86:0)
[01:46:58.619] Timer tick, asking Buildbucket for the build status
[01:46:58.672] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:58.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:87:0) after 1m0s
[01:47:58.692] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:87:0)
[01:47:58.692] Timer tick, asking Buildbucket for the build status
[01:47:58.738] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:58.738] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:88:0) after 1m0s
[01:48:58.759] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:88:0)
[01:48:58.759] Timer tick, asking Buildbucket for the build status
[01:48:58.972] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:58.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:89:0) after 1m0s
[01:49:58.992] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:89:0)
[01:49:58.992] Timer tick, asking Buildbucket for the build status
[01:49:59.236] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:59.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:90:0) after 1m0s
[01:50:59.257] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:90:0)
[01:50:59.257] Timer tick, asking Buildbucket for the build status
[01:50:59.518] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:59.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:91:0) after 1m0s
[01:51:59.539] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:91:0)
[01:51:59.539] Timer tick, asking Buildbucket for the build status
[01:51:59.747] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:59.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:92:0) after 1m0s
[01:52:59.766] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:92:0)
[01:52:59.766] Timer tick, asking Buildbucket for the build status
[01:52:59.818] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:59.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:93:0) after 1m0s
[01:53:59.841] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:93:0)
[01:53:59.841] Timer tick, asking Buildbucket for the build status
[01:53:59.936] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:59.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:94:0) after 1m0s
[01:54:59.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:94:0)
[01:54:59.960] Timer tick, asking Buildbucket for the build status
[01:55:00.026] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:00.026] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:95:0) after 1m0s
[01:56:00.048] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:95:0)
[01:56:00.048] Timer tick, asking Buildbucket for the build status
[01:56:00.255] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:00.255] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:96:0) after 1m0s
[01:57:00.279] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:96:0)
[01:57:00.279] Timer tick, asking Buildbucket for the build status
[01:57:00.328] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:00.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:97:0) after 1m0s
[01:58:00.352] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:97:0)
[01:58:00.352] Timer tick, asking Buildbucket for the build status
[01:58:00.644] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:00.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:98:0) after 1m0s
[01:59:00.680] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:98:0)
[01:59:00.680] Timer tick, asking Buildbucket for the build status
[01:59:00.758] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:00.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:99:0) after 1m0s
[02:00:00.789] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:99:0)
[02:00:00.789] Timer tick, asking Buildbucket for the build status
[02:00:00.856] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:00.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:100:0) after 1m0s
[02:01:00.884] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:100:0)
[02:01:00.884] Timer tick, asking Buildbucket for the build status
[02:01:01.052] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:01.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:101:0) after 1m0s
[02:02:01.187] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:101:0)
[02:02:01.187] Timer tick, asking Buildbucket for the build status
[02:02:01.522] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:01.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:102:0) after 1m0s
[02:03:01.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:102:0)
[02:03:01.544] Timer tick, asking Buildbucket for the build status
[02:03:01.917] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:01.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:103:0) after 1m0s
[02:04:01.984] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:103:0)
[02:04:01.984] Timer tick, asking Buildbucket for the build status
[02:04:02.146] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:02.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:104:0) after 1m0s
[02:05:02.295] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:104:0)
[02:05:02.295] Timer tick, asking Buildbucket for the build status
[02:05:02.402] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:02.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:105:0) after 1m0s
[02:06:02.455] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:105:0)
[02:06:02.455] Timer tick, asking Buildbucket for the build status
[02:06:02.519] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:02.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:106:0) after 1m0s
[02:07:02.549] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:106:0)
[02:07:02.549] Timer tick, asking Buildbucket for the build status
[02:07:02.636] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:02.636] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:107:0) after 1m0s
[02:08:02.659] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:107:0)
[02:08:02.659] Timer tick, asking Buildbucket for the build status
[02:08:02.940] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:02.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:108:0) after 1m0s
[02:09:02.963] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:108:0)
[02:09:02.963] Timer tick, asking Buildbucket for the build status
[02:09:03.066] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:03.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:109:0) after 1m0s
[02:10:03.097] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:109:0)
[02:10:03.097] Timer tick, asking Buildbucket for the build status
[02:10:03.200] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:03.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:110:0) after 1m0s
[02:11:03.219] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:110:0)
[02:11:03.219] Timer tick, asking Buildbucket for the build status
[02:11:03.544] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:03.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:111:0) after 1m0s
[02:12:03.565] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:111:0)
[02:12:03.565] Timer tick, asking Buildbucket for the build status
[02:12:03.617] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:03.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:112:0) after 1m0s
[02:13:03.658] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:112:0)
[02:13:03.658] Timer tick, asking Buildbucket for the build status
[02:13:03.772] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:03.772] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:113:0) after 1m0s
[02:14:03.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:113:0)
[02:14:03.793] Timer tick, asking Buildbucket for the build status
[02:14:03.875] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:03.875] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:114:0) after 1m0s
[02:15:03.906] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:114:0)
[02:15:03.906] Timer tick, asking Buildbucket for the build status
[02:15:04.029] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:04.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:115:0) after 1m0s
[02:16:04.055] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:115:0)
[02:16:04.055] Timer tick, asking Buildbucket for the build status
[02:16:04.130] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:04.130] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:116:0) after 1m0s
[02:17:04.181] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:116:0)
[02:17:04.181] Timer tick, asking Buildbucket for the build status
[02:17:04.294] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:04.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:117:0) after 1m0s
[02:18:04.328] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:117:0)
[02:18:04.328] Timer tick, asking Buildbucket for the build status
[02:18:04.563] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:04.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:118:0) after 1m0s
[02:19:04.586] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:118:0)
[02:19:04.586] Timer tick, asking Buildbucket for the build status
[02:19:04.660] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:04.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:119:0) after 1m0s
[02:20:04.684] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:119:0)
[02:20:04.684] Timer tick, asking Buildbucket for the build status
[02:20:04.845] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:04.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:120:0) after 1m0s
[02:21:04.875] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:120:0)
[02:21:04.875] Timer tick, asking Buildbucket for the build status
[02:21:05.054] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:05.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:121:0) after 1m0s
[02:22:05.085] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:121:0)
[02:22:05.085] Timer tick, asking Buildbucket for the build status
[02:22:05.210] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:05.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:122:0) after 1m0s
[02:23:05.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:122:0)
[02:23:05.238] Timer tick, asking Buildbucket for the build status
[02:23:05.375] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:05.375] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:123:0) after 1m0s
[02:24:05.423] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:123:0)
[02:24:05.423] Timer tick, asking Buildbucket for the build status
[02:24:05.625] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:05.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:124:0) after 1m0s
[02:25:05.649] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:124:0)
[02:25:05.649] Timer tick, asking Buildbucket for the build status
[02:25:05.752] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:05.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:125:0) after 1m0s
[02:26:05.779] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:125:0)
[02:26:05.779] Timer tick, asking Buildbucket for the build status
[02:26:06.079] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:06.079] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:126:0) after 1m0s
[02:27:06.109] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:126:0)
[02:27:06.109] Timer tick, asking Buildbucket for the build status
[02:27:06.474] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:06.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:127:0) after 1m0s
[02:28:06.495] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:127:0)
[02:28:06.495] Timer tick, asking Buildbucket for the build status
[02:28:06.565] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:06.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:128:0) after 1m0s
[02:29:06.588] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:128:0)
[02:29:06.588] Timer tick, asking Buildbucket for the build status
[02:29:06.813] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:06.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:129:0) after 1m0s
[02:30:06.837] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:129:0)
[02:30:06.837] Timer tick, asking Buildbucket for the build status
[02:30:07.103] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:07.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:130:0) after 1m0s
[02:31:07.126] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:130:0)
[02:31:07.127] Timer tick, asking Buildbucket for the build status
[02:31:07.201] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:07.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:131:0) after 1m0s
[02:32:07.225] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:131:0)
[02:32:07.225] Timer tick, asking Buildbucket for the build status
[02:32:07.349] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:07.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:132:0) after 1m0s
[02:33:07.412] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:132:0)
[02:33:07.412] Timer tick, asking Buildbucket for the build status
[02:33:07.590] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:07.590] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:133:0) after 1m0s
[02:34:07.609] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:133:0)
[02:34:07.609] Timer tick, asking Buildbucket for the build status
[02:34:07.660] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:07.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:134:0) after 1m0s
[02:35:07.732] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:134:0)
[02:35:07.733] Timer tick, asking Buildbucket for the build status
[02:35:07.970] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:07.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:135:0) after 1m0s
[02:36:07.997] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:135:0)
[02:36:07.997] Timer tick, asking Buildbucket for the build status
[02:36:08.053] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:08.053] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:136:0) after 1m0s
[02:37:08.080] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:136:0)
[02:37:08.080] Timer tick, asking Buildbucket for the build status
[02:37:08.431] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:08.431] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:137:0) after 1m0s
[02:38:08.455] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:137:0)
[02:38:08.455] Timer tick, asking Buildbucket for the build status
[02:38:08.637] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:08.637] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:138:0) after 1m0s
[02:39:08.666] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:138:0)
[02:39:08.666] Timer tick, asking Buildbucket for the build status
[02:39:08.777] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:08.777] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:139:0) after 1m0s
[02:40:08.802] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:139:0)
[02:40:08.802] Timer tick, asking Buildbucket for the build status
[02:40:08.905] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:08.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:140:0) after 1m0s
[02:41:08.927] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:140:0)
[02:41:08.927] Timer tick, asking Buildbucket for the build status
[02:41:08.992] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:08.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:141:0) after 1m0s
[02:42:09.016] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:141:0)
[02:42:09.016] Timer tick, asking Buildbucket for the build status
[02:42:09.114] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:09.114] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:142:0) after 1m0s
[02:43:09.142] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:142:0)
[02:43:09.142] Timer tick, asking Buildbucket for the build status
[02:43:09.332] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:09.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:143:0) after 1m0s
[02:44:09.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:143:0)
[02:44:09.360] Timer tick, asking Buildbucket for the build status
[02:44:09.455] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:09.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:144:0) after 1m0s
[02:45:09.475] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:144:0)
[02:45:09.475] Timer tick, asking Buildbucket for the build status
[02:45:09.656] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:09.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:145:0) after 1m0s
[02:46:09.677] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:145:0)
[02:46:09.677] Timer tick, asking Buildbucket for the build status
[02:46:09.830] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:09.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:146:0) after 1m0s
[02:47:09.919] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:146:0)
[02:47:09.919] Timer tick, asking Buildbucket for the build status
[02:47:10.029] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:10.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:147:0) after 1m0s
[02:48:10.049] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:147:0)
[02:48:10.049] Timer tick, asking Buildbucket for the build status
[02:48:10.174] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:10.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:148:0) after 1m0s
[02:49:10.203] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:148:0)
[02:49:10.203] Timer tick, asking Buildbucket for the build status
[02:49:10.271] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:10.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:149:0) after 1m0s
[02:50:10.292] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:149:0)
[02:50:10.292] Timer tick, asking Buildbucket for the build status
[02:50:10.387] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:10.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:150:0) after 1m0s
[02:51:10.411] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:150:0)
[02:51:10.411] Timer tick, asking Buildbucket for the build status
[02:51:10.474] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:10.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:151:0) after 1m0s
[02:52:10.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:151:0)
[02:52:10.544] Timer tick, asking Buildbucket for the build status
[02:52:10.593] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:10.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:152:0) after 1m0s
[02:53:10.619] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:152:0)
[02:53:10.619] Timer tick, asking Buildbucket for the build status
[02:53:10.919] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:10.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:153:0) after 1m0s
[02:54:10.943] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:153:0)
[02:54:10.943] Timer tick, asking Buildbucket for the build status
[02:54:11.035] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:11.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:154:0) after 1m0s
[02:55:11.057] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:154:0)
[02:55:11.057] Timer tick, asking Buildbucket for the build status
[02:55:11.199] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:11.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:155:0) after 1m0s
[02:56:11.224] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:155:0)
[02:56:11.224] Timer tick, asking Buildbucket for the build status
[02:56:11.315] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:11.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:156:0) after 1m0s
[02:57:11.373] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:156:0)
[02:57:11.373] Timer tick, asking Buildbucket for the build status
[02:57:11.550] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:11.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:157:0) after 1m0s
[02:58:11.572] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:157:0)
[02:58:11.572] Timer tick, asking Buildbucket for the build status
[02:58:11.793] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:11.793] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:158:0) after 1m0s
[02:59:11.819] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:158:0)
[02:59:11.819] Timer tick, asking Buildbucket for the build status
[02:59:11.890] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:11.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:159:0) after 1m0s
[03:00:11.943] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:159:0)
[03:00:11.943] Timer tick, asking Buildbucket for the build status
[03:00:12.037] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:12.037] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:160:0) after 1m0s
[03:01:12.094] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:160:0)
[03:01:12.094] Timer tick, asking Buildbucket for the build status
[03:01:12.186] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:12.186] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:161:0) after 1m0s
[03:02:12.206] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:161:0)
[03:02:12.206] Timer tick, asking Buildbucket for the build status
[03:02:12.295] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:12.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:162:0) after 1m0s
[03:03:12.319] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:162:0)
[03:03:12.319] Timer tick, asking Buildbucket for the build status
[03:03:12.393] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:12.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:163:0) after 1m0s
[03:04:12.412] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:163:0)
[03:04:12.412] Timer tick, asking Buildbucket for the build status
[03:04:12.506] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:12.506] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:164:0) after 1m0s
[03:05:12.526] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:164:0)
[03:05:12.526] Timer tick, asking Buildbucket for the build status
[03:05:12.591] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:12.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:165:0) after 1m0s
[03:06:12.613] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:165:0)
[03:06:12.613] Timer tick, asking Buildbucket for the build status
[03:06:12.710] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:12.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:166:0) after 1m0s
[03:07:12.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:166:0)
[03:07:12.738] Timer tick, asking Buildbucket for the build status
[03:07:12.922] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:12.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:167:0) after 1m0s
[03:08:12.946] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:167:0)
[03:08:12.946] Timer tick, asking Buildbucket for the build status
[03:08:12.989] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:12.989] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:168:0) after 1m0s
[03:09:13.056] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:168:0)
[03:09:13.056] Timer tick, asking Buildbucket for the build status
[03:09:13.236] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:13.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:169:0) after 1m0s
[03:10:13.263] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:169:0)
[03:10:13.263] Timer tick, asking Buildbucket for the build status
[03:10:13.332] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:13.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:170:0) after 1m0s
[03:11:13.357] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:170:0)
[03:11:13.357] Timer tick, asking Buildbucket for the build status
[03:11:13.442] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:13.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:171:0) after 1m0s
[03:12:13.463] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:171:0)
[03:12:13.463] Timer tick, asking Buildbucket for the build status
[03:12:13.654] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:13.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:172:0) after 1m0s
[03:13:13.684] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:172:0)
[03:13:13.684] Timer tick, asking Buildbucket for the build status
[03:13:13.734] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:13.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:173:0) after 1m0s
[03:14:13.758] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:173:0)
[03:14:13.758] Timer tick, asking Buildbucket for the build status
[03:14:13.843] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:13.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:174:0) after 1m0s
[03:15:13.873] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:174:0)
[03:15:13.873] Timer tick, asking Buildbucket for the build status
[03:15:13.964] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:13.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:175:0) after 1m0s
[03:16:13.987] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:175:0)
[03:16:13.987] Timer tick, asking Buildbucket for the build status
[03:16:14.035] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:14.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:176:0) after 1m0s
[03:17:14.159] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:176:0)
[03:17:14.159] Timer tick, asking Buildbucket for the build status
[03:17:14.214] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:14.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:177:0) after 1m0s
[03:18:14.233] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:177:0)
[03:18:14.233] Timer tick, asking Buildbucket for the build status
[03:18:14.298] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:14.298] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:178:0) after 1m0s
[03:19:14.325] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:178:0)
[03:19:14.325] Timer tick, asking Buildbucket for the build status
[03:19:14.411] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:14.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:179:0) after 1m0s
[03:20:14.434] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:179:0)
[03:20:14.434] Timer tick, asking Buildbucket for the build status
[03:20:14.490] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:14.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:180:0) after 1m0s
[03:21:14.518] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:180:0)
[03:21:14.518] Timer tick, asking Buildbucket for the build status
[03:21:14.604] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:14.605] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:181:0) after 1m0s
[03:22:14.711] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:181:0)
[03:22:14.711] Timer tick, asking Buildbucket for the build status
[03:22:14.770] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:14.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:182:0) after 1m0s
[03:23:14.823] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:182:0)
[03:23:14.823] Timer tick, asking Buildbucket for the build status
[03:23:14.894] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:14.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:183:0) after 1m0s
[03:24:14.929] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:183:0)
[03:24:14.929] Timer tick, asking Buildbucket for the build status
[03:24:15.132] Build 8927118526880904544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:15.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9092548589028403632:184:0) after 1m0s
[03:24:35.635] Received PubSub notification, asking Buildbucket for the build status
[03:24:35.669] Build 8927118526880904544: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:24:35.669] Buildbucket build:
{
"build": {
"bucket": "luci.nacl.ci",
"canary_preference": "AUTO",
"completed_ts": "1544844274593051",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1544833363607219",
"failure_reason": "BUILD_FAILURE",
"id": "8927118526880904544",
"parameters_json": "{\"builder_name\": \"linux-64-validator-opt\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"af5947d13e6794eac489365ff58fd45c0dd4ca2a\"}}",
"project": "nacl",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure annotated steps\\nFailure predownload validator corpus\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"0\"], \"zone\": [\"us\", \"us-golo\", \"us-golo-1\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"kvm\": [\"0\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-E5-2670\"], \"server_version\": [\"3945-402d3be\"], \"machine_type\": [\"n1-highcpu-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"vm316-m1\"], \"pool\": [\"luci.flex.ci\"], \"caches\": [\"builder_41bff59e48143683eee7e209c35176da7d4c8f0bf6fc4cc531114b3142934c50_v2\", \"builder_4235cbca53d69e2265b4766f5a8bce926c6fc26ba44440d27213d5484c3aef8d_v2\", \"builder_78893cbd4c292ba203eb7a045a56252df7f14bd0ad3b7b91fac8bfee09f12c2b_v2\", \"builder_c8e751c405093ae22c3daed2afc711c74e2df07c15bf8f352895d9c637de509d_v2\", \"builder_faaedc22e3ac6fec098652e7f0fd10d4f879f8f9ad55ea8ef979585009ee36da_v2\", \"git\", \"goma_v2\", \"infra_gclient_with_go\", \"vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/mnt/data/b/s/w/ir/cache\", \"temp_dir\": \"/mnt/data/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 87, \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"buildername\": \"linux-64-validator-opt\", \"got_revision\": \"af5947d13e6794eac489365ff58fd45c0dd4ca2a\", \"recipe\": \"nacl\", \"mastername\": \"client.nacl\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1544833363607219, \"tags\": [\"builder:linux-64-validator-opt\", \"buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a\", \"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9092548589028403632\", \"scheduler_job_id:nacl/linux-64-validator-opt\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.nacl.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"nacl\", \"id\": \"8927118526880904544\"}}, \"slavetype\": \"BuilderTester\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"af5947d13e6794eac489365ff58fd45c0dd4ca2a\", \"bot_id\": \"vm316-m1\"}}",
"service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1544833407724283",
"status": "COMPLETED",
"status_changed_ts": "1544844275357840",
"tags": [
"build_address:luci.nacl.ci/linux-64-validator-opt/87",
"builder:linux-64-validator-opt",
"buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9092548589028403632",
"scheduler_job_id:nacl/linux-64-validator-opt",
"swarming_dimension:caches:builder_ec3024801e8fae9a0c90cf0b91bc8fd309d619937749998ead917e6c37a3a5b5_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.flex.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.nacl.ci/linux-64-validator-opt/87",
"swarming_tag:buildbucket_bucket:nacl/ci",
"swarming_tag:buildbucket_build_id:8927118526880904544",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
"swarming_tag:builder:linux-64-validator-opt",
"swarming_tag:buildset:commit/git/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/af5947d13e6794eac489365ff58fd45c0dd4ca2a",
"swarming_tag:caches:builder_ec3024801e8fae9a0c90cf0b91bc8fd309d619937749998ead917e6c37a3a5b5_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8927118526880904544/+/annotations",
"swarming_tag:luci_project:nacl",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.flex.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:nacl",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9092548589028403632",
"swarming_tag:scheduler_job_id:nacl/linux-64-validator-opt",
"swarming_tag:service_account:nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:ee62e96c73f38e03db7f2d5dd18fea50e0f44727",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41c80ff9361bc810",
"user_agent:luci-scheduler"
],
"updated_ts": "1544844275359171",
"url": "https://ci.chromium.org/b/8927118526880904544",
"utcnow_ts": "1544844275656254"
}
}
[03:24:35.669] Invocation finished in 3h1m53.494400629s with status FAILED