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

• 9f9b2606ff17614d49a8bcd854b52568e2891e8c (5 years ago)

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

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

[04:18:42.844] New invocation is queued and will start shortly
[04:18:44.108] Starting the invocation (attempt 1)
[04:18:44.155] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:18:44.155] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:18:44.155] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9050043763268780144",
  "parameters_json": "{\"builder_name\":\"linux-64-validator-opt\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"9f9b2606ff17614d49a8bcd854b52568e2891e8c\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@9f9b2606ff17614d49a8bcd854b52568e2891e8c\",\"title\":\"9f9b2606ff17614d49a8bcd854b52568e2891e8c\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}}",
  "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:9050043763268780144",
    "scheduler_job_id:nacl/linux-64-validator-opt",
    "user_agent:luci-scheduler",
    "buildset:commit/git/9f9b2606ff17614d49a8bcd854b52568e2891e8c",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f9b2606ff17614d49a8bcd854b52568e2891e8c",
    "gitiles_ref:refs/heads/master"
  ]
}
[04:18:45.005] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1585369124277029",
    "id": "8884613701100001264",
    "parameters_json": "{\"builder_name\": \"linux-64-validator-opt\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@9f9b2606ff17614d49a8bcd854b52568e2891e8c\", \"title\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1585369124821173",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/133",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/9f9b2606ff17614d49a8bcd854b52568e2891e8c",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f9b2606ff17614d49a8bcd854b52568e2891e8c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9050043763268780144",
      "scheduler_job_id:nacl/linux-64-validator-opt",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8884613701100001264/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1585369124821543",
    "url": "https://ci.chromium.org/b/8884613701100001264",
    "utcnow_ts": "1585369124970568"
  }
}
[04:18:45.005] Task URL: https://ci.chromium.org/b/8884613701100001264
[04:18:45.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:2:0) after 1m0s
[04:18:47.839] Received PubSub notification, asking Buildbucket for the build status
[04:18:47.982] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:46.106] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:2:0)
[04:19:46.106] Timer tick, asking Buildbucket for the build status
[04:19:46.274] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:46.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:4:0) after 1m0s
[04:20:46.446] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:4:0)
[04:20:46.446] Timer tick, asking Buildbucket for the build status
[04:20:46.543] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:46.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:5:0) after 1m0s
[04:21:46.914] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:5:0)
[04:21:46.914] Timer tick, asking Buildbucket for the build status
[04:21:47.083] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:47.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:6:0) after 1m0s
[04:22:47.202] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:6:0)
[04:22:47.202] Timer tick, asking Buildbucket for the build status
[04:22:47.340] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:47.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:7:0) after 1m0s
[04:23:47.519] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:7:0)
[04:23:47.519] Timer tick, asking Buildbucket for the build status
[04:23:47.736] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:47.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:8:0) after 1m0s
[04:24:48.448] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:8:0)
[04:24:48.448] Timer tick, asking Buildbucket for the build status
[04:24:48.679] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:48.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:9:0) after 1m0s
[04:25:48.994] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:9:0)
[04:25:48.994] Timer tick, asking Buildbucket for the build status
[04:25:49.190] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:49.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:10:0) after 1m0s
[04:26:49.226] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:10:0)
[04:26:49.226] Timer tick, asking Buildbucket for the build status
[04:26:49.440] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:49.440] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:11:0) after 1m0s
[04:27:49.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:11:0)
[04:27:49.486] Timer tick, asking Buildbucket for the build status
[04:27:49.673] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:49.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:12:0) after 1m0s
[04:28:49.732] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:12:0)
[04:28:49.732] Timer tick, asking Buildbucket for the build status
[04:28:49.897] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:49.897] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:13:0) after 1m0s
[04:29:49.953] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:13:0)
[04:29:49.953] Timer tick, asking Buildbucket for the build status
[04:29:50.067] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:50.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:14:0) after 1m0s
[04:30:50.129] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:14:0)
[04:30:50.129] Timer tick, asking Buildbucket for the build status
[04:30:50.304] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:50.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:15:0) after 1m0s
[04:31:50.338] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:15:0)
[04:31:50.338] Timer tick, asking Buildbucket for the build status
[04:31:50.430] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:50.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:16:0) after 1m0s
[04:32:50.581] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:16:0)
[04:32:50.581] Timer tick, asking Buildbucket for the build status
[04:32:50.722] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:50.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:17:0) after 1m0s
[04:33:50.842] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:17:0)
[04:33:50.842] Timer tick, asking Buildbucket for the build status
[04:33:51.640] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:51.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:18:0) after 1m0s
[04:34:51.664] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:18:0)
[04:34:51.664] Timer tick, asking Buildbucket for the build status
[04:34:51.845] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:51.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:19:0) after 1m0s
[04:35:51.875] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:19:0)
[04:35:51.875] Timer tick, asking Buildbucket for the build status
[04:35:52.034] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:52.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:20:0) after 1m0s
[04:36:52.049] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:20:0)
[04:36:52.049] Timer tick, asking Buildbucket for the build status
[04:36:52.289] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:52.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:21:0) after 1m0s
[04:37:52.319] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:21:0)
[04:37:52.319] Timer tick, asking Buildbucket for the build status
[04:37:52.467] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:52.467] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:22:0) after 1m0s
[04:38:52.500] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:22:0)
[04:38:52.500] Timer tick, asking Buildbucket for the build status
[04:38:52.774] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:52.774] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:23:0) after 1m0s
[04:39:52.863] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:23:0)
[04:39:52.863] Timer tick, asking Buildbucket for the build status
[04:39:53.009] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:53.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:24:0) after 1m0s
[04:40:53.250] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:24:0)
[04:40:53.250] Timer tick, asking Buildbucket for the build status
[04:40:53.412] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:53.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:25:0) after 1m0s
[04:41:53.557] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:25:0)
[04:41:53.557] Timer tick, asking Buildbucket for the build status
[04:41:53.672] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:53.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:26:0) after 1m0s
[04:42:53.944] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:26:0)
[04:42:53.944] Timer tick, asking Buildbucket for the build status
[04:42:54.132] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:54.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:27:0) after 1m0s
[04:43:54.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:27:0)
[04:43:54.272] Timer tick, asking Buildbucket for the build status
[04:43:54.736] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:54.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:28:0) after 1m0s
[04:44:54.757] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:28:0)
[04:44:54.757] Timer tick, asking Buildbucket for the build status
[04:44:54.916] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:54.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:29:0) after 1m0s
[04:45:54.941] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:29:0)
[04:45:54.941] Timer tick, asking Buildbucket for the build status
[04:45:55.108] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:55.108] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:30:0) after 1m0s
[04:46:55.158] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:30:0)
[04:46:55.158] Timer tick, asking Buildbucket for the build status
[04:46:55.266] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:55.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:31:0) after 1m0s
[04:47:55.334] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:31:0)
[04:47:55.334] Timer tick, asking Buildbucket for the build status
[04:47:55.453] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:55.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:32:0) after 1m0s
[04:48:55.535] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:32:0)
[04:48:55.535] Timer tick, asking Buildbucket for the build status
[04:48:55.624] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:55.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:33:0) after 1m0s
[04:49:55.727] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:33:0)
[04:49:55.727] Timer tick, asking Buildbucket for the build status
[04:49:56.081] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:56.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:34:0) after 1m0s
[04:50:56.204] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:34:0)
[04:50:56.204] Timer tick, asking Buildbucket for the build status
[04:50:56.341] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:56.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:35:0) after 1m0s
[04:51:56.535] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:35:0)
[04:51:56.535] Timer tick, asking Buildbucket for the build status
[04:51:56.658] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:56.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:36:0) after 1m0s
[04:52:56.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:36:0)
[04:52:56.738] Timer tick, asking Buildbucket for the build status
[04:52:56.854] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:56.854] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:37:0) after 1m0s
[04:53:56.832] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:37:0)
[04:53:56.832] Timer tick, asking Buildbucket for the build status
[04:53:56.899] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:56.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:38:0) after 1m0s
[04:54:56.982] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:38:0)
[04:54:56.982] Timer tick, asking Buildbucket for the build status
[04:54:57.092] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:57.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:39:0) after 1m0s
[04:55:57.271] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:39:0)
[04:55:57.271] Timer tick, asking Buildbucket for the build status
[04:55:57.400] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:57.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:40:0) after 1m0s
[04:56:57.475] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:40:0)
[04:56:57.475] Timer tick, asking Buildbucket for the build status
[04:56:57.537] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:57.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:41:0) after 1m0s
[04:57:57.719] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:41:0)
[04:57:57.719] Timer tick, asking Buildbucket for the build status
[04:57:57.890] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:57.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:42:0) after 1m0s
[04:58:57.974] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:42:0)
[04:58:57.974] Timer tick, asking Buildbucket for the build status
[04:58:58.098] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:58.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:43:0) after 1m0s
[04:59:58.400] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:43:0)
[04:59:58.400] Timer tick, asking Buildbucket for the build status
[04:59:58.512] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:58.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:44:0) after 1m0s
[05:00:58.539] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:44:0)
[05:00:58.539] Timer tick, asking Buildbucket for the build status
[05:00:58.693] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:58.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:45:0) after 1m0s
[05:01:58.816] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:45:0)
[05:01:58.816] Timer tick, asking Buildbucket for the build status
[05:01:59.065] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:59.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:46:0) after 1m0s
[05:02:59.182] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:46:0)
[05:02:59.182] Timer tick, asking Buildbucket for the build status
[05:02:59.402] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:59.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:47:0) after 1m0s
[05:03:59.438] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:47:0)
[05:03:59.438] Timer tick, asking Buildbucket for the build status
[05:03:59.570] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:59.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:48:0) after 1m0s
[05:04:59.650] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:48:0)
[05:04:59.650] Timer tick, asking Buildbucket for the build status
[05:04:59.741] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:59.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:49:0) after 1m0s
[05:05:59.769] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:49:0)
[05:05:59.769] Timer tick, asking Buildbucket for the build status
[05:06:00.135] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:00.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:50:0) after 1m0s
[05:07:00.265] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:50:0)
[05:07:00.265] Timer tick, asking Buildbucket for the build status
[05:07:00.426] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:00.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:51:0) after 1m0s
[05:08:00.441] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:51:0)
[05:08:00.441] Timer tick, asking Buildbucket for the build status
[05:08:00.634] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:00.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:52:0) after 1m0s
[05:09:00.709] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:52:0)
[05:09:00.709] Timer tick, asking Buildbucket for the build status
[05:09:01.059] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:01.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:53:0) after 1m0s
[05:10:01.084] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:53:0)
[05:10:01.084] Timer tick, asking Buildbucket for the build status
[05:10:01.458] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:01.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:54:0) after 1m0s
[05:11:01.607] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:54:0)
[05:11:01.607] Timer tick, asking Buildbucket for the build status
[05:11:01.739] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:01.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:55:0) after 1m0s
[05:12:01.769] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:55:0)
[05:12:01.769] Timer tick, asking Buildbucket for the build status
[05:12:01.928] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:01.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:56:0) after 1m0s
[05:13:02.086] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:56:0)
[05:13:02.086] Timer tick, asking Buildbucket for the build status
[05:13:02.208] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:02.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:57:0) after 1m0s
[05:14:02.401] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:57:0)
[05:14:02.401] Timer tick, asking Buildbucket for the build status
[05:14:02.606] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:02.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:58:0) after 1m0s
[05:15:02.852] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:58:0)
[05:15:02.852] Timer tick, asking Buildbucket for the build status
[05:15:02.939] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:02.939] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:59:0) after 1m0s
[05:16:02.936] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:59:0)
[05:16:02.936] Timer tick, asking Buildbucket for the build status
[05:16:03.045] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:03.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:60:0) after 1m0s
[05:17:03.189] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:60:0)
[05:17:03.189] Timer tick, asking Buildbucket for the build status
[05:17:03.363] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:03.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:61:0) after 1m0s
[05:18:03.505] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:61:0)
[05:18:03.505] Timer tick, asking Buildbucket for the build status
[05:18:03.608] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:03.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:62:0) after 1m0s
[05:19:03.615] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:62:0)
[05:19:03.615] Timer tick, asking Buildbucket for the build status
[05:19:03.763] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:03.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:63:0) after 1m0s
[05:20:03.828] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:63:0)
[05:20:03.828] Timer tick, asking Buildbucket for the build status
[05:20:04.740] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:04.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:64:0) after 1m0s
[05:21:04.910] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:64:0)
[05:21:04.910] Timer tick, asking Buildbucket for the build status
[05:21:04.984] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:04.984] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:65:0) after 1m0s
[05:22:05.220] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:65:0)
[05:22:05.220] Timer tick, asking Buildbucket for the build status
[05:22:05.483] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:05.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:66:0) after 1m0s
[05:23:05.664] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:66:0)
[05:23:05.665] Timer tick, asking Buildbucket for the build status
[05:23:05.822] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:05.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:67:0) after 1m0s
[05:24:05.914] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:67:0)
[05:24:05.914] Timer tick, asking Buildbucket for the build status
[05:24:06.247] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:06.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:68:0) after 1m0s
[05:25:06.882] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:68:0)
[05:25:06.882] Timer tick, asking Buildbucket for the build status
[05:25:07.043] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:07.043] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:69:0) after 1m0s
[05:26:07.066] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:69:0)
[05:26:07.066] Timer tick, asking Buildbucket for the build status
[05:26:07.262] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:07.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:70:0) after 1m0s
[05:27:07.335] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:70:0)
[05:27:07.335] Timer tick, asking Buildbucket for the build status
[05:27:07.582] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:07.582] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:71:0) after 1m0s
[05:28:07.643] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:71:0)
[05:28:07.643] Timer tick, asking Buildbucket for the build status
[05:28:07.829] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:07.829] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:72:0) after 1m0s
[05:29:07.914] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:72:0)
[05:29:07.914] Timer tick, asking Buildbucket for the build status
[05:29:08.029] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:08.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:73:0) after 1m0s
[05:30:08.033] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:73:0)
[05:30:08.033] Timer tick, asking Buildbucket for the build status
[05:30:08.184] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:08.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:74:0) after 1m0s
[05:31:08.207] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:74:0)
[05:31:08.207] Timer tick, asking Buildbucket for the build status
[05:31:08.324] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:08.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:75:0) after 1m0s
[05:32:09.303] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:75:0)
[05:32:09.303] Timer tick, asking Buildbucket for the build status
[05:32:09.426] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:09.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:76:0) after 1m0s
[05:33:09.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:76:0)
[05:33:09.544] Timer tick, asking Buildbucket for the build status
[05:33:09.915] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:09.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:77:0) after 1m0s
[05:34:10.228] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:77:0)
[05:34:10.228] Timer tick, asking Buildbucket for the build status
[05:34:10.407] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:10.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:78:0) after 1m0s
[05:35:10.501] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:78:0)
[05:35:10.501] Timer tick, asking Buildbucket for the build status
[05:35:10.671] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:10.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:79:0) after 1m0s
[05:36:10.778] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:79:0)
[05:36:10.778] Timer tick, asking Buildbucket for the build status
[05:36:10.909] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:10.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:80:0) after 1m0s
[05:37:11.048] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:80:0)
[05:37:11.048] Timer tick, asking Buildbucket for the build status
[05:37:11.426] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:11.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:81:0) after 1m0s
[05:38:11.463] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:81:0)
[05:38:11.463] Timer tick, asking Buildbucket for the build status
[05:38:11.838] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:11.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:82:0) after 1m0s
[05:39:11.818] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:82:0)
[05:39:11.818] Timer tick, asking Buildbucket for the build status
[05:39:11.948] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:11.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:83:0) after 1m0s
[05:40:12.051] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:83:0)
[05:40:12.051] Timer tick, asking Buildbucket for the build status
[05:40:12.195] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:12.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:84:0) after 1m0s
[05:41:12.345] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:84:0)
[05:41:12.345] Timer tick, asking Buildbucket for the build status
[05:41:12.834] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:12.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:85:0) after 1m0s
[05:42:12.860] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:85:0)
[05:42:12.860] Timer tick, asking Buildbucket for the build status
[05:42:12.961] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:12.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:86:0) after 1m0s
[05:43:12.987] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:86:0)
[05:43:12.987] Timer tick, asking Buildbucket for the build status
[05:43:13.179] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:13.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:87:0) after 1m0s
[05:44:13.311] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:87:0)
[05:44:13.311] Timer tick, asking Buildbucket for the build status
[05:44:13.412] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:13.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:88:0) after 1m0s
[05:45:13.581] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:88:0)
[05:45:13.581] Timer tick, asking Buildbucket for the build status
[05:45:13.701] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:13.701] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:89:0) after 1m0s
[05:46:13.800] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:89:0)
[05:46:13.800] Timer tick, asking Buildbucket for the build status
[05:46:13.931] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:13.931] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:90:0) after 1m0s
[05:47:13.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:90:0)
[05:47:13.960] Timer tick, asking Buildbucket for the build status
[05:47:14.365] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:14.365] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:91:0) after 1m0s
[05:48:14.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:91:0)
[05:48:14.486] Timer tick, asking Buildbucket for the build status
[05:48:15.242] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:15.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:92:0) after 1m0s
[05:49:15.284] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:92:0)
[05:49:15.284] Timer tick, asking Buildbucket for the build status
[05:49:15.436] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:15.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:93:0) after 1m0s
[05:50:15.460] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:93:0)
[05:50:15.460] Timer tick, asking Buildbucket for the build status
[05:50:15.577] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:15.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:94:0) after 1m0s
[05:51:15.612] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:94:0)
[05:51:15.612] Timer tick, asking Buildbucket for the build status
[05:51:15.766] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:15.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:95:0) after 1m0s
[05:52:15.795] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:95:0)
[05:52:15.795] Timer tick, asking Buildbucket for the build status
[05:52:15.916] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:15.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:96:0) after 1m0s
[05:53:16.034] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:96:0)
[05:53:16.034] Timer tick, asking Buildbucket for the build status
[05:53:17.615] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:17.615] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:97:0) after 1m0s
[05:54:17.705] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:97:0)
[05:54:17.705] Timer tick, asking Buildbucket for the build status
[05:54:17.840] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:17.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:98:0) after 1m0s
[05:55:17.936] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:98:0)
[05:55:17.936] Timer tick, asking Buildbucket for the build status
[05:55:18.088] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:18.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:99:0) after 1m0s
[05:56:18.087] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:99:0)
[05:56:18.087] Timer tick, asking Buildbucket for the build status
[05:56:18.303] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:18.303] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:100:0) after 1m0s
[05:57:18.316] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:100:0)
[05:57:18.316] Timer tick, asking Buildbucket for the build status
[05:57:18.450] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:18.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:101:0) after 1m0s
[05:58:18.513] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:101:0)
[05:58:18.513] Timer tick, asking Buildbucket for the build status
[05:58:18.998] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:18.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:102:0) after 1m0s
[05:59:19.062] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:102:0)
[05:59:19.062] Timer tick, asking Buildbucket for the build status
[05:59:19.322] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:19.322] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:103:0) after 1m0s
[06:00:19.398] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:103:0)
[06:00:19.398] Timer tick, asking Buildbucket for the build status
[06:00:19.546] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:19.546] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:104:0) after 1m0s
[06:01:19.741] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:104:0)
[06:01:19.741] Timer tick, asking Buildbucket for the build status
[06:01:19.866] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:19.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:105:0) after 1m0s
[06:02:19.977] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:105:0)
[06:02:19.977] Timer tick, asking Buildbucket for the build status
[06:02:20.153] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:20.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:106:0) after 1m0s
[06:03:20.211] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:106:0)
[06:03:20.211] Timer tick, asking Buildbucket for the build status
[06:03:20.975] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:20.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:107:0) after 1m0s
[06:04:20.999] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:107:0)
[06:04:20.999] Timer tick, asking Buildbucket for the build status
[06:04:21.149] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:21.149] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:108:0) after 1m0s
[06:05:21.189] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:108:0)
[06:05:21.189] Timer tick, asking Buildbucket for the build status
[06:05:21.621] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:21.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:109:0) after 1m0s
[06:06:21.730] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:109:0)
[06:06:21.730] Timer tick, asking Buildbucket for the build status
[06:06:22.102] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:22.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:110:0) after 1m0s
[06:07:22.211] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:110:0)
[06:07:22.211] Timer tick, asking Buildbucket for the build status
[06:07:22.465] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:22.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:111:0) after 1m0s
[06:08:22.526] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:111:0)
[06:08:22.526] Timer tick, asking Buildbucket for the build status
[06:08:22.820] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:22.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:112:0) after 1m0s
[06:09:22.891] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:112:0)
[06:09:22.891] Timer tick, asking Buildbucket for the build status
[06:09:23.092] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:23.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:113:0) after 1m0s
[06:10:23.115] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:113:0)
[06:10:23.115] Timer tick, asking Buildbucket for the build status
[06:10:23.239] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:23.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:114:0) after 1m0s
[06:11:23.264] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:114:0)
[06:11:23.264] Timer tick, asking Buildbucket for the build status
[06:11:23.587] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:23.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:115:0) after 1m0s
[06:12:23.634] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:115:0)
[06:12:23.634] Timer tick, asking Buildbucket for the build status
[06:12:23.827] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:23.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:116:0) after 1m0s
[06:13:23.812] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:116:0)
[06:13:23.812] Timer tick, asking Buildbucket for the build status
[06:13:24.138] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:24.138] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:117:0) after 1m0s
[06:14:24.225] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:117:0)
[06:14:24.225] Timer tick, asking Buildbucket for the build status
[06:14:24.429] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:24.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:118:0) after 1m0s
[06:15:24.456] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:118:0)
[06:15:24.456] Timer tick, asking Buildbucket for the build status
[06:15:24.598] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:24.598] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:119:0) after 1m0s
[06:16:24.630] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:119:0)
[06:16:24.630] Timer tick, asking Buildbucket for the build status
[06:16:24.780] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:24.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:120:0) after 1m0s
[06:17:24.806] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:120:0)
[06:17:24.806] Timer tick, asking Buildbucket for the build status
[06:17:24.925] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:24.925] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:121:0) after 1m0s
[06:18:25.013] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:121:0)
[06:18:25.013] Timer tick, asking Buildbucket for the build status
[06:18:25.752] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:25.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:122:0) after 1m0s
[06:19:25.804] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:122:0)
[06:19:25.804] Timer tick, asking Buildbucket for the build status
[06:19:26.111] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:26.111] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:123:0) after 1m0s
[06:20:26.342] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:123:0)
[06:20:26.342] Timer tick, asking Buildbucket for the build status
[06:20:26.524] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:26.524] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:124:0) after 1m0s
[06:21:26.766] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:124:0)
[06:21:26.766] Timer tick, asking Buildbucket for the build status
[06:21:26.963] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:26.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:125:0) after 1m0s
[06:22:26.989] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:125:0)
[06:22:26.989] Timer tick, asking Buildbucket for the build status
[06:22:27.146] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:27.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:126:0) after 1m0s
[06:23:27.187] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:126:0)
[06:23:27.187] Timer tick, asking Buildbucket for the build status
[06:23:28.166] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:28.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:127:0) after 1m0s
[06:24:28.197] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:127:0)
[06:24:28.197] Timer tick, asking Buildbucket for the build status
[06:24:28.325] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:28.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:128:0) after 1m0s
[06:25:28.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:128:0)
[06:25:28.517] Timer tick, asking Buildbucket for the build status
[06:25:28.642] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:28.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:129:0) after 1m0s
[06:26:28.767] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:129:0)
[06:26:28.767] Timer tick, asking Buildbucket for the build status
[06:26:28.915] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:28.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:130:0) after 1m0s
[06:27:28.952] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:130:0)
[06:27:28.952] Timer tick, asking Buildbucket for the build status
[06:27:29.152] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:29.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:131:0) after 1m0s
[06:28:29.279] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:131:0)
[06:28:29.279] Timer tick, asking Buildbucket for the build status
[06:28:30.487] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:30.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:132:0) after 1m0s
[06:29:30.563] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:132:0)
[06:29:30.563] Timer tick, asking Buildbucket for the build status
[06:29:30.710] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:30.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:133:0) after 1m0s
[06:30:30.804] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:133:0)
[06:30:30.804] Timer tick, asking Buildbucket for the build status
[06:30:30.964] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:30.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:134:0) after 1m0s
[06:31:30.991] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:134:0)
[06:31:30.991] Timer tick, asking Buildbucket for the build status
[06:31:31.213] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:31.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:135:0) after 1m0s
[06:32:31.331] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:135:0)
[06:32:31.331] Timer tick, asking Buildbucket for the build status
[06:32:31.690] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:31.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:136:0) after 1m0s
[06:33:31.718] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:136:0)
[06:33:31.718] Timer tick, asking Buildbucket for the build status
[06:33:31.978] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:31.978] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:137:0) after 1m0s
[06:34:32.032] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:137:0)
[06:34:32.032] Timer tick, asking Buildbucket for the build status
[06:34:32.227] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:32.227] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:138:0) after 1m0s
[06:35:32.275] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:138:0)
[06:35:32.275] Timer tick, asking Buildbucket for the build status
[06:35:32.446] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:32.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:139:0) after 1m0s
[06:36:32.533] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:139:0)
[06:36:32.533] Timer tick, asking Buildbucket for the build status
[06:36:32.715] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:32.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:140:0) after 1m0s
[06:37:32.786] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:140:0)
[06:37:32.786] Timer tick, asking Buildbucket for the build status
[06:37:32.948] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:32.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:141:0) after 1m0s
[06:38:33.185] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:141:0)
[06:38:33.185] Timer tick, asking Buildbucket for the build status
[06:38:36.832] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:36.832] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:142:0) after 1m0s
[06:39:37.011] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:142:0)
[06:39:37.011] Timer tick, asking Buildbucket for the build status
[06:39:37.402] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:37.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:143:0) after 1m0s
[06:40:37.393] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:143:0)
[06:40:37.393] Timer tick, asking Buildbucket for the build status
[06:40:37.654] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:37.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:144:0) after 1m0s
[06:41:37.688] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:144:0)
[06:41:37.688] Timer tick, asking Buildbucket for the build status
[06:41:37.813] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:37.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:145:0) after 1m0s
[06:42:37.853] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:145:0)
[06:42:37.853] Timer tick, asking Buildbucket for the build status
[06:42:37.989] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:37.989] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:146:0) after 1m0s
[06:43:38.077] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:146:0)
[06:43:38.077] Timer tick, asking Buildbucket for the build status
[06:43:38.225] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:38.225] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:147:0) after 1m0s
[06:44:38.387] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:147:0)
[06:44:38.387] Timer tick, asking Buildbucket for the build status
[06:44:38.654] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:38.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:148:0) after 1m0s
[06:45:38.711] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:148:0)
[06:45:38.711] Timer tick, asking Buildbucket for the build status
[06:45:38.892] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:38.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:149:0) after 1m0s
[06:46:38.986] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:149:0)
[06:46:38.986] Timer tick, asking Buildbucket for the build status
[06:46:40.350] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:40.350] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:150:0) after 1m0s
[06:47:40.502] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:150:0)
[06:47:40.502] Timer tick, asking Buildbucket for the build status
[06:47:40.629] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:40.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:151:0) after 1m0s
[06:48:40.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:151:0)
[06:48:40.738] Timer tick, asking Buildbucket for the build status
[06:48:40.857] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:40.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:152:0) after 1m0s
[06:49:40.979] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:152:0)
[06:49:40.979] Timer tick, asking Buildbucket for the build status
[06:49:41.121] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:41.121] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:153:0) after 1m0s
[06:50:41.160] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:153:0)
[06:50:41.160] Timer tick, asking Buildbucket for the build status
[06:50:41.380] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:41.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:154:0) after 1m0s
[06:51:41.367] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:154:0)
[06:51:41.367] Timer tick, asking Buildbucket for the build status
[06:51:41.810] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:41.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:155:0) after 1m0s
[06:52:41.886] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:155:0)
[06:52:41.886] Timer tick, asking Buildbucket for the build status
[06:52:42.266] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:42.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:156:0) after 1m0s
[06:53:42.323] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:156:0)
[06:53:42.323] Timer tick, asking Buildbucket for the build status
[06:53:43.724] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:43.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:157:0) after 1m0s
[06:54:44.653] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:157:0)
[06:54:44.653] Timer tick, asking Buildbucket for the build status
[06:54:44.839] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:44.839] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:158:0) after 1m0s
[06:55:44.921] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:158:0)
[06:55:44.921] Timer tick, asking Buildbucket for the build status
[06:55:45.080] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:45.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:159:0) after 1m0s
[06:56:45.469] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:159:0)
[06:56:45.469] Timer tick, asking Buildbucket for the build status
[06:56:45.699] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:45.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:160:0) after 1m0s
[06:57:45.795] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:160:0)
[06:57:45.795] Timer tick, asking Buildbucket for the build status
[06:57:45.916] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:45.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:161:0) after 1m0s
[06:58:46.181] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:161:0)
[06:58:46.181] Timer tick, asking Buildbucket for the build status
[06:58:46.382] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:46.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:162:0) after 1m0s
[06:59:46.601] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:162:0)
[06:59:46.601] Timer tick, asking Buildbucket for the build status
[06:59:46.875] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:46.875] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:163:0) after 1m0s
[07:00:47.114] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:163:0)
[07:00:47.114] Timer tick, asking Buildbucket for the build status
[07:00:47.307] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:47.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:164:0) after 1m0s
[07:01:47.309] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:164:0)
[07:01:47.309] Timer tick, asking Buildbucket for the build status
[07:01:47.454] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:47.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:165:0) after 1m0s
[07:02:47.550] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:165:0)
[07:02:47.550] Timer tick, asking Buildbucket for the build status
[07:02:47.684] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:47.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:166:0) after 1m0s
[07:03:47.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:166:0)
[07:03:47.745] Timer tick, asking Buildbucket for the build status
[07:03:47.994] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:47.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:167:0) after 1m0s
[07:04:48.057] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:167:0)
[07:04:48.057] Timer tick, asking Buildbucket for the build status
[07:04:48.281] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:48.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:168:0) after 1m0s
[07:05:48.331] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:168:0)
[07:05:48.331] Timer tick, asking Buildbucket for the build status
[07:05:48.593] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:48.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:169:0) after 1m0s
[07:06:48.655] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:169:0)
[07:06:48.655] Timer tick, asking Buildbucket for the build status
[07:06:48.770] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:48.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:170:0) after 1m0s
[07:07:48.858] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:170:0)
[07:07:48.858] Timer tick, asking Buildbucket for the build status
[07:07:49.077] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:49.077] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:171:0) after 1m0s
[07:08:49.104] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:171:0)
[07:08:49.104] Timer tick, asking Buildbucket for the build status
[07:08:49.216] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:49.216] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:172:0) after 1m0s
[07:09:49.307] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:172:0)
[07:09:49.307] Timer tick, asking Buildbucket for the build status
[07:09:49.605] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:49.605] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:173:0) after 1m0s
[07:10:49.671] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:173:0)
[07:10:49.671] Timer tick, asking Buildbucket for the build status
[07:10:49.877] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:49.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:174:0) after 1m0s
[07:11:49.902] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:174:0)
[07:11:49.902] Timer tick, asking Buildbucket for the build status
[07:11:50.015] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:50.016] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:175:0) after 1m0s
[07:12:50.134] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:175:0)
[07:12:50.134] Timer tick, asking Buildbucket for the build status
[07:12:50.357] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:50.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:176:0) after 1m0s
[07:13:50.424] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:176:0)
[07:13:50.424] Timer tick, asking Buildbucket for the build status
[07:13:50.615] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:50.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:177:0) after 1m0s
[07:14:50.667] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:177:0)
[07:14:50.667] Timer tick, asking Buildbucket for the build status
[07:14:50.816] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:50.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:178:0) after 1m0s
[07:15:50.860] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:178:0)
[07:15:50.860] Timer tick, asking Buildbucket for the build status
[07:15:51.244] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:51.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:179:0) after 1m0s
[07:16:51.287] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:179:0)
[07:16:51.287] Timer tick, asking Buildbucket for the build status
[07:16:51.589] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:51.590] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:180:0) after 1m0s
[07:17:51.646] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:180:0)
[07:17:51.646] Timer tick, asking Buildbucket for the build status
[07:17:51.998] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:51.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:181:0) after 1m0s
[07:18:52.072] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:181:0)
[07:18:52.072] Timer tick, asking Buildbucket for the build status
[07:18:52.314] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:52.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:182:0) after 1m0s
[07:19:52.547] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:182:0)
[07:19:52.548] Timer tick, asking Buildbucket for the build status
[07:19:53.118] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:53.118] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:183:0) after 1m0s
[07:20:53.166] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:183:0)
[07:20:53.166] Timer tick, asking Buildbucket for the build status
[07:20:53.350] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:53.350] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:184:0) after 1m0s
[07:21:53.406] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:184:0)
[07:21:53.406] Timer tick, asking Buildbucket for the build status
[07:21:53.758] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:53.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:185:0) after 1m0s
[07:22:53.889] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:185:0)
[07:22:53.889] Timer tick, asking Buildbucket for the build status
[07:22:54.285] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:54.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:186:0) after 1m0s
[07:23:54.421] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:186:0)
[07:23:54.421] Timer tick, asking Buildbucket for the build status
[07:23:54.643] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:54.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:187:0) after 1m0s
[07:24:54.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:187:0)
[07:24:54.788] Timer tick, asking Buildbucket for the build status
[07:24:55.259] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:55.259] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:188:0) after 1m0s
[07:25:55.356] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:188:0)
[07:25:55.356] Timer tick, asking Buildbucket for the build status
[07:25:55.589] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:55.589] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:189:0) after 1m0s
[07:26:55.615] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:189:0)
[07:26:55.615] Timer tick, asking Buildbucket for the build status
[07:26:55.767] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:55.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:190:0) after 1m0s
[07:27:55.899] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:190:0)
[07:27:55.899] Timer tick, asking Buildbucket for the build status
[07:27:56.089] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:56.089] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:191:0) after 1m0s
[07:28:56.121] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:191:0)
[07:28:56.121] Timer tick, asking Buildbucket for the build status
[07:28:56.248] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:56.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:192:0) after 1m0s
[07:29:56.292] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:192:0)
[07:29:56.292] Timer tick, asking Buildbucket for the build status
[07:29:57.954] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:57.954] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:193:0) after 1m0s
[07:30:58.144] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:193:0)
[07:30:58.144] Timer tick, asking Buildbucket for the build status
[07:30:58.282] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:58.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:194:0) after 1m0s
[07:31:58.393] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:194:0)
[07:31:58.393] Timer tick, asking Buildbucket for the build status
[07:31:58.798] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:58.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:195:0) after 1m0s
[07:32:59.208] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:195:0)
[07:32:59.208] Timer tick, asking Buildbucket for the build status
[07:32:59.474] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:59.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:196:0) after 1m0s
[07:33:59.527] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:196:0)
[07:33:59.527] Timer tick, asking Buildbucket for the build status
[07:33:59.691] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:59.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:197:0) after 1m0s
[07:34:59.718] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:197:0)
[07:34:59.718] Timer tick, asking Buildbucket for the build status
[07:34:59.882] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:59.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:198:0) after 1m0s
[07:35:59.976] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:198:0)
[07:35:59.976] Timer tick, asking Buildbucket for the build status
[07:36:00.147] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:00.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:199:0) after 1m0s
[07:37:00.321] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:199:0)
[07:37:00.321] Timer tick, asking Buildbucket for the build status
[07:37:00.572] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:00.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:200:0) after 1m0s
[07:38:00.665] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:200:0)
[07:38:00.665] Timer tick, asking Buildbucket for the build status
[07:38:01.175] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:01.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:201:0) after 1m0s
[07:39:01.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:201:0)
[07:39:01.251] Timer tick, asking Buildbucket for the build status
[07:39:01.722] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:01.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:202:0) after 1m0s
[07:40:01.815] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:202:0)
[07:40:01.815] Timer tick, asking Buildbucket for the build status
[07:40:02.002] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:02.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:203:0) after 1m0s
[07:41:02.179] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:203:0)
[07:41:02.179] Timer tick, asking Buildbucket for the build status
[07:41:02.360] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:02.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:204:0) after 1m0s
[07:42:02.420] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:204:0)
[07:42:02.420] Timer tick, asking Buildbucket for the build status
[07:42:02.644] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:02.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:205:0) after 1m0s
[07:43:02.764] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:205:0)
[07:43:02.764] Timer tick, asking Buildbucket for the build status
[07:43:05.096] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:05.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:206:0) after 1m0s
[07:44:05.359] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:206:0)
[07:44:05.359] Timer tick, asking Buildbucket for the build status
[07:44:05.482] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:05.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:207:0) after 1m0s
[07:45:05.730] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:207:0)
[07:45:05.730] Timer tick, asking Buildbucket for the build status
[07:45:06.272] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:06.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:208:0) after 1m0s
[07:46:06.362] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:208:0)
[07:46:06.362] Timer tick, asking Buildbucket for the build status
[07:46:06.599] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:06.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:209:0) after 1m0s
[07:47:06.658] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:209:0)
[07:47:06.658] Timer tick, asking Buildbucket for the build status
[07:47:06.795] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:06.795] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:210:0) after 1m0s
[07:48:06.892] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:210:0)
[07:48:06.892] Timer tick, asking Buildbucket for the build status
[07:48:07.904] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:07.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:211:0) after 1m0s
[07:49:08.041] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:211:0)
[07:49:08.041] Timer tick, asking Buildbucket for the build status
[07:49:08.201] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:08.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:212:0) after 1m0s
[07:50:08.318] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:212:0)
[07:50:08.318] Timer tick, asking Buildbucket for the build status
[07:50:08.650] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:08.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:213:0) after 1m0s
[07:51:08.726] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:213:0)
[07:51:08.726] Timer tick, asking Buildbucket for the build status
[07:51:08.959] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:08.959] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:214:0) after 1m0s
[07:52:08.971] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:214:0)
[07:52:08.971] Timer tick, asking Buildbucket for the build status
[07:52:09.205] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:09.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:215:0) after 1m0s
[07:53:09.289] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:215:0)
[07:53:09.289] Timer tick, asking Buildbucket for the build status
[07:53:09.489] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:09.489] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:216:0) after 1m0s
[07:54:09.678] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:216:0)
[07:54:09.678] Timer tick, asking Buildbucket for the build status
[07:54:09.848] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:09.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:217:0) after 1m0s
[07:55:09.942] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:217:0)
[07:55:09.942] Timer tick, asking Buildbucket for the build status
[07:55:10.122] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:10.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:218:0) after 1m0s
[07:56:10.379] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:218:0)
[07:56:10.379] Timer tick, asking Buildbucket for the build status
[07:56:10.614] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:10.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:219:0) after 1m0s
[07:57:10.746] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:219:0)
[07:57:10.746] Timer tick, asking Buildbucket for the build status
[07:57:11.027] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:11.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:220:0) after 1m0s
[07:58:11.191] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:220:0)
[07:58:11.191] Timer tick, asking Buildbucket for the build status
[07:58:11.268] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:11.268] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:221:0) after 1m0s
[07:59:11.446] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:221:0)
[07:59:11.446] Timer tick, asking Buildbucket for the build status
[07:59:11.572] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:11.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:222:0) after 1m0s
[08:00:11.628] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:222:0)
[08:00:11.628] Timer tick, asking Buildbucket for the build status
[08:00:11.965] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:11.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:223:0) after 1m0s
[08:01:12.161] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:223:0)
[08:01:12.161] Timer tick, asking Buildbucket for the build status
[08:01:12.309] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:12.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:224:0) after 1m0s
[08:02:12.332] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:224:0)
[08:02:12.332] Timer tick, asking Buildbucket for the build status
[08:02:12.759] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:12.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:225:0) after 1m0s
[08:03:12.816] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:225:0)
[08:03:12.816] Timer tick, asking Buildbucket for the build status
[08:03:13.012] Build 8884613701100001264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:13.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9050043763268780144:226:0) after 1m0s
[08:03:46.880] Received PubSub notification, asking Buildbucket for the build status
[08:03:47.144] Build 8884613701100001264: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:03:47.145] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "completed_ts": "1585382626200326",
    "created_by": "project:nacl",
    "created_ts": "1585369124277029",
    "failure_reason": "BUILD_FAILURE",
    "id": "8884613701100001264",
    "parameters_json": "{\"builder_name\": \"linux-64-validator-opt\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@9f9b2606ff17614d49a8bcd854b52568e2891e8c\", \"title\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"Step('annotated steps') (retcode: 1)\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@9f9b2606ff17614d49a8bcd854b52568e2891e8c\", \"title\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/9f9b2606ff17614d49a8bcd854b52568e2891e8c\"}]}, \"bot_id\": \"luci-flex-ci-xenial-3-rmrm\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-64-validator-opt\", \"buildnumber\": 133, \"got_revision\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\", \"mastername\": \"client.nacl\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"9f9b2606ff17614d49a8bcd854b52568e2891e8c\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_41bff59e48143683eee7e209c35176da7d4c8f0bf6fc4cc531114b3142934c50_v2\", \"builder_5bf551a0d5d177b55ce526f99d0a6f2ea5c5827f96722dd0bf2e7c331b5e9e59_v2\", \"builder_78893cbd4c292ba203eb7a045a56252df7f14bd0ad3b7b91fac8bfee09f12c2b_v2\", \"builder_7ea55abfea25d314356d803a5f0ad62170c3dfd6004ffb0ffd94b75873d1ce3b_v2\", \"builder_faaedc22e3ac6fec098652e7f0fd10d4f879f8f9ad55ea8ef979585009ee36da_v2\", \"git\", \"goma_v2\", \"infra_gclient_with_go\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-flex-ci-xenial-3-rmrm\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.flex.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4901-91f024a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"Step('annotated steps') (retcode: 1)\"}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1585369126686664",
    "status": "COMPLETED",
    "status_changed_ts": "1585369127268090",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/133",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/9f9b2606ff17614d49a8bcd854b52568e2891e8c",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/9f9b2606ff17614d49a8bcd854b52568e2891e8c",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9050043763268780144",
      "scheduler_job_id:nacl/linux-64-validator-opt",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8884613701100001264/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:4b382e99926e5310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1585382626447947",
    "url": "https://ci.chromium.org/b/8884613701100001264",
    "utcnow_ts": "1585382627086150"
  }
}
[08:03:47.145] Invocation finished in 3h45m4.319886494s with status FAILED