LUCI Scheduler :: nacl :: linux-64-validator-opt

Status: FAILED

Triggered by: -

Duration: 4 hours

Actions:

Definition (rev 8fecfaafc1abba4843234d58a712c5811f9e1de9)

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

Incoming triggers

b13f9c675f002215b711619f8e99cbcf90b84125 (6 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[15:19:26.072] New invocation is queued and will start shortly
[15:19:27.525] Starting the invocation (attempt 1)
[15:19:27.631] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:19:27.631] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:19:27.631] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9088868292921404032",
  "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\":\"b13f9c675f002215b711619f8e99cbcf90b84125\"}}",
  "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:9088868292921404032",
    "scheduler_job_id:nacl/linux-64-validator-opt",
    "user_agent:luci-scheduler",
    "buildset:commit/git/b13f9c675f002215b711619f8e99cbcf90b84125",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/b13f9c675f002215b711619f8e99cbcf90b84125",
    "gitiles_ref:refs/heads/master"
  ]
}
[15:19:28.624] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1548343167753488",
    "id": "8923438230488088656",
    "lease_expiration_ts": "1548494368395578",
    "lease_key": "1473488595",
    "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\": \"b13f9c675f002215b711619f8e99cbcf90b84125\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1548343168543856",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/100",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/b13f9c675f002215b711619f8e99cbcf90b84125",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/b13f9c675f002215b711619f8e99cbcf90b84125",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9088868292921404032",
      "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/100",
      "swarming_tag:buildbucket_bucket:nacl/ci",
      "swarming_tag:buildbucket_build_id:8923438230488088656",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:linux-64-validator-opt",
      "swarming_tag:buildset:commit/git/b13f9c675f002215b711619f8e99cbcf90b84125",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/b13f9c675f002215b711619f8e99cbcf90b84125",
      "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/8923438230488088656/+/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:9088868292921404032",
      "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:a883ea2343e81ad9b4be8c2424a65260c5b29a9f",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:42994354caa0b510",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1548343168543868",
    "url": "https://ci.chromium.org/b/8923438230488088656",
    "utcnow_ts": "1548343168616619"
  }
}
[15:19:28.624] Task URL: https://ci.chromium.org/b/8923438230488088656
[15:19:28.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:2:0) after 1m0s
[15:20:28.668] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:2:0)
[15:20:28.669] Timer tick, asking Buildbucket for the build status
[15:20:28.721] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:20:28.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:3:0) after 1m0s
[15:21:28.782] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:3:0)
[15:21:28.782] Timer tick, asking Buildbucket for the build status
[15:21:28.815] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:21:28.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:4:0) after 1m0s
[15:22:28.932] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:4:0)
[15:22:28.933] Timer tick, asking Buildbucket for the build status
[15:22:28.969] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:22:28.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:5:0) after 1m0s
[15:23:29.014] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:5:0)
[15:23:29.014] Timer tick, asking Buildbucket for the build status
[15:23:29.068] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:23:29.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:6:0) after 1m0s
[15:24:29.142] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:6:0)
[15:24:29.142] Timer tick, asking Buildbucket for the build status
[15:24:29.193] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:24:29.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:7:0) after 1m0s
[15:25:29.232] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:7:0)
[15:25:29.232] Timer tick, asking Buildbucket for the build status
[15:25:29.302] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:25:29.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:8:0) after 1m0s
[15:26:29.344] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:8:0)
[15:26:29.344] Timer tick, asking Buildbucket for the build status
[15:26:29.379] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:26:29.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:9:0) after 1m0s
[15:27:29.396] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:9:0)
[15:27:29.396] Timer tick, asking Buildbucket for the build status
[15:27:29.608] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:27:29.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:10:0) after 1m0s
[15:28:29.628] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:10:0)
[15:28:29.628] Timer tick, asking Buildbucket for the build status
[15:28:29.672] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:28:29.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:11:0) after 1m0s
[15:29:29.698] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:11:0)
[15:29:29.698] Timer tick, asking Buildbucket for the build status
[15:29:29.751] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:29:29.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:12:0) after 1m0s
[15:30:29.772] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:12:0)
[15:30:29.772] Timer tick, asking Buildbucket for the build status
[15:30:29.829] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:30:29.829] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:13:0) after 1m0s
[15:31:29.845] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:13:0)
[15:31:29.845] Timer tick, asking Buildbucket for the build status
[15:31:29.886] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:31:29.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:14:0) after 1m0s
[15:32:29.904] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:14:0)
[15:32:29.904] Timer tick, asking Buildbucket for the build status
[15:32:29.980] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:32:29.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:15:0) after 1m0s
[15:33:29.998] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:15:0)
[15:33:29.998] Timer tick, asking Buildbucket for the build status
[15:33:30.039] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:33:30.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:16:0) after 1m0s
[15:34:30.096] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:16:0)
[15:34:30.096] Timer tick, asking Buildbucket for the build status
[15:34:30.156] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:34:30.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:17:0) after 1m0s
[15:35:30.173] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:17:0)
[15:35:30.173] Timer tick, asking Buildbucket for the build status
[15:35:30.212] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:35:30.212] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:18:0) after 1m0s
[15:36:30.232] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:18:0)
[15:36:30.232] Timer tick, asking Buildbucket for the build status
[15:36:30.301] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:36:30.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:19:0) after 1m0s
[15:37:30.323] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:19:0)
[15:37:30.324] Timer tick, asking Buildbucket for the build status
[15:37:30.415] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:37:30.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:20:0) after 1m0s
[15:38:30.461] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:20:0)
[15:38:30.461] Timer tick, asking Buildbucket for the build status
[15:38:30.503] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:38:30.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:21:0) after 1m0s
[15:39:30.521] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:21:0)
[15:39:30.521] Timer tick, asking Buildbucket for the build status
[15:39:30.572] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:39:30.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:22:0) after 1m0s
[15:40:30.588] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:22:0)
[15:40:30.588] Timer tick, asking Buildbucket for the build status
[15:40:30.618] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:40:30.618] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:23:0) after 1m0s
[15:41:30.639] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:23:0)
[15:41:30.639] Timer tick, asking Buildbucket for the build status
[15:41:30.753] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:41:30.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:24:0) after 1m0s
[15:42:30.768] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:24:0)
[15:42:30.768] Timer tick, asking Buildbucket for the build status
[15:42:30.824] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:42:30.824] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:25:0) after 1m0s
[15:43:30.839] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:25:0)
[15:43:30.839] Timer tick, asking Buildbucket for the build status
[15:43:30.900] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:43:30.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:26:0) after 1m0s
[15:44:30.918] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:26:0)
[15:44:30.918] Timer tick, asking Buildbucket for the build status
[15:44:30.954] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:44:30.954] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:27:0) after 1m0s
[15:45:30.974] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:27:0)
[15:45:30.974] Timer tick, asking Buildbucket for the build status
[15:45:31.031] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:45:31.031] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:28:0) after 1m0s
[15:46:31.111] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:28:0)
[15:46:31.111] Timer tick, asking Buildbucket for the build status
[15:46:31.156] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:46:31.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:29:0) after 1m0s
[15:47:31.175] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:29:0)
[15:47:31.175] Timer tick, asking Buildbucket for the build status
[15:47:31.298] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:47:31.298] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:30:0) after 1m0s
[15:48:31.315] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:30:0)
[15:48:31.315] Timer tick, asking Buildbucket for the build status
[15:48:31.448] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:48:31.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:31:0) after 1m0s
[15:49:31.464] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:31:0)
[15:49:31.464] Timer tick, asking Buildbucket for the build status
[15:49:31.498] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:49:31.498] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:32:0) after 1m0s
[15:50:31.513] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:32:0)
[15:50:31.514] Timer tick, asking Buildbucket for the build status
[15:50:31.574] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:50:31.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:33:0) after 1m0s
[15:51:31.593] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:33:0)
[15:51:31.593] Timer tick, asking Buildbucket for the build status
[15:51:31.631] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:51:31.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:34:0) after 1m0s
[15:52:31.651] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:34:0)
[15:52:31.651] Timer tick, asking Buildbucket for the build status
[15:52:31.706] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:52:31.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:35:0) after 1m0s
[15:53:31.761] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:35:0)
[15:53:31.762] Timer tick, asking Buildbucket for the build status
[15:53:31.807] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:53:31.807] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:36:0) after 1m0s
[15:54:31.845] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:36:0)
[15:54:31.845] Timer tick, asking Buildbucket for the build status
[15:54:31.973] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:54:31.973] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:37:0) after 1m0s
[15:55:31.991] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:37:0)
[15:55:31.991] Timer tick, asking Buildbucket for the build status
[15:55:32.105] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:55:32.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:38:0) after 1m0s
[15:56:32.129] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:38:0)
[15:56:32.129] Timer tick, asking Buildbucket for the build status
[15:56:32.182] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:56:32.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:39:0) after 1m0s
[15:57:32.240] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:39:0)
[15:57:32.240] Timer tick, asking Buildbucket for the build status
[15:57:32.353] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:57:32.353] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:40:0) after 1m0s
[15:58:32.413] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:40:0)
[15:58:32.413] Timer tick, asking Buildbucket for the build status
[15:58:32.447] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:58:32.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:41:0) after 1m0s
[15:59:32.466] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:41:0)
[15:59:32.466] Timer tick, asking Buildbucket for the build status
[15:59:32.522] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:59:32.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:42:0) after 1m0s
[16:00:32.551] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:42:0)
[16:00:32.551] Timer tick, asking Buildbucket for the build status
[16:00:32.589] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:00:32.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:43:0) after 1m0s
[16:01:32.622] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:43:0)
[16:01:32.622] Timer tick, asking Buildbucket for the build status
[16:01:32.696] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:01:32.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:44:0) after 1m0s
[16:02:32.718] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:44:0)
[16:02:32.718] Timer tick, asking Buildbucket for the build status
[16:02:32.753] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:02:32.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:45:0) after 1m0s
[16:03:32.778] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:45:0)
[16:03:32.778] Timer tick, asking Buildbucket for the build status
[16:03:32.831] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:03:32.831] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:46:0) after 1m0s
[16:04:32.849] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:46:0)
[16:04:32.849] Timer tick, asking Buildbucket for the build status
[16:04:32.890] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:04:32.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:47:0) after 1m0s
[16:05:32.907] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:47:0)
[16:05:32.907] Timer tick, asking Buildbucket for the build status
[16:05:32.979] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:05:32.979] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:48:0) after 1m0s
[16:06:32.997] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:48:0)
[16:06:32.997] Timer tick, asking Buildbucket for the build status
[16:06:33.032] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:06:33.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:49:0) after 1m0s
[16:07:33.053] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:49:0)
[16:07:33.053] Timer tick, asking Buildbucket for the build status
[16:07:33.176] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:07:33.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:50:0) after 1m0s
[16:08:33.196] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:50:0)
[16:08:33.196] Timer tick, asking Buildbucket for the build status
[16:08:33.228] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:08:33.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:51:0) after 1m0s
[16:09:33.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:51:0)
[16:09:33.251] Timer tick, asking Buildbucket for the build status
[16:09:33.307] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:09:33.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:52:0) after 1m0s
[16:10:33.326] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:52:0)
[16:10:33.326] Timer tick, asking Buildbucket for the build status
[16:10:33.400] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:10:33.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:53:0) after 1m0s
[16:11:33.451] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:53:0)
[16:11:33.451] Timer tick, asking Buildbucket for the build status
[16:11:33.499] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:11:33.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:54:0) after 1m0s
[16:12:33.658] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:54:0)
[16:12:33.658] Timer tick, asking Buildbucket for the build status
[16:12:33.687] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:12:33.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:55:0) after 1m0s
[16:13:33.705] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:55:0)
[16:13:33.705] Timer tick, asking Buildbucket for the build status
[16:13:33.757] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:13:33.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:56:0) after 1m0s
[16:14:33.812] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:56:0)
[16:14:33.812] Timer tick, asking Buildbucket for the build status
[16:14:33.876] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:14:33.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:57:0) after 1m0s
[16:15:33.958] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:57:0)
[16:15:33.958] Timer tick, asking Buildbucket for the build status
[16:15:34.009] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:15:34.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:58:0) after 1m0s
[16:16:34.037] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:58:0)
[16:16:34.037] Timer tick, asking Buildbucket for the build status
[16:16:34.122] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:16:34.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:59:0) after 1m0s
[16:17:34.125] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:59:0)
[16:17:34.125] Timer tick, asking Buildbucket for the build status
[16:17:34.315] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:17:34.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:60:0) after 1m0s
[16:18:34.338] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:60:0)
[16:18:34.338] Timer tick, asking Buildbucket for the build status
[16:18:34.369] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:34.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:61:0) after 1m0s
[16:19:34.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:61:0)
[16:19:34.405] Timer tick, asking Buildbucket for the build status
[16:19:34.469] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:19:34.469] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:62:0) after 1m0s
[16:20:34.511] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:62:0)
[16:20:34.511] Timer tick, asking Buildbucket for the build status
[16:20:34.568] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:20:34.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:63:0) after 1m0s
[16:21:34.592] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:63:0)
[16:21:34.592] Timer tick, asking Buildbucket for the build status
[16:21:34.657] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:21:34.657] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:64:0) after 1m0s
[16:22:34.753] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:64:0)
[16:22:34.753] Timer tick, asking Buildbucket for the build status
[16:22:34.804] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:22:34.804] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:65:0) after 1m0s
[16:23:34.825] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:65:0)
[16:23:34.825] Timer tick, asking Buildbucket for the build status
[16:23:34.902] Build 8923438230488088656: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:23:34.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:66:0) after 1m0s
[16:24:28.725] Received PubSub notification, asking Buildbucket for the build status
[16:24:28.760] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:34.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:66:0)
[16:24:34.920] Timer tick, asking Buildbucket for the build status
[16:24:35.040] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:35.040] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:68:0) after 1m0s
[16:25:35.064] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:68:0)
[16:25:35.064] Timer tick, asking Buildbucket for the build status
[16:25:35.188] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:35.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:69:0) after 1m0s
[16:26:35.213] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:69:0)
[16:26:35.213] Timer tick, asking Buildbucket for the build status
[16:26:35.301] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:35.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:70:0) after 1m0s
[16:27:35.322] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:70:0)
[16:27:35.322] Timer tick, asking Buildbucket for the build status
[16:27:35.449] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:35.449] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:71:0) after 1m0s
[16:28:35.516] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:71:0)
[16:28:35.516] Timer tick, asking Buildbucket for the build status
[16:28:35.633] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:35.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:72:0) after 1m0s
[16:29:35.654] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:72:0)
[16:29:35.654] Timer tick, asking Buildbucket for the build status
[16:29:35.768] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:35.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:73:0) after 1m0s
[16:30:35.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:73:0)
[16:30:35.793] Timer tick, asking Buildbucket for the build status
[16:30:35.854] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:35.854] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:74:0) after 1m0s
[16:31:35.875] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:74:0)
[16:31:35.875] Timer tick, asking Buildbucket for the build status
[16:31:35.922] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:35.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:75:0) after 1m0s
[16:32:35.943] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:75:0)
[16:32:35.943] Timer tick, asking Buildbucket for the build status
[16:32:35.993] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:35.993] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:76:0) after 1m0s
[16:33:36.013] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:76:0)
[16:33:36.013] Timer tick, asking Buildbucket for the build status
[16:33:36.101] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:36.101] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:77:0) after 1m0s
[16:34:36.144] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:77:0)
[16:34:36.144] Timer tick, asking Buildbucket for the build status
[16:34:36.214] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:36.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:78:0) after 1m0s
[16:35:36.249] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:78:0)
[16:35:36.249] Timer tick, asking Buildbucket for the build status
[16:35:36.331] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:36.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:79:0) after 1m0s
[16:36:36.351] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:79:0)
[16:36:36.351] Timer tick, asking Buildbucket for the build status
[16:36:36.469] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:36.469] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:80:0) after 1m0s
[16:37:36.489] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:80:0)
[16:37:36.489] Timer tick, asking Buildbucket for the build status
[16:37:36.567] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:36.567] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:81:0) after 1m0s
[16:38:36.589] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:81:0)
[16:38:36.589] Timer tick, asking Buildbucket for the build status
[16:38:36.663] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:36.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:82:0) after 1m0s
[16:39:36.684] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:82:0)
[16:39:36.684] Timer tick, asking Buildbucket for the build status
[16:39:36.830] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:36.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:83:0) after 1m0s
[16:40:36.851] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:83:0)
[16:40:36.851] Timer tick, asking Buildbucket for the build status
[16:40:36.941] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:36.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:84:0) after 1m0s
[16:41:36.963] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:84:0)
[16:41:36.963] Timer tick, asking Buildbucket for the build status
[16:41:37.066] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:37.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:85:0) after 1m0s
[16:42:37.088] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:85:0)
[16:42:37.088] Timer tick, asking Buildbucket for the build status
[16:42:37.265] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:37.265] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:86:0) after 1m0s
[16:43:37.287] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:86:0)
[16:43:37.287] Timer tick, asking Buildbucket for the build status
[16:43:37.369] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:37.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:87:0) after 1m0s
[16:44:37.389] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:87:0)
[16:44:37.389] Timer tick, asking Buildbucket for the build status
[16:44:37.500] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:37.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:88:0) after 1m0s
[16:45:37.521] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:88:0)
[16:45:37.521] Timer tick, asking Buildbucket for the build status
[16:45:37.581] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:37.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:89:0) after 1m0s
[16:46:37.612] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:89:0)
[16:46:37.612] Timer tick, asking Buildbucket for the build status
[16:46:37.713] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:37.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:90:0) after 1m0s
[16:47:37.732] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:90:0)
[16:47:37.732] Timer tick, asking Buildbucket for the build status
[16:47:37.798] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:37.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:91:0) after 1m0s
[16:48:37.820] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:91:0)
[16:48:37.820] Timer tick, asking Buildbucket for the build status
[16:48:37.887] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:37.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:92:0) after 1m0s
[16:49:38.012] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:92:0)
[16:49:38.012] Timer tick, asking Buildbucket for the build status
[16:49:38.076] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:38.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:93:0) after 1m0s
[16:50:38.098] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:93:0)
[16:50:38.098] Timer tick, asking Buildbucket for the build status
[16:50:38.168] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:38.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:94:0) after 1m0s
[16:51:38.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:94:0)
[16:51:38.251] Timer tick, asking Buildbucket for the build status
[16:51:38.313] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:38.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:95:0) after 1m0s
[16:52:38.339] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:95:0)
[16:52:38.339] Timer tick, asking Buildbucket for the build status
[16:52:38.437] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:38.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:96:0) after 1m0s
[16:53:38.509] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:96:0)
[16:53:38.509] Timer tick, asking Buildbucket for the build status
[16:53:38.794] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:38.794] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:97:0) after 1m0s
[16:54:38.878] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:97:0)
[16:54:38.878] Timer tick, asking Buildbucket for the build status
[16:54:38.919] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:38.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:98:0) after 1m0s
[16:55:38.940] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:98:0)
[16:55:38.940] Timer tick, asking Buildbucket for the build status
[16:55:39.025] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:39.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:99:0) after 1m0s
[16:56:39.069] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:99:0)
[16:56:39.069] Timer tick, asking Buildbucket for the build status
[16:56:39.272] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:39.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:100:0) after 1m0s
[16:57:39.296] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:100:0)
[16:57:39.296] Timer tick, asking Buildbucket for the build status
[16:57:39.723] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:39.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:101:0) after 1m0s
[16:58:39.744] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:101:0)
[16:58:39.744] Timer tick, asking Buildbucket for the build status
[16:58:39.820] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:39.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:102:0) after 1m0s
[16:59:39.848] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:102:0)
[16:59:39.848] Timer tick, asking Buildbucket for the build status
[16:59:39.913] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:39.913] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:103:0) after 1m0s
[17:00:39.932] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:103:0)
[17:00:39.932] Timer tick, asking Buildbucket for the build status
[17:00:40.070] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:40.070] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:104:0) after 1m0s
[17:01:40.097] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:104:0)
[17:01:40.097] Timer tick, asking Buildbucket for the build status
[17:01:40.414] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:40.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:105:0) after 1m0s
[17:02:40.439] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:105:0)
[17:02:40.439] Timer tick, asking Buildbucket for the build status
[17:02:40.525] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:40.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:106:0) after 1m0s
[17:03:40.547] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:106:0)
[17:03:40.547] Timer tick, asking Buildbucket for the build status
[17:03:40.613] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:40.613] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:107:0) after 1m0s
[17:04:40.642] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:107:0)
[17:04:40.642] Timer tick, asking Buildbucket for the build status
[17:04:40.726] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:40.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:108:0) after 1m0s
[17:05:40.761] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:108:0)
[17:05:40.761] Timer tick, asking Buildbucket for the build status
[17:05:40.882] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:40.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:109:0) after 1m0s
[17:06:40.904] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:109:0)
[17:06:40.904] Timer tick, asking Buildbucket for the build status
[17:06:40.983] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:40.983] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:110:0) after 1m0s
[17:07:41.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:110:0)
[17:07:41.008] Timer tick, asking Buildbucket for the build status
[17:07:41.200] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:41.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:111:0) after 1m0s
[17:08:41.226] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:111:0)
[17:08:41.226] Timer tick, asking Buildbucket for the build status
[17:08:41.275] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:41.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:112:0) after 1m0s
[17:09:41.296] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:112:0)
[17:09:41.296] Timer tick, asking Buildbucket for the build status
[17:09:41.418] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:41.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:113:0) after 1m0s
[17:10:41.438] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:113:0)
[17:10:41.438] Timer tick, asking Buildbucket for the build status
[17:10:41.570] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:41.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:114:0) after 1m0s
[17:11:41.623] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:114:0)
[17:11:41.623] Timer tick, asking Buildbucket for the build status
[17:11:41.706] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:41.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:115:0) after 1m0s
[17:12:41.729] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:115:0)
[17:12:41.729] Timer tick, asking Buildbucket for the build status
[17:12:41.792] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:41.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:116:0) after 1m0s
[17:13:41.820] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:116:0)
[17:13:41.820] Timer tick, asking Buildbucket for the build status
[17:13:41.863] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:41.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:117:0) after 1m0s
[17:14:41.883] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:117:0)
[17:14:41.883] Timer tick, asking Buildbucket for the build status
[17:14:41.931] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:41.931] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:118:0) after 1m0s
[17:15:41.952] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:118:0)
[17:15:41.952] Timer tick, asking Buildbucket for the build status
[17:15:42.028] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:42.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:119:0) after 1m0s
[17:16:42.073] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:119:0)
[17:16:42.073] Timer tick, asking Buildbucket for the build status
[17:16:42.215] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:42.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:120:0) after 1m0s
[17:17:42.237] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:120:0)
[17:17:42.237] Timer tick, asking Buildbucket for the build status
[17:17:42.280] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:42.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:121:0) after 1m0s
[17:18:42.309] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:121:0)
[17:18:42.309] Timer tick, asking Buildbucket for the build status
[17:18:42.354] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:42.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:122:0) after 1m0s
[17:19:42.375] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:122:0)
[17:19:42.375] Timer tick, asking Buildbucket for the build status
[17:19:42.455] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:42.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:123:0) after 1m0s
[17:20:42.480] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:123:0)
[17:20:42.480] Timer tick, asking Buildbucket for the build status
[17:20:42.523] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:42.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:124:0) after 1m0s
[17:21:42.546] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:124:0)
[17:21:42.546] Timer tick, asking Buildbucket for the build status
[17:21:42.658] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:42.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:125:0) after 1m0s
[17:22:42.679] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:125:0)
[17:22:42.679] Timer tick, asking Buildbucket for the build status
[17:22:42.768] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:42.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:126:0) after 1m0s
[17:23:42.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:126:0)
[17:23:42.793] Timer tick, asking Buildbucket for the build status
[17:23:42.841] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:42.841] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:127:0) after 1m0s
[17:24:42.862] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:127:0)
[17:24:42.862] Timer tick, asking Buildbucket for the build status
[17:24:42.933] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:42.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:128:0) after 1m0s
[17:25:42.954] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:128:0)
[17:25:42.954] Timer tick, asking Buildbucket for the build status
[17:25:43.027] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:43.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:129:0) after 1m0s
[17:26:43.051] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:129:0)
[17:26:43.051] Timer tick, asking Buildbucket for the build status
[17:26:43.264] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:43.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:130:0) after 1m0s
[17:27:43.292] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:130:0)
[17:27:43.292] Timer tick, asking Buildbucket for the build status
[17:27:43.455] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:43.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:131:0) after 1m0s
[17:28:43.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:131:0)
[17:28:43.486] Timer tick, asking Buildbucket for the build status
[17:28:43.571] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:43.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:132:0) after 1m0s
[17:29:43.600] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:132:0)
[17:29:43.600] Timer tick, asking Buildbucket for the build status
[17:29:43.674] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:43.674] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:133:0) after 1m0s
[17:30:43.702] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:133:0)
[17:30:43.702] Timer tick, asking Buildbucket for the build status
[17:30:43.783] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:43.783] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:134:0) after 1m0s
[17:31:43.835] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:134:0)
[17:31:43.835] Timer tick, asking Buildbucket for the build status
[17:31:43.897] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:43.898] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:135:0) after 1m0s
[17:32:43.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:135:0)
[17:32:43.934] Timer tick, asking Buildbucket for the build status
[17:32:44.001] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:44.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:136:0) after 1m0s
[17:33:44.024] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:136:0)
[17:33:44.024] Timer tick, asking Buildbucket for the build status
[17:33:44.139] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:44.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:137:0) after 1m0s
[17:34:44.165] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:137:0)
[17:34:44.165] Timer tick, asking Buildbucket for the build status
[17:34:44.311] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:44.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:138:0) after 1m0s
[17:35:44.335] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:138:0)
[17:35:44.335] Timer tick, asking Buildbucket for the build status
[17:35:44.553] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:44.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:139:0) after 1m0s
[17:36:44.578] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:139:0)
[17:36:44.578] Timer tick, asking Buildbucket for the build status
[17:36:44.656] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:44.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:140:0) after 1m0s
[17:37:44.679] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:140:0)
[17:37:44.679] Timer tick, asking Buildbucket for the build status
[17:37:44.759] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:44.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:141:0) after 1m0s
[17:38:44.782] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:141:0)
[17:38:44.782] Timer tick, asking Buildbucket for the build status
[17:38:44.935] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:44.935] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:142:0) after 1m0s
[17:39:44.978] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:142:0)
[17:39:44.978] Timer tick, asking Buildbucket for the build status
[17:39:45.112] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:45.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:143:0) after 1m0s
[17:40:45.153] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:143:0)
[17:40:45.153] Timer tick, asking Buildbucket for the build status
[17:40:45.226] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:45.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:144:0) after 1m0s
[17:41:45.318] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:144:0)
[17:41:45.318] Timer tick, asking Buildbucket for the build status
[17:41:45.384] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:45.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:145:0) after 1m0s
[17:42:45.422] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:145:0)
[17:42:45.422] Timer tick, asking Buildbucket for the build status
[17:42:45.462] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:45.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:146:0) after 1m0s
[17:43:45.483] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:146:0)
[17:43:45.483] Timer tick, asking Buildbucket for the build status
[17:43:45.596] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:45.596] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:147:0) after 1m0s
[17:44:45.629] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:147:0)
[17:44:45.629] Timer tick, asking Buildbucket for the build status
[17:44:45.720] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:45.720] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:148:0) after 1m0s
[17:45:45.743] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:148:0)
[17:45:45.743] Timer tick, asking Buildbucket for the build status
[17:45:45.804] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:45.804] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:149:0) after 1m0s
[17:46:45.880] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:149:0)
[17:46:45.880] Timer tick, asking Buildbucket for the build status
[17:46:45.928] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:45.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:150:0) after 1m0s
[17:47:46.009] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:150:0)
[17:47:46.009] Timer tick, asking Buildbucket for the build status
[17:47:46.109] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:46.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:151:0) after 1m0s
[17:48:46.147] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:151:0)
[17:48:46.147] Timer tick, asking Buildbucket for the build status
[17:48:46.201] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:46.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:152:0) after 1m0s
[17:49:46.227] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:152:0)
[17:49:46.227] Timer tick, asking Buildbucket for the build status
[17:49:46.303] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:46.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:153:0) after 1m0s
[17:50:46.326] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:153:0)
[17:50:46.326] Timer tick, asking Buildbucket for the build status
[17:50:46.412] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:46.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:154:0) after 1m0s
[17:51:46.498] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:154:0)
[17:51:46.498] Timer tick, asking Buildbucket for the build status
[17:51:46.594] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:46.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:155:0) after 1m0s
[17:52:46.620] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:155:0)
[17:52:46.620] Timer tick, asking Buildbucket for the build status
[17:52:46.670] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:46.670] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:156:0) after 1m0s
[17:53:46.691] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:156:0)
[17:53:46.691] Timer tick, asking Buildbucket for the build status
[17:53:46.764] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:46.764] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:157:0) after 1m0s
[17:54:46.809] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:157:0)
[17:54:46.809] Timer tick, asking Buildbucket for the build status
[17:54:47.054] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:47.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:158:0) after 1m0s
[17:55:47.125] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:158:0)
[17:55:47.125] Timer tick, asking Buildbucket for the build status
[17:55:47.197] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:47.197] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:159:0) after 1m0s
[17:56:47.219] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:159:0)
[17:56:47.219] Timer tick, asking Buildbucket for the build status
[17:56:47.263] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:47.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:160:0) after 1m0s
[17:57:47.286] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:160:0)
[17:57:47.286] Timer tick, asking Buildbucket for the build status
[17:57:47.660] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:47.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:161:0) after 1m0s
[17:58:47.680] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:161:0)
[17:58:47.680] Timer tick, asking Buildbucket for the build status
[17:58:47.715] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:47.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:162:0) after 1m0s
[17:59:47.736] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:162:0)
[17:59:47.736] Timer tick, asking Buildbucket for the build status
[17:59:48.059] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:48.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:163:0) after 1m0s
[18:00:48.094] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:163:0)
[18:00:48.094] Timer tick, asking Buildbucket for the build status
[18:00:48.147] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:48.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:164:0) after 1m0s
[18:01:48.228] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:164:0)
[18:01:48.228] Timer tick, asking Buildbucket for the build status
[18:01:48.307] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:48.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:165:0) after 1m0s
[18:02:48.332] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:165:0)
[18:02:48.332] Timer tick, asking Buildbucket for the build status
[18:02:48.393] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:48.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:166:0) after 1m0s
[18:03:59.302] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:166:0)
[18:03:59.302] Timer tick, asking Buildbucket for the build status
[18:03:59.392] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:59.392] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:167:0) after 1m0s
[18:04:59.424] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:167:0)
[18:04:59.424] Timer tick, asking Buildbucket for the build status
[18:04:59.464] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:59.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:168:0) after 1m0s
[18:05:59.491] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:168:0)
[18:05:59.491] Timer tick, asking Buildbucket for the build status
[18:05:59.556] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:59.556] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:169:0) after 1m0s
[18:06:59.579] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:169:0)
[18:06:59.579] Timer tick, asking Buildbucket for the build status
[18:06:59.619] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:59.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:170:0) after 1m0s
[18:07:59.643] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:170:0)
[18:07:59.643] Timer tick, asking Buildbucket for the build status
[18:07:59.701] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:59.701] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:171:0) after 1m0s
[18:08:59.726] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:171:0)
[18:08:59.726] Timer tick, asking Buildbucket for the build status
[18:08:59.770] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:59.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:172:0) after 1m0s
[18:09:59.807] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:172:0)
[18:09:59.807] Timer tick, asking Buildbucket for the build status
[18:09:59.870] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:59.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:173:0) after 1m0s
[18:11:00.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:173:0)
[18:11:00.330] Timer tick, asking Buildbucket for the build status
[18:11:00.462] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:00.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:174:0) after 1m0s
[18:12:00.495] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:174:0)
[18:12:00.495] Timer tick, asking Buildbucket for the build status
[18:12:00.547] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:00.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:175:0) after 1m0s
[18:13:00.602] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:175:0)
[18:13:00.602] Timer tick, asking Buildbucket for the build status
[18:13:00.677] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:00.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:176:0) after 1m0s
[18:14:00.703] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:176:0)
[18:14:00.703] Timer tick, asking Buildbucket for the build status
[18:14:00.763] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:00.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:177:0) after 1m0s
[18:15:00.787] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:177:0)
[18:15:00.787] Timer tick, asking Buildbucket for the build status
[18:15:00.932] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:00.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:178:0) after 1m0s
[18:16:00.972] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:178:0)
[18:16:00.972] Timer tick, asking Buildbucket for the build status
[18:16:01.019] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:01.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:179:0) after 1m0s
[18:17:01.042] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:179:0)
[18:17:01.042] Timer tick, asking Buildbucket for the build status
[18:17:01.248] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:01.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:180:0) after 1m0s
[18:18:01.275] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:180:0)
[18:18:01.275] Timer tick, asking Buildbucket for the build status
[18:18:01.403] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:01.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:181:0) after 1m0s
[18:19:01.435] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:181:0)
[18:19:01.435] Timer tick, asking Buildbucket for the build status
[18:19:01.589] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:01.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:182:0) after 1m0s
[18:20:01.619] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:182:0)
[18:20:01.619] Timer tick, asking Buildbucket for the build status
[18:20:01.863] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:01.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:183:0) after 1m0s
[18:21:01.886] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:183:0)
[18:21:01.886] Timer tick, asking Buildbucket for the build status
[18:21:01.929] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:01.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:184:0) after 1m0s
[18:22:01.976] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:184:0)
[18:22:01.976] Timer tick, asking Buildbucket for the build status
[18:22:02.074] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:02.074] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:185:0) after 1m0s
[18:23:02.103] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:185:0)
[18:23:02.103] Timer tick, asking Buildbucket for the build status
[18:23:02.153] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:02.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:186:0) after 1m0s
[18:24:02.193] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:186:0)
[18:24:02.193] Timer tick, asking Buildbucket for the build status
[18:24:02.385] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:02.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:187:0) after 1m0s
[18:25:02.425] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:187:0)
[18:25:02.425] Timer tick, asking Buildbucket for the build status
[18:25:02.464] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:02.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:188:0) after 1m0s
[18:26:02.491] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:188:0)
[18:26:02.491] Timer tick, asking Buildbucket for the build status
[18:26:02.571] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:02.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:189:0) after 1m0s
[18:27:02.594] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:189:0)
[18:27:02.594] Timer tick, asking Buildbucket for the build status
[18:27:02.640] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:02.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:190:0) after 1m0s
[18:28:02.662] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:190:0)
[18:28:02.662] Timer tick, asking Buildbucket for the build status
[18:28:02.773] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:02.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:191:0) after 1m0s
[18:29:02.798] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:191:0)
[18:29:02.798] Timer tick, asking Buildbucket for the build status
[18:29:02.857] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:02.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:192:0) after 1m0s
[18:30:02.893] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:192:0)
[18:30:02.893] Timer tick, asking Buildbucket for the build status
[18:30:02.940] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:02.940] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:193:0) after 1m0s
[18:31:02.962] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:193:0)
[18:31:02.962] Timer tick, asking Buildbucket for the build status
[18:31:03.376] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:03.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:194:0) after 1m0s
[18:32:03.399] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:194:0)
[18:32:03.399] Timer tick, asking Buildbucket for the build status
[18:32:03.462] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:03.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:195:0) after 1m0s
[18:33:03.491] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:195:0)
[18:33:03.491] Timer tick, asking Buildbucket for the build status
[18:33:03.564] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:03.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:196:0) after 1m0s
[18:34:03.588] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:196:0)
[18:34:03.588] Timer tick, asking Buildbucket for the build status
[18:34:03.693] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:03.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:197:0) after 1m0s
[18:35:03.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:197:0)
[18:35:03.844] Timer tick, asking Buildbucket for the build status
[18:35:03.954] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:03.954] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:198:0) after 1m0s
[18:36:04.037] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:198:0)
[18:36:04.037] Timer tick, asking Buildbucket for the build status
[18:36:04.104] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:04.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:199:0) after 1m0s
[18:37:04.135] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:199:0)
[18:37:04.135] Timer tick, asking Buildbucket for the build status
[18:37:04.179] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:04.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:200:0) after 1m0s
[18:38:04.336] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:200:0)
[18:38:04.336] Timer tick, asking Buildbucket for the build status
[18:38:04.476] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:04.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:201:0) after 1m0s
[18:39:04.498] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:201:0)
[18:39:04.498] Timer tick, asking Buildbucket for the build status
[18:39:04.565] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:04.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:202:0) after 1m0s
[18:40:04.679] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:202:0)
[18:40:04.679] Timer tick, asking Buildbucket for the build status
[18:40:04.796] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:04.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:203:0) after 1m0s
[18:41:04.928] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:203:0)
[18:41:04.928] Timer tick, asking Buildbucket for the build status
[18:41:05.038] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:05.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:204:0) after 1m0s
[18:42:05.119] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:204:0)
[18:42:05.119] Timer tick, asking Buildbucket for the build status
[18:42:05.183] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:05.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:205:0) after 1m0s
[18:43:05.211] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:205:0)
[18:43:05.211] Timer tick, asking Buildbucket for the build status
[18:43:05.283] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:05.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:206:0) after 1m0s
[18:44:05.337] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:206:0)
[18:44:05.337] Timer tick, asking Buildbucket for the build status
[18:44:05.569] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:05.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:207:0) after 1m0s
[18:45:05.599] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:207:0)
[18:45:05.599] Timer tick, asking Buildbucket for the build status
[18:45:05.666] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:05.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:208:0) after 1m0s
[18:46:05.781] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:208:0)
[18:46:05.781] Timer tick, asking Buildbucket for the build status
[18:46:06.116] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:06.116] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:209:0) after 1m0s
[18:47:06.146] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:209:0)
[18:47:06.146] Timer tick, asking Buildbucket for the build status
[18:47:06.199] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:06.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:210:0) after 1m0s
[18:48:06.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:210:0)
[18:48:06.238] Timer tick, asking Buildbucket for the build status
[18:48:06.380] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:06.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:211:0) after 1m0s
[18:49:06.419] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:211:0)
[18:49:06.419] Timer tick, asking Buildbucket for the build status
[18:49:06.591] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:06.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:212:0) after 1m0s
[18:50:06.616] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:212:0)
[18:50:06.616] Timer tick, asking Buildbucket for the build status
[18:50:06.766] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:06.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:213:0) after 1m0s
[18:51:06.789] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:213:0)
[18:51:06.789] Timer tick, asking Buildbucket for the build status
[18:51:06.860] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:06.860] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:214:0) after 1m0s
[18:52:06.908] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:214:0)
[18:52:06.908] Timer tick, asking Buildbucket for the build status
[18:52:07.003] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:07.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:215:0) after 1m0s
[18:53:07.034] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:215:0)
[18:53:07.034] Timer tick, asking Buildbucket for the build status
[18:53:07.137] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:07.137] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:216:0) after 1m0s
[18:54:07.161] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:216:0)
[18:54:07.161] Timer tick, asking Buildbucket for the build status
[18:54:07.265] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:07.265] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:217:0) after 1m0s
[18:55:07.297] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:217:0)
[18:55:07.297] Timer tick, asking Buildbucket for the build status
[18:55:07.379] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:07.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:218:0) after 1m0s
[18:56:07.428] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:218:0)
[18:56:07.428] Timer tick, asking Buildbucket for the build status
[18:56:07.565] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:07.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:219:0) after 1m0s
[18:57:07.593] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:219:0)
[18:57:07.593] Timer tick, asking Buildbucket for the build status
[18:57:07.681] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:07.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:220:0) after 1m0s
[18:58:07.705] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:220:0)
[18:58:07.705] Timer tick, asking Buildbucket for the build status
[18:58:07.769] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:07.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:221:0) after 1m0s
[18:59:07.801] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:221:0)
[18:59:07.801] Timer tick, asking Buildbucket for the build status
[18:59:07.959] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:07.959] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:222:0) after 1m0s
[19:00:07.996] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:222:0)
[19:00:07.996] Timer tick, asking Buildbucket for the build status
[19:00:08.254] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:08.254] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:223:0) after 1m0s
[19:01:08.341] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:223:0)
[19:01:08.341] Timer tick, asking Buildbucket for the build status
[19:01:08.598] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:08.598] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:224:0) after 1m0s
[19:02:08.668] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:224:0)
[19:02:08.668] Timer tick, asking Buildbucket for the build status
[19:02:08.893] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:08.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:225:0) after 1m0s
[19:03:08.917] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:225:0)
[19:03:08.917] Timer tick, asking Buildbucket for the build status
[19:03:09.010] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:09.010] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:226:0) after 1m0s
[19:04:09.107] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:226:0)
[19:04:09.107] Timer tick, asking Buildbucket for the build status
[19:04:09.156] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:09.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:227:0) after 1m0s
[19:05:09.180] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:227:0)
[19:05:09.180] Timer tick, asking Buildbucket for the build status
[19:05:09.371] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:09.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:228:0) after 1m0s
[19:06:09.474] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:228:0)
[19:06:09.474] Timer tick, asking Buildbucket for the build status
[19:06:09.681] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:09.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:229:0) after 1m0s
[19:07:09.710] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:229:0)
[19:07:09.710] Timer tick, asking Buildbucket for the build status
[19:07:09.757] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:09.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:230:0) after 1m0s
[19:08:09.864] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:230:0)
[19:08:09.864] Timer tick, asking Buildbucket for the build status
[19:08:09.983] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:09.983] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:231:0) after 1m0s
[19:09:10.013] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:231:0)
[19:09:10.013] Timer tick, asking Buildbucket for the build status
[19:09:10.061] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:10.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:232:0) after 1m0s
[19:10:10.103] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:232:0)
[19:10:10.103] Timer tick, asking Buildbucket for the build status
[19:10:10.152] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:10.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:233:0) after 1m0s
[19:11:10.177] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:233:0)
[19:11:10.177] Timer tick, asking Buildbucket for the build status
[19:11:10.244] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:10.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:234:0) after 1m0s
[19:12:10.277] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:234:0)
[19:12:10.277] Timer tick, asking Buildbucket for the build status
[19:12:10.347] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:10.347] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:235:0) after 1m0s
[19:13:10.447] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:235:0)
[19:13:10.447] Timer tick, asking Buildbucket for the build status
[19:13:10.493] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:10.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:236:0) after 1m0s
[19:14:10.587] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:236:0)
[19:14:10.587] Timer tick, asking Buildbucket for the build status
[19:14:10.634] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:10.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:237:0) after 1m0s
[19:15:10.705] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:237:0)
[19:15:10.705] Timer tick, asking Buildbucket for the build status
[19:15:10.801] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:10.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:238:0) after 1m0s
[19:16:10.828] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:238:0)
[19:16:10.828] Timer tick, asking Buildbucket for the build status
[19:16:10.876] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:10.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:239:0) after 1m0s
[19:17:10.904] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:239:0)
[19:17:10.904] Timer tick, asking Buildbucket for the build status
[19:17:10.974] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:10.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:240:0) after 1m0s
[19:18:11.000] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:240:0)
[19:18:11.000] Timer tick, asking Buildbucket for the build status
[19:18:11.093] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:11.093] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:241:0) after 1m0s
[19:19:11.119] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:241:0)
[19:19:11.119] Timer tick, asking Buildbucket for the build status
[19:19:11.423] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:11.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:242:0) after 1m0s
[19:20:11.466] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:242:0)
[19:20:11.466] Timer tick, asking Buildbucket for the build status
[19:20:11.512] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:11.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:243:0) after 1m0s
[19:21:11.543] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:243:0)
[19:21:11.543] Timer tick, asking Buildbucket for the build status
[19:21:11.595] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:11.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:244:0) after 1m0s
[19:22:11.639] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:244:0)
[19:22:11.639] Timer tick, asking Buildbucket for the build status
[19:22:11.706] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:11.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:245:0) after 1m0s
[19:23:11.733] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:245:0)
[19:23:11.733] Timer tick, asking Buildbucket for the build status
[19:23:11.823] Build 8923438230488088656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:11.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9088868292921404032:246:0) after 1m0s
[19:23:14.167] Received PubSub notification, asking Buildbucket for the build status
[19:23:14.376] Build 8923438230488088656: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[19:23:14.376] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "AUTO",
    "completed_ts": "1548357793286975",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1548343167753488",
    "failure_reason": "BUILD_FAILURE",
    "id": "8923438230488088656",
    "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\": \"b13f9c675f002215b711619f8e99cbcf90b84125\"}}",
    "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\": [\"4026-11b7a84\"], \"machine_type\": [\"n1-highcpu-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"vm316-m1\"], \"pool\": [\"luci.flex.ci\"], \"caches\": [\"builder_30037600afb0fc8938a6d537e3c45a46491e7159df17e0dae8492f75116b87ca_v2\", \"builder_5bf551a0d5d177b55ce526f99d0a6f2ea5c5827f96722dd0bf2e7c331b5e9e59_v2\", \"builder_78893cbd4c292ba203eb7a045a56252df7f14bd0ad3b7b91fac8bfee09f12c2b_v2\", \"builder_7ea55abfea25d314356d803a5f0ad62170c3dfd6004ffb0ffd94b75873d1ce3b_v2\", \"builder_f58e49d4978dd47022c74d62848afbffa29b3ee52aa79f0e76d160631af2bf15_v2\", \"builder_fa9d879aabe313024a0ba592a6a7867dc3149ebafcc9bdcf1ac65c59a572870d_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\": 100, \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"buildername\": \"linux-64-validator-opt\", \"got_revision\": \"b13f9c675f002215b711619f8e99cbcf90b84125\", \"recipe\": \"nacl\", \"mastername\": \"client.nacl\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1548343167753488, \"tags\": [\"builder:linux-64-validator-opt\", \"buildset:commit/git/b13f9c675f002215b711619f8e99cbcf90b84125\", \"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/b13f9c675f002215b711619f8e99cbcf90b84125\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9088868292921404032\", \"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\": \"8923438230488088656\"}}, \"slavetype\": \"BuilderTester\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"b13f9c675f002215b711619f8e99cbcf90b84125\", \"bot_id\": \"vm316-m1\"}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1548347067805524",
    "status": "COMPLETED",
    "status_changed_ts": "1548357793794553",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/100",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/b13f9c675f002215b711619f8e99cbcf90b84125",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/b13f9c675f002215b711619f8e99cbcf90b84125",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9088868292921404032",
      "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/100",
      "swarming_tag:buildbucket_bucket:nacl/ci",
      "swarming_tag:buildbucket_build_id:8923438230488088656",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
      "swarming_tag:builder:linux-64-validator-opt",
      "swarming_tag:buildset:commit/git/b13f9c675f002215b711619f8e99cbcf90b84125",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/b13f9c675f002215b711619f8e99cbcf90b84125",
      "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/8923438230488088656/+/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:9088868292921404032",
      "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:a883ea2343e81ad9b4be8c2424a65260c5b29a9f",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:42994354caa0b510",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1548357793796190",
    "url": "https://ci.chromium.org/b/8923438230488088656",
    "utcnow_ts": "1548357794359501"
  }
}
[19:23:14.376] Invocation finished in 4h3m48.326935856s with status FAILED