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

Status: SUCCEEDED

Triggered by: -

Duration: 10 hours

Actions:

Definition (rev 8647dce0c5b1812bd57953fb611ed390e849ac26)

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

Incoming triggers

4de55da44c4b511989359381e8b7a88a01fe0634 (4 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[19:00:05.903] New invocation is queued and will start shortly
[19:00:07.092] Starting the invocation (attempt 1)
[19:00:07.143] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:00:07.143] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:00:07.143] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9021178476043677200",
  "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\":\"4de55da44c4b511989359381e8b7a88a01fe0634\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4de55da44c4b511989359381e8b7a88a01fe0634\",\"title\":\"4de55da44c4b511989359381e8b7a88a01fe0634\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/4de55da44c4b511989359381e8b7a88a01fe0634\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"4de55da44c4b511989359381e8b7a88a01fe0634\"}}",
  "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:9021178476043677200",
    "scheduler_job_id:nacl/linux-64-validator-opt",
    "user_agent:luci-scheduler",
    "buildset:commit/git/4de55da44c4b511989359381e8b7a88a01fe0634",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/4de55da44c4b511989359381e8b7a88a01fe0634",
    "gitiles_ref:refs/heads/master"
  ]
}
[19:00:08.612] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1612897207379926",
    "id": "8855748413834025792",
    "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\": \"4de55da44c4b511989359381e8b7a88a01fe0634\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4de55da44c4b511989359381e8b7a88a01fe0634\", \"title\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/4de55da44c4b511989359381e8b7a88a01fe0634\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1612897208327822",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/162",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/4de55da44c4b511989359381e8b7a88a01fe0634",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/4de55da44c4b511989359381e8b7a88a01fe0634",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021178476043677200",
      "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/8855748413834025792/+/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": "1612897208327968",
    "url": "https://ci.chromium.org/b/8855748413834025792",
    "utcnow_ts": "1612897208598301"
  }
}
[19:00:08.612] Task URL: https://ci.chromium.org/b/8855748413834025792
[19:00:08.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:2:0) after 1m0s
[19:01:08.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:2:0)
[19:01:08.788] Timer tick, asking Buildbucket for the build status
[19:01:09.874] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:09.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:3:0) after 1m0s
[19:02:09.982] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:3:0)
[19:02:09.982] Timer tick, asking Buildbucket for the build status
[19:02:10.173] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:10.173] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:4:0) after 1m0s
[19:03:10.197] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:4:0)
[19:03:10.197] Timer tick, asking Buildbucket for the build status
[19:03:10.735] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:10.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:5:0) after 1m0s
[19:04:10.826] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:5:0)
[19:04:10.826] Timer tick, asking Buildbucket for the build status
[19:04:12.108] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:12.108] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:6:0) after 1m0s
[19:05:12.132] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:6:0)
[19:05:12.132] Timer tick, asking Buildbucket for the build status
[19:05:14.044] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:14.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:7:0) after 1m0s
[19:06:14.067] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:7:0)
[19:06:14.067] Timer tick, asking Buildbucket for the build status
[19:06:15.550] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:15.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:8:0) after 1m0s
[19:07:15.591] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:8:0)
[19:07:15.591] Timer tick, asking Buildbucket for the build status
[19:07:15.805] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:15.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:9:0) after 1m0s
[19:08:15.791] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:9:0)
[19:08:15.791] Timer tick, asking Buildbucket for the build status
[19:08:16.742] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:16.742] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:10:0) after 1m0s
[19:09:16.766] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:10:0)
[19:09:16.766] Timer tick, asking Buildbucket for the build status
[19:09:17.436] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:17.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:11:0) after 1m0s
[19:10:17.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:11:0)
[19:10:17.486] Timer tick, asking Buildbucket for the build status
[19:10:17.622] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:17.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:12:0) after 1m0s
[19:11:17.631] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:12:0)
[19:11:17.631] Timer tick, asking Buildbucket for the build status
[19:11:17.850] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:11:17.850] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:13:0) after 1m0s
[19:12:17.996] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:13:0)
[19:12:17.996] Timer tick, asking Buildbucket for the build status
[19:12:18.131] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:12:18.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:14:0) after 1m0s
[19:13:18.221] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:14:0)
[19:13:18.221] Timer tick, asking Buildbucket for the build status
[19:13:18.787] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:18.787] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:15:0) after 1m0s
[19:14:18.797] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:15:0)
[19:14:18.797] Timer tick, asking Buildbucket for the build status
[19:14:19.301] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:14:19.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:16:0) after 1m0s
[19:15:19.507] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:16:0)
[19:15:19.507] Timer tick, asking Buildbucket for the build status
[19:15:19.987] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:15:19.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:17:0) after 1m0s
[19:16:20.035] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:17:0)
[19:16:20.035] Timer tick, asking Buildbucket for the build status
[19:16:20.262] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:20.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:18:0) after 1m0s
[19:17:20.345] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:18:0)
[19:17:20.345] Timer tick, asking Buildbucket for the build status
[19:17:22.204] Build 8855748413834025792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:22.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:19:0) after 1m0s
[19:17:48.842] Received PubSub notification, asking Buildbucket for the build status
[19:17:49.127] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:22.217] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:19:0)
[19:18:22.217] Timer tick, asking Buildbucket for the build status
[19:18:22.357] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:22.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:21:0) after 1m0s
[19:19:22.528] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:21:0)
[19:19:22.528] Timer tick, asking Buildbucket for the build status
[19:19:22.675] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:22.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:22:0) after 1m0s
[19:20:23.125] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:22:0)
[19:20:23.125] Timer tick, asking Buildbucket for the build status
[19:20:23.359] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:23.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:23:0) after 1m0s
[19:21:23.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:23:0)
[19:21:23.394] Timer tick, asking Buildbucket for the build status
[19:21:23.787] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:23.787] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:24:0) after 1m0s
[19:22:23.886] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:24:0)
[19:22:23.886] Timer tick, asking Buildbucket for the build status
[19:22:23.948] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:23.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:25:0) after 1m0s
[19:23:24.087] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:25:0)
[19:23:24.087] Timer tick, asking Buildbucket for the build status
[19:23:24.808] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:24.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:26:0) after 1m0s
[19:24:24.829] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:26:0)
[19:24:24.829] Timer tick, asking Buildbucket for the build status
[19:24:24.944] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:24.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:27:0) after 1m0s
[19:25:24.969] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:27:0)
[19:25:24.969] Timer tick, asking Buildbucket for the build status
[19:25:25.162] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:25.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:28:0) after 1m0s
[19:26:25.240] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:28:0)
[19:26:25.240] Timer tick, asking Buildbucket for the build status
[19:26:25.517] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:25.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:29:0) after 1m0s
[19:27:25.522] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:29:0)
[19:27:25.522] Timer tick, asking Buildbucket for the build status
[19:27:25.642] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:25.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:30:0) after 1m0s
[19:28:25.685] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:30:0)
[19:28:25.685] Timer tick, asking Buildbucket for the build status
[19:28:26.071] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:26.071] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:31:0) after 1m0s
[19:29:26.118] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:31:0)
[19:29:26.118] Timer tick, asking Buildbucket for the build status
[19:29:26.195] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:26.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:32:0) after 1m0s
[19:30:26.217] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:32:0)
[19:30:26.217] Timer tick, asking Buildbucket for the build status
[19:30:26.708] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:26.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:33:0) after 1m0s
[19:31:26.780] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:33:0)
[19:31:26.781] Timer tick, asking Buildbucket for the build status
[19:31:27.762] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:27.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:34:0) after 1m0s
[19:32:27.825] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:34:0)
[19:32:27.825] Timer tick, asking Buildbucket for the build status
[19:32:28.785] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:28.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:35:0) after 1m0s
[19:33:28.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:35:0)
[19:33:28.788] Timer tick, asking Buildbucket for the build status
[19:33:29.250] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:29.250] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:36:0) after 1m0s
[19:34:29.221] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:36:0)
[19:34:29.221] Timer tick, asking Buildbucket for the build status
[19:34:30.004] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:30.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:37:0) after 1m0s
[19:35:30.064] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:37:0)
[19:35:30.064] Timer tick, asking Buildbucket for the build status
[19:35:30.884] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:30.884] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:38:0) after 1m0s
[19:36:30.922] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:38:0)
[19:36:30.922] Timer tick, asking Buildbucket for the build status
[19:36:31.045] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:31.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:39:0) after 1m0s
[19:37:31.086] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:39:0)
[19:37:31.086] Timer tick, asking Buildbucket for the build status
[19:37:31.170] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:31.170] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:40:0) after 1m0s
[19:38:31.216] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:40:0)
[19:38:31.216] Timer tick, asking Buildbucket for the build status
[19:38:31.285] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:31.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:41:0) after 1m0s
[19:39:31.359] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:41:0)
[19:39:31.359] Timer tick, asking Buildbucket for the build status
[19:39:31.429] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:31.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:42:0) after 1m0s
[19:40:31.495] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:42:0)
[19:40:31.495] Timer tick, asking Buildbucket for the build status
[19:40:33.760] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:33.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:43:0) after 1m0s
[19:41:33.803] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:43:0)
[19:41:33.803] Timer tick, asking Buildbucket for the build status
[19:41:33.897] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:33.897] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:44:0) after 1m0s
[19:42:33.912] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:44:0)
[19:42:33.912] Timer tick, asking Buildbucket for the build status
[19:42:33.994] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:33.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:45:0) after 1m0s
[19:43:34.062] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:45:0)
[19:43:34.062] Timer tick, asking Buildbucket for the build status
[19:43:34.256] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:34.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:46:0) after 1m0s
[19:44:34.287] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:46:0)
[19:44:34.287] Timer tick, asking Buildbucket for the build status
[19:44:34.636] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:34.636] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:47:0) after 1m0s
[19:45:34.645] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:47:0)
[19:45:34.645] Timer tick, asking Buildbucket for the build status
[19:45:34.853] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:34.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:48:0) after 1m0s
[19:46:34.906] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:48:0)
[19:46:34.906] Timer tick, asking Buildbucket for the build status
[19:46:35.222] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:35.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:49:0) after 1m0s
[19:47:35.266] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:49:0)
[19:47:35.266] Timer tick, asking Buildbucket for the build status
[19:47:35.573] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:35.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:50:0) after 1m0s
[19:48:35.614] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:50:0)
[19:48:35.614] Timer tick, asking Buildbucket for the build status
[19:48:35.765] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:35.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:51:0) after 1m0s
[19:49:35.798] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:51:0)
[19:49:35.798] Timer tick, asking Buildbucket for the build status
[19:49:35.887] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:35.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:52:0) after 1m0s
[19:50:35.930] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:52:0)
[19:50:35.930] Timer tick, asking Buildbucket for the build status
[19:50:37.929] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:37.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:53:0) after 1m0s
[19:51:38.045] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:53:0)
[19:51:38.045] Timer tick, asking Buildbucket for the build status
[19:51:38.316] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:38.316] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:54:0) after 1m0s
[19:52:38.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:54:0)
[19:52:38.360] Timer tick, asking Buildbucket for the build status
[19:52:39.312] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:39.312] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:55:0) after 1m0s
[19:53:39.380] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:55:0)
[19:53:39.380] Timer tick, asking Buildbucket for the build status
[19:53:39.530] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:39.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:56:0) after 1m0s
[19:54:39.552] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:56:0)
[19:54:39.552] Timer tick, asking Buildbucket for the build status
[19:54:39.605] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:39.605] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:57:0) after 1m0s
[19:55:39.628] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:57:0)
[19:55:39.628] Timer tick, asking Buildbucket for the build status
[19:55:39.862] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:39.862] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:58:0) after 1m0s
[19:56:39.902] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:58:0)
[19:56:39.902] Timer tick, asking Buildbucket for the build status
[19:56:40.004] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:40.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:59:0) after 1m0s
[19:57:40.032] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:59:0)
[19:57:40.032] Timer tick, asking Buildbucket for the build status
[19:57:40.107] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:40.107] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:60:0) after 1m0s
[19:58:40.109] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:60:0)
[19:58:40.109] Timer tick, asking Buildbucket for the build status
[19:58:40.240] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:40.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:61:0) after 1m0s
[19:59:40.298] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:61:0)
[19:59:40.298] Timer tick, asking Buildbucket for the build status
[19:59:40.560] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:40.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:62:0) after 1m0s
[20:00:40.625] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:62:0)
[20:00:40.625] Timer tick, asking Buildbucket for the build status
[20:00:41.662] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:41.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:63:0) after 1m0s
[20:01:41.729] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:63:0)
[20:01:41.729] Timer tick, asking Buildbucket for the build status
[20:01:41.816] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:41.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:64:0) after 1m0s
[20:02:41.897] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:64:0)
[20:02:41.897] Timer tick, asking Buildbucket for the build status
[20:02:42.391] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:42.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:65:0) after 1m0s
[20:03:42.434] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:65:0)
[20:03:42.434] Timer tick, asking Buildbucket for the build status
[20:03:42.814] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:42.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:66:0) after 1m0s
[20:04:42.807] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:66:0)
[20:04:42.807] Timer tick, asking Buildbucket for the build status
[20:04:43.035] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:43.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:67:0) after 1m0s
[20:05:43.042] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:67:0)
[20:05:43.042] Timer tick, asking Buildbucket for the build status
[20:05:43.162] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:43.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:68:0) after 1m0s
[20:06:43.164] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:68:0)
[20:06:43.165] Timer tick, asking Buildbucket for the build status
[20:06:43.256] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:43.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:69:0) after 1m0s
[20:07:43.291] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:69:0)
[20:07:43.291] Timer tick, asking Buildbucket for the build status
[20:07:43.430] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:43.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:70:0) after 1m0s
[20:08:43.708] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:70:0)
[20:08:43.708] Timer tick, asking Buildbucket for the build status
[20:08:43.835] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:43.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:71:0) after 1m0s
[20:09:44.024] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:71:0)
[20:09:44.024] Timer tick, asking Buildbucket for the build status
[20:09:44.331] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:44.331] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:72:0) after 1m0s
[20:10:44.391] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:72:0)
[20:10:44.391] Timer tick, asking Buildbucket for the build status
[20:10:44.626] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:44.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:73:0) after 1m0s
[20:11:44.672] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:73:0)
[20:11:44.672] Timer tick, asking Buildbucket for the build status
[20:11:45.356] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:45.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:74:0) after 1m0s
[20:12:45.433] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:74:0)
[20:12:45.433] Timer tick, asking Buildbucket for the build status
[20:12:45.555] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:45.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:75:0) after 1m0s
[20:13:45.551] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:75:0)
[20:13:45.551] Timer tick, asking Buildbucket for the build status
[20:13:45.651] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:45.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:76:0) after 1m0s
[20:14:45.674] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:76:0)
[20:14:45.674] Timer tick, asking Buildbucket for the build status
[20:14:45.765] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:45.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:77:0) after 1m0s
[20:15:45.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:77:0)
[20:15:45.808] Timer tick, asking Buildbucket for the build status
[20:15:45.968] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:45.968] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:78:0) after 1m0s
[20:16:46.044] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:78:0)
[20:16:46.044] Timer tick, asking Buildbucket for the build status
[20:16:46.324] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:46.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:79:0) after 1m0s
[20:17:46.384] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:79:0)
[20:17:46.384] Timer tick, asking Buildbucket for the build status
[20:17:55.004] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:55.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:80:0) after 1m0s
[20:18:55.038] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:80:0)
[20:18:55.038] Timer tick, asking Buildbucket for the build status
[20:18:55.131] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:55.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:81:0) after 1m0s
[20:19:55.282] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:81:0)
[20:19:55.282] Timer tick, asking Buildbucket for the build status
[20:19:55.457] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:55.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:82:0) after 1m0s
[20:20:55.537] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:82:0)
[20:20:55.537] Timer tick, asking Buildbucket for the build status
[20:20:56.875] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:56.875] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:83:0) after 1m0s
[20:21:56.923] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:83:0)
[20:21:56.923] Timer tick, asking Buildbucket for the build status
[20:21:57.238] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:57.238] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:84:0) after 1m0s
[20:22:57.267] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:84:0)
[20:22:57.267] Timer tick, asking Buildbucket for the build status
[20:22:58.851] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:58.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:85:0) after 1m0s
[20:23:58.883] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:85:0)
[20:23:58.883] Timer tick, asking Buildbucket for the build status
[20:23:59.032] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:59.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:86:0) after 1m0s
[20:24:59.062] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:86:0)
[20:24:59.062] Timer tick, asking Buildbucket for the build status
[20:24:59.152] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:59.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:87:0) after 1m0s
[20:25:59.183] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:87:0)
[20:25:59.183] Timer tick, asking Buildbucket for the build status
[20:25:59.730] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:59.730] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:88:0) after 1m0s
[20:26:59.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:88:0)
[20:26:59.745] Timer tick, asking Buildbucket for the build status
[20:26:59.900] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:59.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:89:0) after 1m0s
[20:27:59.963] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:89:0)
[20:27:59.963] Timer tick, asking Buildbucket for the build status
[20:28:00.352] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:00.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:90:0) after 1m0s
[20:29:00.381] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:90:0)
[20:29:00.381] Timer tick, asking Buildbucket for the build status
[20:29:00.463] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:00.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:91:0) after 1m0s
[20:30:01.955] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:91:0)
[20:30:01.955] Timer tick, asking Buildbucket for the build status
[20:30:02.155] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:02.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:92:0) after 1m0s
[20:31:02.175] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:92:0)
[20:31:02.175] Timer tick, asking Buildbucket for the build status
[20:31:02.394] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:02.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:93:0) after 1m0s
[20:32:02.417] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:93:0)
[20:32:02.417] Timer tick, asking Buildbucket for the build status
[20:32:02.612] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:02.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:94:0) after 1m0s
[20:33:02.636] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:94:0)
[20:33:02.636] Timer tick, asking Buildbucket for the build status
[20:33:03.020] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:03.020] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:95:0) after 1m0s
[20:34:03.059] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:95:0)
[20:34:03.059] Timer tick, asking Buildbucket for the build status
[20:34:03.319] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:03.319] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:96:0) after 1m0s
[20:35:03.388] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:96:0)
[20:35:03.388] Timer tick, asking Buildbucket for the build status
[20:35:03.470] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:03.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:97:0) after 1m0s
[20:36:03.531] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:97:0)
[20:36:03.531] Timer tick, asking Buildbucket for the build status
[20:36:03.646] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:03.646] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:98:0) after 1m0s
[20:37:03.679] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:98:0)
[20:37:03.679] Timer tick, asking Buildbucket for the build status
[20:37:03.773] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:03.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:99:0) after 1m0s
[20:38:03.785] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:99:0)
[20:38:03.785] Timer tick, asking Buildbucket for the build status
[20:38:05.773] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:05.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:100:0) after 1m0s
[20:39:05.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:100:0)
[20:39:05.834] Timer tick, asking Buildbucket for the build status
[20:39:07.179] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:07.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:101:0) after 1m0s
[20:40:07.223] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:101:0)
[20:40:07.223] Timer tick, asking Buildbucket for the build status
[20:40:07.314] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:07.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:102:0) after 1m0s
[20:41:07.336] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:102:0)
[20:41:07.336] Timer tick, asking Buildbucket for the build status
[20:41:07.511] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:07.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:103:0) after 1m0s
[20:42:07.558] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:103:0)
[20:42:07.558] Timer tick, asking Buildbucket for the build status
[20:42:07.617] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:07.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:104:0) after 1m0s
[20:43:07.672] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:104:0)
[20:43:07.672] Timer tick, asking Buildbucket for the build status
[20:43:07.872] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:07.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:105:0) after 1m0s
[20:44:07.903] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:105:0)
[20:44:07.903] Timer tick, asking Buildbucket for the build status
[20:44:09.503] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:09.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:106:0) after 1m0s
[20:45:09.570] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:106:0)
[20:45:09.570] Timer tick, asking Buildbucket for the build status
[20:45:10.027] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:10.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:107:0) after 1m0s
[20:46:10.071] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:107:0)
[20:46:10.071] Timer tick, asking Buildbucket for the build status
[20:46:10.224] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:10.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:108:0) after 1m0s
[20:47:10.264] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:108:0)
[20:47:10.264] Timer tick, asking Buildbucket for the build status
[20:47:13.626] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:13.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:109:0) after 1m0s
[20:48:13.823] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:109:0)
[20:48:13.823] Timer tick, asking Buildbucket for the build status
[20:48:13.962] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:13.962] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:110:0) after 1m0s
[20:49:14.310] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:110:0)
[20:49:14.310] Timer tick, asking Buildbucket for the build status
[20:49:14.419] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:14.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:111:0) after 1m0s
[20:50:14.527] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:111:0)
[20:50:14.527] Timer tick, asking Buildbucket for the build status
[20:50:14.597] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:14.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:112:0) after 1m0s
[20:51:14.693] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:112:0)
[20:51:14.694] Timer tick, asking Buildbucket for the build status
[20:51:14.875] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:14.875] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:113:0) after 1m0s
[20:52:14.978] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:113:0)
[20:52:14.978] Timer tick, asking Buildbucket for the build status
[20:52:15.064] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:15.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:114:0) after 1m0s
[20:53:15.072] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:114:0)
[20:53:15.072] Timer tick, asking Buildbucket for the build status
[20:53:15.168] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:15.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:115:0) after 1m0s
[20:54:15.216] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:115:0)
[20:54:15.216] Timer tick, asking Buildbucket for the build status
[20:54:15.590] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:15.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:116:0) after 1m0s
[20:55:15.628] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:116:0)
[20:55:15.628] Timer tick, asking Buildbucket for the build status
[20:55:15.728] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:15.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:117:0) after 1m0s
[20:56:15.761] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:117:0)
[20:56:15.761] Timer tick, asking Buildbucket for the build status
[20:56:15.886] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:15.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:118:0) after 1m0s
[20:57:15.962] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:118:0)
[20:57:15.962] Timer tick, asking Buildbucket for the build status
[20:57:16.038] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:16.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:119:0) after 1m0s
[20:58:16.082] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:119:0)
[20:58:16.082] Timer tick, asking Buildbucket for the build status
[20:58:16.156] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:16.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:120:0) after 1m0s
[20:59:16.222] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:120:0)
[20:59:16.222] Timer tick, asking Buildbucket for the build status
[20:59:16.353] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:16.353] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:121:0) after 1m0s
[21:00:16.431] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:121:0)
[21:00:16.431] Timer tick, asking Buildbucket for the build status
[21:00:16.520] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:16.520] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:122:0) after 1m0s
[21:01:16.573] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:122:0)
[21:01:16.573] Timer tick, asking Buildbucket for the build status
[21:01:17.098] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:17.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:123:0) after 1m0s
[21:02:17.143] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:123:0)
[21:02:17.143] Timer tick, asking Buildbucket for the build status
[21:02:17.249] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:17.249] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:124:0) after 1m0s
[21:03:17.291] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:124:0)
[21:03:17.291] Timer tick, asking Buildbucket for the build status
[21:03:17.556] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:17.556] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:125:0) after 1m0s
[21:04:17.649] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:125:0)
[21:04:17.649] Timer tick, asking Buildbucket for the build status
[21:04:17.835] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:17.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:126:0) after 1m0s
[21:05:17.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:126:0)
[21:05:17.844] Timer tick, asking Buildbucket for the build status
[21:05:18.546] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:18.546] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:127:0) after 1m0s
[21:06:18.571] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:127:0)
[21:06:18.571] Timer tick, asking Buildbucket for the build status
[21:06:18.786] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:18.786] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:128:0) after 1m0s
[21:07:18.836] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:128:0)
[21:07:18.836] Timer tick, asking Buildbucket for the build status
[21:07:18.995] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:18.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:129:0) after 1m0s
[21:08:19.015] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:129:0)
[21:08:19.015] Timer tick, asking Buildbucket for the build status
[21:08:19.151] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:19.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:130:0) after 1m0s
[21:09:19.200] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:130:0)
[21:09:19.200] Timer tick, asking Buildbucket for the build status
[21:09:19.497] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:19.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:131:0) after 1m0s
[21:10:19.690] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:131:0)
[21:10:19.690] Timer tick, asking Buildbucket for the build status
[21:10:19.915] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:19.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:132:0) after 1m0s
[21:11:19.964] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:132:0)
[21:11:19.964] Timer tick, asking Buildbucket for the build status
[21:11:20.926] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:20.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:133:0) after 1m0s
[21:12:20.950] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:133:0)
[21:12:20.950] Timer tick, asking Buildbucket for the build status
[21:12:21.080] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:21.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:134:0) after 1m0s
[21:13:21.146] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:134:0)
[21:13:21.146] Timer tick, asking Buildbucket for the build status
[21:13:21.264] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:21.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:135:0) after 1m0s
[21:14:21.313] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:135:0)
[21:14:21.313] Timer tick, asking Buildbucket for the build status
[21:14:21.402] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:21.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:136:0) after 1m0s
[21:15:21.681] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:136:0)
[21:15:21.681] Timer tick, asking Buildbucket for the build status
[21:15:22.257] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:22.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:137:0) after 1m0s
[21:16:22.339] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:137:0)
[21:16:22.339] Timer tick, asking Buildbucket for the build status
[21:16:22.470] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:22.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:138:0) after 1m0s
[21:17:22.593] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:138:0)
[21:17:22.593] Timer tick, asking Buildbucket for the build status
[21:17:22.991] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:22.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:139:0) after 1m0s
[21:18:23.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:139:0)
[21:18:23.186] Timer tick, asking Buildbucket for the build status
[21:18:23.494] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:23.494] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:140:0) after 1m0s
[21:19:23.583] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:140:0)
[21:19:23.583] Timer tick, asking Buildbucket for the build status
[21:19:23.802] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:23.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:141:0) after 1m0s
[21:20:23.812] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:141:0)
[21:20:23.812] Timer tick, asking Buildbucket for the build status
[21:20:24.428] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:24.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:142:0) after 1m0s
[21:21:24.484] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:142:0)
[21:21:24.484] Timer tick, asking Buildbucket for the build status
[21:21:24.616] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:24.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:143:0) after 1m0s
[21:22:24.668] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:143:0)
[21:22:24.668] Timer tick, asking Buildbucket for the build status
[21:22:25.746] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:25.746] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:144:0) after 1m0s
[21:23:25.794] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:144:0)
[21:23:25.794] Timer tick, asking Buildbucket for the build status
[21:23:25.878] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:25.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:145:0) after 1m0s
[21:24:26.045] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:145:0)
[21:24:26.045] Timer tick, asking Buildbucket for the build status
[21:24:26.191] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:26.191] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:146:0) after 1m0s
[21:25:26.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:146:0)
[21:25:26.272] Timer tick, asking Buildbucket for the build status
[21:25:26.380] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:26.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:147:0) after 1m0s
[21:26:26.428] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:147:0)
[21:26:26.428] Timer tick, asking Buildbucket for the build status
[21:26:26.602] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:26.602] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:148:0) after 1m0s
[21:27:26.633] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:148:0)
[21:27:26.633] Timer tick, asking Buildbucket for the build status
[21:27:26.760] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:26.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:149:0) after 1m0s
[21:28:26.764] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:149:0)
[21:28:26.764] Timer tick, asking Buildbucket for the build status
[21:28:26.885] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:26.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:150:0) after 1m0s
[21:29:27.095] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:150:0)
[21:29:27.095] Timer tick, asking Buildbucket for the build status
[21:29:27.215] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:27.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:151:0) after 1m0s
[21:30:28.074] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:151:0)
[21:30:28.074] Timer tick, asking Buildbucket for the build status
[21:30:28.258] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:28.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:152:0) after 1m0s
[21:31:28.431] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:152:0)
[21:31:28.431] Timer tick, asking Buildbucket for the build status
[21:31:28.653] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:28.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:153:0) after 1m0s
[21:32:28.731] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:153:0)
[21:32:28.731] Timer tick, asking Buildbucket for the build status
[21:32:28.798] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:28.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:154:0) after 1m0s
[21:33:29.206] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:154:0)
[21:33:29.206] Timer tick, asking Buildbucket for the build status
[21:33:29.280] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:29.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:155:0) after 1m0s
[21:34:29.432] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:155:0)
[21:34:29.432] Timer tick, asking Buildbucket for the build status
[21:34:29.627] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:29.627] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:156:0) after 1m0s
[21:35:29.697] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:156:0)
[21:35:29.697] Timer tick, asking Buildbucket for the build status
[21:35:29.822] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:29.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:157:0) after 1m0s
[21:36:29.887] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:157:0)
[21:36:29.887] Timer tick, asking Buildbucket for the build status
[21:36:31.439] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:31.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:158:0) after 1m0s
[21:37:31.527] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:158:0)
[21:37:31.527] Timer tick, asking Buildbucket for the build status
[21:37:32.146] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:32.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:159:0) after 1m0s
[21:38:32.212] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:159:0)
[21:38:32.212] Timer tick, asking Buildbucket for the build status
[21:38:32.645] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:32.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:160:0) after 1m0s
[21:39:32.681] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:160:0)
[21:39:32.681] Timer tick, asking Buildbucket for the build status
[21:39:32.802] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:32.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:161:0) after 1m0s
[21:40:32.859] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:161:0)
[21:40:32.859] Timer tick, asking Buildbucket for the build status
[21:40:32.981] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:32.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:162:0) after 1m0s
[21:41:33.192] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:162:0)
[21:41:33.192] Timer tick, asking Buildbucket for the build status
[21:41:33.541] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:33.541] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:163:0) after 1m0s
[21:42:33.683] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:163:0)
[21:42:33.683] Timer tick, asking Buildbucket for the build status
[21:42:33.765] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:33.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:164:0) after 1m0s
[21:43:33.907] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:164:0)
[21:43:33.907] Timer tick, asking Buildbucket for the build status
[21:43:34.052] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:34.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:165:0) after 1m0s
[21:44:34.170] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:165:0)
[21:44:34.170] Timer tick, asking Buildbucket for the build status
[21:44:34.874] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:34.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:166:0) after 1m0s
[21:45:34.913] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:166:0)
[21:45:34.913] Timer tick, asking Buildbucket for the build status
[21:45:35.042] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:35.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:167:0) after 1m0s
[21:46:35.056] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:167:0)
[21:46:35.056] Timer tick, asking Buildbucket for the build status
[21:46:35.339] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:35.339] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:168:0) after 1m0s
[21:47:35.458] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:168:0)
[21:47:35.458] Timer tick, asking Buildbucket for the build status
[21:47:35.587] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:35.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:169:0) after 1m0s
[21:48:35.702] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:169:0)
[21:48:35.703] Timer tick, asking Buildbucket for the build status
[21:48:35.830] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:35.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:170:0) after 1m0s
[21:49:35.905] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:170:0)
[21:49:35.905] Timer tick, asking Buildbucket for the build status
[21:49:36.056] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:36.056] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:171:0) after 1m0s
[21:50:36.084] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:171:0)
[21:50:36.084] Timer tick, asking Buildbucket for the build status
[21:50:36.809] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:36.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:172:0) after 1m0s
[21:51:36.914] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:172:0)
[21:51:36.914] Timer tick, asking Buildbucket for the build status
[21:51:37.595] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:37.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:173:0) after 1m0s
[21:52:37.684] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:173:0)
[21:52:37.684] Timer tick, asking Buildbucket for the build status
[21:52:38.465] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:38.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:174:0) after 1m0s
[21:53:38.589] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:174:0)
[21:53:38.589] Timer tick, asking Buildbucket for the build status
[21:53:39.461] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:39.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:175:0) after 1m0s
[21:54:39.543] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:175:0)
[21:54:39.543] Timer tick, asking Buildbucket for the build status
[21:54:39.868] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:39.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:176:0) after 1m0s
[21:55:39.919] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:176:0)
[21:55:39.919] Timer tick, asking Buildbucket for the build status
[21:55:40.669] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:40.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:177:0) after 1m0s
[21:56:40.851] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:177:0)
[21:56:40.851] Timer tick, asking Buildbucket for the build status
[21:56:42.036] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:42.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:178:0) after 1m0s
[21:57:42.331] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:178:0)
[21:57:42.331] Timer tick, asking Buildbucket for the build status
[21:57:43.217] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:43.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:179:0) after 1m0s
[21:58:43.502] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:179:0)
[21:58:43.502] Timer tick, asking Buildbucket for the build status
[21:58:43.594] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:43.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:180:0) after 1m0s
[21:59:43.744] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:180:0)
[21:59:43.744] Timer tick, asking Buildbucket for the build status
[21:59:44.102] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:44.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:181:0) after 1m0s
[22:00:45.286] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:181:0)
[22:00:45.287] Timer tick, asking Buildbucket for the build status
[22:00:45.470] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:45.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:182:0) after 1m0s
[22:01:45.970] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:182:0)
[22:01:45.970] Timer tick, asking Buildbucket for the build status
[22:01:46.292] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:46.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:183:0) after 1m0s
[22:02:46.347] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:183:0)
[22:02:46.347] Timer tick, asking Buildbucket for the build status
[22:02:46.478] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:46.478] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:184:0) after 1m0s
[22:03:46.514] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:184:0)
[22:03:46.514] Timer tick, asking Buildbucket for the build status
[22:03:46.587] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:46.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:185:0) after 1m0s
[22:04:46.776] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:185:0)
[22:04:46.776] Timer tick, asking Buildbucket for the build status
[22:04:46.882] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:46.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:186:0) after 1m0s
[22:05:47.022] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:186:0)
[22:05:47.022] Timer tick, asking Buildbucket for the build status
[22:05:49.588] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:49.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:187:0) after 1m0s
[22:06:50.016] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:187:0)
[22:06:50.016] Timer tick, asking Buildbucket for the build status
[22:06:50.208] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:50.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:188:0) after 1m0s
[22:07:50.256] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:188:0)
[22:07:50.256] Timer tick, asking Buildbucket for the build status
[22:07:50.384] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:50.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:189:0) after 1m0s
[22:08:50.643] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:189:0)
[22:08:50.643] Timer tick, asking Buildbucket for the build status
[22:08:50.757] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:50.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:190:0) after 1m0s
[22:09:50.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:190:0)
[22:09:50.808] Timer tick, asking Buildbucket for the build status
[22:09:50.916] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:50.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:191:0) after 1m0s
[22:10:50.991] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:191:0)
[22:10:50.991] Timer tick, asking Buildbucket for the build status
[22:10:52.448] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:52.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:192:0) after 1m0s
[22:11:52.494] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:192:0)
[22:11:52.494] Timer tick, asking Buildbucket for the build status
[22:11:52.854] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:52.854] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:193:0) after 1m0s
[22:12:52.867] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:193:0)
[22:12:52.867] Timer tick, asking Buildbucket for the build status
[22:12:53.004] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:53.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:194:0) after 1m0s
[22:13:53.232] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:194:0)
[22:13:53.232] Timer tick, asking Buildbucket for the build status
[22:13:53.481] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:53.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:195:0) after 1m0s
[22:14:53.621] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:195:0)
[22:14:53.621] Timer tick, asking Buildbucket for the build status
[22:14:53.829] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:53.829] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:196:0) after 1m0s
[22:15:53.836] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:196:0)
[22:15:53.836] Timer tick, asking Buildbucket for the build status
[22:15:55.492] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:55.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:197:0) after 1m0s
[22:16:55.530] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:197:0)
[22:16:55.530] Timer tick, asking Buildbucket for the build status
[22:16:55.692] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:55.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:198:0) after 1m0s
[22:17:55.797] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:198:0)
[22:17:55.797] Timer tick, asking Buildbucket for the build status
[22:17:55.894] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:55.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:199:0) after 1m0s
[22:18:56.100] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:199:0)
[22:18:56.100] Timer tick, asking Buildbucket for the build status
[22:18:56.176] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:56.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:200:0) after 1m0s
[22:19:56.286] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:200:0)
[22:19:56.286] Timer tick, asking Buildbucket for the build status
[22:19:56.509] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:56.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:201:0) after 1m0s
[22:20:56.642] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:201:0)
[22:20:56.642] Timer tick, asking Buildbucket for the build status
[22:20:56.855] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:56.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:202:0) after 1m0s
[22:21:57.554] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:202:0)
[22:21:57.554] Timer tick, asking Buildbucket for the build status
[22:21:57.644] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:57.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:203:0) after 1m0s
[22:22:58.108] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:203:0)
[22:22:58.108] Timer tick, asking Buildbucket for the build status
[22:22:58.248] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:58.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:204:0) after 1m0s
[22:23:58.291] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:204:0)
[22:23:58.291] Timer tick, asking Buildbucket for the build status
[22:23:58.458] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:58.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:205:0) after 1m0s
[22:24:59.045] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:205:0)
[22:24:59.045] Timer tick, asking Buildbucket for the build status
[22:24:59.218] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:59.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:206:0) after 1m0s
[22:25:59.496] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:206:0)
[22:25:59.496] Timer tick, asking Buildbucket for the build status
[22:25:59.691] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:59.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:207:0) after 1m0s
[22:26:59.768] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:207:0)
[22:26:59.768] Timer tick, asking Buildbucket for the build status
[22:27:00.415] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:00.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:208:0) after 1m0s
[22:28:00.691] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:208:0)
[22:28:00.691] Timer tick, asking Buildbucket for the build status
[22:28:02.125] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:02.125] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:209:0) after 1m0s
[22:29:02.722] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:209:0)
[22:29:02.722] Timer tick, asking Buildbucket for the build status
[22:29:02.844] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:02.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:210:0) after 1m0s
[22:30:03.123] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:210:0)
[22:30:03.123] Timer tick, asking Buildbucket for the build status
[22:30:03.267] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:03.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:211:0) after 1m0s
[22:31:04.053] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:211:0)
[22:31:04.053] Timer tick, asking Buildbucket for the build status
[22:31:04.554] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:04.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:212:0) after 1m0s
[22:32:04.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:212:0)
[22:32:04.920] Timer tick, asking Buildbucket for the build status
[22:32:05.062] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:05.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:213:0) after 1m0s
[22:33:05.223] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:213:0)
[22:33:05.223] Timer tick, asking Buildbucket for the build status
[22:33:05.364] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:05.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:214:0) after 1m0s
[22:34:05.484] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:214:0)
[22:34:05.484] Timer tick, asking Buildbucket for the build status
[22:34:05.586] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:05.586] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:215:0) after 1m0s
[22:35:05.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:215:0)
[22:35:05.788] Timer tick, asking Buildbucket for the build status
[22:35:05.912] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:05.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:216:0) after 1m0s
[22:36:05.953] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:216:0)
[22:36:05.953] Timer tick, asking Buildbucket for the build status
[22:36:06.665] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:06.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:217:0) after 1m0s
[22:37:07.230] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:217:0)
[22:37:07.230] Timer tick, asking Buildbucket for the build status
[22:37:07.378] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:07.378] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:218:0) after 1m0s
[22:38:07.657] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:218:0)
[22:38:07.657] Timer tick, asking Buildbucket for the build status
[22:38:07.852] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:07.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:219:0) after 1m0s
[22:39:07.990] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:219:0)
[22:39:07.990] Timer tick, asking Buildbucket for the build status
[22:39:08.222] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:08.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:220:0) after 1m0s
[22:40:08.256] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:220:0)
[22:40:08.256] Timer tick, asking Buildbucket for the build status
[22:40:08.516] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:08.516] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:221:0) after 1m0s
[22:41:08.863] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:221:0)
[22:41:08.863] Timer tick, asking Buildbucket for the build status
[22:41:09.299] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:09.299] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:222:0) after 1m0s
[22:42:09.395] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:222:0)
[22:42:09.395] Timer tick, asking Buildbucket for the build status
[22:42:09.513] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:09.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:223:0) after 1m0s
[22:43:09.605] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:223:0)
[22:43:09.605] Timer tick, asking Buildbucket for the build status
[22:43:09.909] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:09.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:224:0) after 1m0s
[22:44:09.974] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:224:0)
[22:44:09.974] Timer tick, asking Buildbucket for the build status
[22:44:10.081] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:10.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:225:0) after 1m0s
[22:45:10.218] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:225:0)
[22:45:10.218] Timer tick, asking Buildbucket for the build status
[22:45:10.522] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:10.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:226:0) after 1m0s
[22:46:10.649] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:226:0)
[22:46:10.649] Timer tick, asking Buildbucket for the build status
[22:46:11.849] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:11.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:227:0) after 1m0s
[22:47:11.879] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:227:0)
[22:47:11.879] Timer tick, asking Buildbucket for the build status
[22:47:12.369] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:12.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:228:0) after 1m0s
[22:48:12.430] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:228:0)
[22:48:12.430] Timer tick, asking Buildbucket for the build status
[22:48:12.506] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:12.506] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:229:0) after 1m0s
[22:49:13.129] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:229:0)
[22:49:13.129] Timer tick, asking Buildbucket for the build status
[22:49:13.401] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:13.401] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:230:0) after 1m0s
[22:50:13.553] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:230:0)
[22:50:13.553] Timer tick, asking Buildbucket for the build status
[22:50:13.673] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:13.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:231:0) after 1m0s
[22:51:13.780] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:231:0)
[22:51:13.780] Timer tick, asking Buildbucket for the build status
[22:51:14.068] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:14.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:232:0) after 1m0s
[22:52:14.407] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:232:0)
[22:52:14.407] Timer tick, asking Buildbucket for the build status
[22:52:14.528] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:14.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:233:0) after 1m0s
[22:53:14.770] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:233:0)
[22:53:14.770] Timer tick, asking Buildbucket for the build status
[22:53:14.877] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:14.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:234:0) after 1m0s
[22:54:14.986] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:234:0)
[22:54:14.986] Timer tick, asking Buildbucket for the build status
[22:54:15.153] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:15.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:235:0) after 1m0s
[22:55:15.362] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:235:0)
[22:55:15.362] Timer tick, asking Buildbucket for the build status
[22:55:15.452] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:15.452] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:236:0) after 1m0s
[22:56:15.648] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:236:0)
[22:56:15.648] Timer tick, asking Buildbucket for the build status
[22:56:15.825] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:15.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:237:0) after 1m0s
[22:57:16.264] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:237:0)
[22:57:16.264] Timer tick, asking Buildbucket for the build status
[22:57:16.358] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:16.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:238:0) after 1m0s
[22:58:16.605] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:238:0)
[22:58:16.605] Timer tick, asking Buildbucket for the build status
[22:58:16.792] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:16.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:239:0) after 1m0s
[22:59:16.861] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:239:0)
[22:59:16.861] Timer tick, asking Buildbucket for the build status
[22:59:16.927] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:16.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:240:0) after 1m0s
[23:00:16.973] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:240:0)
[23:00:16.973] Timer tick, asking Buildbucket for the build status
[23:00:17.067] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:17.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:241:0) after 1m0s
[23:01:17.176] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:241:0)
[23:01:17.176] Timer tick, asking Buildbucket for the build status
[23:01:17.742] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:17.742] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:242:0) after 1m0s
[23:02:18.870] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:242:0)
[23:02:18.870] Timer tick, asking Buildbucket for the build status
[23:02:19.215] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:19.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:243:0) after 1m0s
[23:03:19.507] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:243:0)
[23:03:19.507] Timer tick, asking Buildbucket for the build status
[23:03:19.727] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:19.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:244:0) after 1m0s
[23:04:20.072] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:244:0)
[23:04:20.072] Timer tick, asking Buildbucket for the build status
[23:04:20.197] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:20.197] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:245:0) after 1m0s
[23:05:20.335] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:245:0)
[23:05:20.335] Timer tick, asking Buildbucket for the build status
[23:05:20.496] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:20.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:246:0) after 1m0s
[23:06:20.593] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:246:0)
[23:06:20.593] Timer tick, asking Buildbucket for the build status
[23:06:21.197] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:21.197] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:247:0) after 1m0s
[23:07:21.270] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:247:0)
[23:07:21.270] Timer tick, asking Buildbucket for the build status
[23:07:21.723] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:21.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:248:0) after 1m0s
[23:08:21.777] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:248:0)
[23:08:21.777] Timer tick, asking Buildbucket for the build status
[23:08:21.882] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:21.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:249:0) after 1m0s
[23:09:21.916] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:249:0)
[23:09:21.916] Timer tick, asking Buildbucket for the build status
[23:09:22.004] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:22.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:250:0) after 1m0s
[23:10:22.039] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:250:0)
[23:10:22.039] Timer tick, asking Buildbucket for the build status
[23:10:22.145] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:22.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:251:0) after 1m0s
[23:11:22.191] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:251:0)
[23:11:22.191] Timer tick, asking Buildbucket for the build status
[23:11:23.241] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:23.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:252:0) after 1m0s
[23:12:23.287] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:252:0)
[23:12:23.287] Timer tick, asking Buildbucket for the build status
[23:12:23.379] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:23.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:253:0) after 1m0s
[23:13:23.589] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:253:0)
[23:13:23.589] Timer tick, asking Buildbucket for the build status
[23:13:23.704] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:23.704] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:254:0) after 1m0s
[23:14:24.079] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:254:0)
[23:14:24.079] Timer tick, asking Buildbucket for the build status
[23:14:25.939] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:25.939] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:255:0) after 1m0s
[23:15:26.220] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:255:0)
[23:15:26.220] Timer tick, asking Buildbucket for the build status
[23:15:26.435] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:26.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:256:0) after 1m0s
[23:16:26.543] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:256:0)
[23:16:26.543] Timer tick, asking Buildbucket for the build status
[23:16:26.971] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:26.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:257:0) after 1m0s
[23:17:27.006] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:257:0)
[23:17:27.006] Timer tick, asking Buildbucket for the build status
[23:17:27.150] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:27.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:258:0) after 1m0s
[23:18:27.265] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:258:0)
[23:18:27.265] Timer tick, asking Buildbucket for the build status
[23:18:27.422] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:27.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:259:0) after 1m0s
[23:19:27.598] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:259:0)
[23:19:27.598] Timer tick, asking Buildbucket for the build status
[23:19:27.853] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:27.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:260:0) after 1m0s
[23:20:27.935] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:260:0)
[23:20:27.935] Timer tick, asking Buildbucket for the build status
[23:20:28.737] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:28.738] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:261:0) after 1m0s
[23:21:28.739] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:261:0)
[23:21:28.739] Timer tick, asking Buildbucket for the build status
[23:21:28.899] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:28.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:262:0) after 1m0s
[23:22:28.916] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:262:0)
[23:22:28.916] Timer tick, asking Buildbucket for the build status
[23:22:29.586] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:29.586] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:263:0) after 1m0s
[23:23:29.628] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:263:0)
[23:23:29.628] Timer tick, asking Buildbucket for the build status
[23:23:29.710] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:29.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:264:0) after 1m0s
[23:24:29.821] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:264:0)
[23:24:29.821] Timer tick, asking Buildbucket for the build status
[23:24:29.942] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:29.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:265:0) after 1m0s
[23:25:30.021] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:265:0)
[23:25:30.021] Timer tick, asking Buildbucket for the build status
[23:25:30.166] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:30.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:266:0) after 1m0s
[23:26:30.244] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:266:0)
[23:26:30.244] Timer tick, asking Buildbucket for the build status
[23:26:30.974] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:30.974] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:267:0) after 1m0s
[23:27:31.017] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:267:0)
[23:27:31.017] Timer tick, asking Buildbucket for the build status
[23:27:31.175] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:31.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:268:0) after 1m0s
[23:28:31.213] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:268:0)
[23:28:31.213] Timer tick, asking Buildbucket for the build status
[23:28:31.387] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:31.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:269:0) after 1m0s
[23:29:31.525] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:269:0)
[23:29:31.525] Timer tick, asking Buildbucket for the build status
[23:29:31.987] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:31.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:270:0) after 1m0s
[23:30:32.253] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:270:0)
[23:30:32.253] Timer tick, asking Buildbucket for the build status
[23:30:32.343] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:32.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:271:0) after 1m0s
[23:31:32.530] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:271:0)
[23:31:32.530] Timer tick, asking Buildbucket for the build status
[23:31:32.696] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:32.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:272:0) after 1m0s
[23:32:32.831] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:272:0)
[23:32:32.831] Timer tick, asking Buildbucket for the build status
[23:32:32.931] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:32.931] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:273:0) after 1m0s
[23:33:33.066] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:273:0)
[23:33:33.066] Timer tick, asking Buildbucket for the build status
[23:33:33.149] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:33.149] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:274:0) after 1m0s
[23:34:33.343] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:274:0)
[23:34:33.343] Timer tick, asking Buildbucket for the build status
[23:34:33.539] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:33.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:275:0) after 1m0s
[23:35:33.891] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:275:0)
[23:35:33.892] Timer tick, asking Buildbucket for the build status
[23:35:34.117] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:34.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:276:0) after 1m0s
[23:36:35.415] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:276:0)
[23:36:35.415] Timer tick, asking Buildbucket for the build status
[23:36:36.773] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:36.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:277:0) after 1m0s
[23:37:36.942] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:277:0)
[23:37:36.942] Timer tick, asking Buildbucket for the build status
[23:37:38.189] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:38.189] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:278:0) after 1m0s
[23:38:38.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:278:0)
[23:38:38.272] Timer tick, asking Buildbucket for the build status
[23:38:39.128] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:39.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:279:0) after 1m0s
[23:39:39.206] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:279:0)
[23:39:39.206] Timer tick, asking Buildbucket for the build status
[23:39:39.365] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:39.365] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:280:0) after 1m0s
[23:40:39.381] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:280:0)
[23:40:39.381] Timer tick, asking Buildbucket for the build status
[23:40:39.578] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:39.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:281:0) after 1m0s
[23:41:39.581] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:281:0)
[23:41:39.581] Timer tick, asking Buildbucket for the build status
[23:41:39.675] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:39.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:282:0) after 1m0s
[23:42:39.816] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:282:0)
[23:42:39.816] Timer tick, asking Buildbucket for the build status
[23:42:39.944] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:39.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:283:0) after 1m0s
[23:43:39.927] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:283:0)
[23:43:39.927] Timer tick, asking Buildbucket for the build status
[23:43:40.016] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:40.016] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:284:0) after 1m0s
[23:44:40.124] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:284:0)
[23:44:40.124] Timer tick, asking Buildbucket for the build status
[23:44:40.506] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:40.506] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:285:0) after 1m0s
[23:45:40.606] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:285:0)
[23:45:40.606] Timer tick, asking Buildbucket for the build status
[23:45:40.860] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:40.860] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:286:0) after 1m0s
[23:46:41.250] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:286:0)
[23:46:41.250] Timer tick, asking Buildbucket for the build status
[23:46:41.594] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:41.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:287:0) after 1m0s
[23:47:42.247] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:287:0)
[23:47:42.247] Timer tick, asking Buildbucket for the build status
[23:47:42.873] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:42.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:288:0) after 1m0s
[23:48:43.152] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:288:0)
[23:48:43.152] Timer tick, asking Buildbucket for the build status
[23:48:43.421] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:43.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:289:0) after 1m0s
[23:49:43.447] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:289:0)
[23:49:43.447] Timer tick, asking Buildbucket for the build status
[23:49:44.082] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:44.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:290:0) after 1m0s
[23:50:44.651] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:290:0)
[23:50:44.651] Timer tick, asking Buildbucket for the build status
[23:50:45.253] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:45.253] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:291:0) after 1m0s
[23:51:45.296] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:291:0)
[23:51:45.296] Timer tick, asking Buildbucket for the build status
[23:51:46.837] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:46.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:292:0) after 1m0s
[23:52:46.870] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:292:0)
[23:52:46.870] Timer tick, asking Buildbucket for the build status
[23:52:47.007] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:47.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:293:0) after 1m0s
[23:53:46.999] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:293:0)
[23:53:46.999] Timer tick, asking Buildbucket for the build status
[23:53:47.125] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:47.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:294:0) after 1m0s
[23:54:47.178] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:294:0)
[23:54:47.178] Timer tick, asking Buildbucket for the build status
[23:54:47.658] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:47.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:295:0) after 1m0s
[23:55:47.721] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:295:0)
[23:55:47.721] Timer tick, asking Buildbucket for the build status
[23:55:48.141] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:48.141] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:296:0) after 1m0s
[23:56:48.180] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:296:0)
[23:56:48.180] Timer tick, asking Buildbucket for the build status
[23:56:48.310] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:48.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:297:0) after 1m0s
[23:57:48.365] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:297:0)
[23:57:48.365] Timer tick, asking Buildbucket for the build status
[23:57:49.509] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:49.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:298:0) after 1m0s
[23:58:49.648] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:298:0)
[23:58:49.648] Timer tick, asking Buildbucket for the build status
[23:58:50.508] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:50.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:299:0) after 1m0s
[23:59:50.535] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:299:0)
[23:59:50.535] Timer tick, asking Buildbucket for the build status
[23:59:50.944] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:50.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:300:0) after 1m0s
[00:00:51.033] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:300:0)
[00:00:51.033] Timer tick, asking Buildbucket for the build status
[00:00:51.584] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:51.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:301:0) after 1m0s
[00:01:51.606] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:301:0)
[00:01:51.606] Timer tick, asking Buildbucket for the build status
[00:01:51.733] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:51.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:302:0) after 1m0s
[00:02:51.815] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:302:0)
[00:02:51.815] Timer tick, asking Buildbucket for the build status
[00:02:51.908] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:51.908] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:303:0) after 1m0s
[00:03:51.940] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:303:0)
[00:03:51.940] Timer tick, asking Buildbucket for the build status
[00:03:52.221] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:52.221] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:304:0) after 1m0s
[00:04:52.335] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:304:0)
[00:04:52.335] Timer tick, asking Buildbucket for the build status
[00:04:52.738] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:52.738] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:305:0) after 1m0s
[00:05:52.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:305:0)
[00:05:52.793] Timer tick, asking Buildbucket for the build status
[00:05:52.976] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:52.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:306:0) after 1m0s
[00:06:53.048] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:306:0)
[00:06:53.048] Timer tick, asking Buildbucket for the build status
[00:06:53.213] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:53.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:307:0) after 1m0s
[00:07:53.714] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:307:0)
[00:07:53.714] Timer tick, asking Buildbucket for the build status
[00:07:53.851] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:53.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:308:0) after 1m0s
[00:08:55.063] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:308:0)
[00:08:55.063] Timer tick, asking Buildbucket for the build status
[00:08:55.145] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:55.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:309:0) after 1m0s
[00:09:55.782] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:309:0)
[00:09:55.782] Timer tick, asking Buildbucket for the build status
[00:09:55.883] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:55.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:310:0) after 1m0s
[00:10:57.005] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:310:0)
[00:10:57.005] Timer tick, asking Buildbucket for the build status
[00:10:57.206] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:57.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:311:0) after 1m0s
[00:11:57.412] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:311:0)
[00:11:57.412] Timer tick, asking Buildbucket for the build status
[00:11:57.525] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:57.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:312:0) after 1m0s
[00:12:57.605] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:312:0)
[00:12:57.605] Timer tick, asking Buildbucket for the build status
[00:12:57.758] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:57.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:313:0) after 1m0s
[00:13:57.866] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:313:0)
[00:13:57.866] Timer tick, asking Buildbucket for the build status
[00:13:57.969] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:57.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:314:0) after 1m0s
[00:14:57.993] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:314:0)
[00:14:57.993] Timer tick, asking Buildbucket for the build status
[00:14:58.121] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:58.121] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:315:0) after 1m0s
[00:15:58.199] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:315:0)
[00:15:58.199] Timer tick, asking Buildbucket for the build status
[00:15:58.307] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:58.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:316:0) after 1m0s
[00:16:58.386] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:316:0)
[00:16:58.386] Timer tick, asking Buildbucket for the build status
[00:16:58.869] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:58.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:317:0) after 1m0s
[00:17:58.925] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:317:0)
[00:17:58.925] Timer tick, asking Buildbucket for the build status
[00:17:59.017] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:59.017] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:318:0) after 1m0s
[00:18:59.053] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:318:0)
[00:18:59.053] Timer tick, asking Buildbucket for the build status
[00:18:59.124] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:59.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:319:0) after 1m0s
[00:19:59.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:319:0)
[00:19:59.186] Timer tick, asking Buildbucket for the build status
[00:19:59.281] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:59.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:320:0) after 1m0s
[00:20:59.420] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:320:0)
[00:20:59.420] Timer tick, asking Buildbucket for the build status
[00:20:59.765] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:59.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:321:0) after 1m0s
[00:21:59.899] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:321:0)
[00:21:59.899] Timer tick, asking Buildbucket for the build status
[00:22:00.052] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:00.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:322:0) after 1m0s
[00:23:00.156] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:322:0)
[00:23:00.156] Timer tick, asking Buildbucket for the build status
[00:23:00.232] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:00.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:323:0) after 1m0s
[00:24:00.323] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:323:0)
[00:24:00.323] Timer tick, asking Buildbucket for the build status
[00:24:00.463] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:00.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:324:0) after 1m0s
[00:25:01.010] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:324:0)
[00:25:01.010] Timer tick, asking Buildbucket for the build status
[00:25:01.608] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:01.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:325:0) after 1m0s
[00:26:02.292] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:325:0)
[00:26:02.292] Timer tick, asking Buildbucket for the build status
[00:26:02.434] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:02.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:326:0) after 1m0s
[00:27:02.640] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:326:0)
[00:27:02.640] Timer tick, asking Buildbucket for the build status
[00:27:02.773] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:02.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:327:0) after 1m0s
[00:28:03.315] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:327:0)
[00:28:03.315] Timer tick, asking Buildbucket for the build status
[00:28:03.413] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:03.413] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:328:0) after 1m0s
[00:29:03.994] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:328:0)
[00:29:03.994] Timer tick, asking Buildbucket for the build status
[00:29:04.278] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:04.278] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:329:0) after 1m0s
[00:30:04.399] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:329:0)
[00:30:04.399] Timer tick, asking Buildbucket for the build status
[00:30:04.549] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:04.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:330:0) after 1m0s
[00:31:04.615] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:330:0)
[00:31:04.615] Timer tick, asking Buildbucket for the build status
[00:31:04.877] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:04.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:331:0) after 1m0s
[00:32:05.010] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:331:0)
[00:32:05.010] Timer tick, asking Buildbucket for the build status
[00:32:05.103] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:05.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:332:0) after 1m0s
[00:33:05.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:332:0)
[00:33:05.290] Timer tick, asking Buildbucket for the build status
[00:33:05.515] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:05.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:333:0) after 1m0s
[00:34:05.539] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:333:0)
[00:34:05.539] Timer tick, asking Buildbucket for the build status
[00:34:05.716] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:05.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:334:0) after 1m0s
[00:35:05.846] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:334:0)
[00:35:05.846] Timer tick, asking Buildbucket for the build status
[00:35:05.936] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:05.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:335:0) after 1m0s
[00:36:05.988] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:335:0)
[00:36:05.988] Timer tick, asking Buildbucket for the build status
[00:36:06.290] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:06.290] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:336:0) after 1m0s
[00:37:06.333] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:336:0)
[00:37:06.333] Timer tick, asking Buildbucket for the build status
[00:37:06.400] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:06.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:337:0) after 1m0s
[00:38:06.503] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:337:0)
[00:38:06.503] Timer tick, asking Buildbucket for the build status
[00:38:06.602] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:06.602] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:338:0) after 1m0s
[00:39:06.810] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:338:0)
[00:39:06.810] Timer tick, asking Buildbucket for the build status
[00:39:06.894] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:06.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:339:0) after 1m0s
[00:40:06.976] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:339:0)
[00:40:06.976] Timer tick, asking Buildbucket for the build status
[00:40:07.586] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:07.586] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:340:0) after 1m0s
[00:41:07.636] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:340:0)
[00:41:07.636] Timer tick, asking Buildbucket for the build status
[00:41:07.782] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:07.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:341:0) after 1m0s
[00:42:07.811] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:341:0)
[00:42:07.811] Timer tick, asking Buildbucket for the build status
[00:42:08.003] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:08.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:342:0) after 1m0s
[00:43:08.140] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:342:0)
[00:43:08.140] Timer tick, asking Buildbucket for the build status
[00:43:08.499] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:08.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:343:0) after 1m0s
[00:44:08.699] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:343:0)
[00:44:08.699] Timer tick, asking Buildbucket for the build status
[00:44:08.771] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:08.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:344:0) after 1m0s
[00:45:08.892] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:344:0)
[00:45:08.892] Timer tick, asking Buildbucket for the build status
[00:45:09.009] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:09.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:345:0) after 1m0s
[00:46:09.060] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:345:0)
[00:46:09.060] Timer tick, asking Buildbucket for the build status
[00:46:12.943] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:12.943] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:346:0) after 1m0s
[00:47:12.990] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:346:0)
[00:47:12.990] Timer tick, asking Buildbucket for the build status
[00:47:15.703] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:15.703] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:347:0) after 1m0s
[00:48:15.775] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:347:0)
[00:48:15.775] Timer tick, asking Buildbucket for the build status
[00:48:16.063] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:16.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:348:0) after 1m0s
[00:49:16.096] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:348:0)
[00:49:16.096] Timer tick, asking Buildbucket for the build status
[00:49:16.166] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:16.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:349:0) after 1m0s
[00:50:16.219] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:349:0)
[00:50:16.219] Timer tick, asking Buildbucket for the build status
[00:50:19.296] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:19.296] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:350:0) after 1m0s
[00:51:19.379] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:350:0)
[00:51:19.379] Timer tick, asking Buildbucket for the build status
[00:51:19.621] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:19.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:351:0) after 1m0s
[00:52:19.757] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:351:0)
[00:52:19.757] Timer tick, asking Buildbucket for the build status
[00:52:19.855] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:19.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:352:0) after 1m0s
[00:53:20.081] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:352:0)
[00:53:20.081] Timer tick, asking Buildbucket for the build status
[00:53:20.144] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:20.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:353:0) after 1m0s
[00:54:20.283] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:353:0)
[00:54:20.283] Timer tick, asking Buildbucket for the build status
[00:54:20.460] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:20.460] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:354:0) after 1m0s
[00:55:20.600] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:354:0)
[00:55:20.600] Timer tick, asking Buildbucket for the build status
[00:55:20.726] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:20.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:355:0) after 1m0s
[00:56:20.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:355:0)
[00:56:20.834] Timer tick, asking Buildbucket for the build status
[00:56:21.040] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:21.040] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:356:0) after 1m0s
[00:57:21.098] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:356:0)
[00:57:21.098] Timer tick, asking Buildbucket for the build status
[00:57:21.185] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:21.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:357:0) after 1m0s
[00:58:21.246] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:357:0)
[00:58:21.246] Timer tick, asking Buildbucket for the build status
[00:58:21.342] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:21.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:358:0) after 1m0s
[00:59:21.476] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:358:0)
[00:59:21.476] Timer tick, asking Buildbucket for the build status
[00:59:21.653] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:21.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:359:0) after 1m0s
[01:00:21.690] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:359:0)
[01:00:21.690] Timer tick, asking Buildbucket for the build status
[01:00:21.801] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:21.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:360:0) after 1m0s
[01:01:21.958] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:360:0)
[01:01:21.958] Timer tick, asking Buildbucket for the build status
[01:01:22.106] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:22.106] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:361:0) after 1m0s
[01:02:22.202] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:361:0)
[01:02:22.202] Timer tick, asking Buildbucket for the build status
[01:02:22.384] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:22.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:362:0) after 1m0s
[01:03:22.523] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:362:0)
[01:03:22.523] Timer tick, asking Buildbucket for the build status
[01:03:22.762] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:22.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:363:0) after 1m0s
[01:04:22.807] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:363:0)
[01:04:22.807] Timer tick, asking Buildbucket for the build status
[01:04:22.955] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:22.955] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:364:0) after 1m0s
[01:05:23.062] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:364:0)
[01:05:23.062] Timer tick, asking Buildbucket for the build status
[01:05:23.159] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:23.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:365:0) after 1m0s
[01:06:23.191] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:365:0)
[01:06:23.191] Timer tick, asking Buildbucket for the build status
[01:06:23.376] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:23.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:366:0) after 1m0s
[01:07:23.475] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:366:0)
[01:07:23.475] Timer tick, asking Buildbucket for the build status
[01:07:23.569] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:23.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:367:0) after 1m0s
[01:08:23.695] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:367:0)
[01:08:23.695] Timer tick, asking Buildbucket for the build status
[01:08:23.760] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:23.761] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:368:0) after 1m0s
[01:09:24.140] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:368:0)
[01:09:24.140] Timer tick, asking Buildbucket for the build status
[01:09:24.305] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:24.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:369:0) after 1m0s
[01:10:25.353] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:369:0)
[01:10:25.353] Timer tick, asking Buildbucket for the build status
[01:10:25.843] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:25.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:370:0) after 1m0s
[01:11:25.928] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:370:0)
[01:11:25.928] Timer tick, asking Buildbucket for the build status
[01:11:26.051] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:26.051] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:371:0) after 1m0s
[01:12:26.576] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:371:0)
[01:12:26.576] Timer tick, asking Buildbucket for the build status
[01:12:26.812] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:26.812] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:372:0) after 1m0s
[01:13:27.417] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:372:0)
[01:13:27.417] Timer tick, asking Buildbucket for the build status
[01:13:27.643] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:27.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:373:0) after 1m0s
[01:14:27.739] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:373:0)
[01:14:27.739] Timer tick, asking Buildbucket for the build status
[01:14:27.802] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:27.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:374:0) after 1m0s
[01:15:28.052] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:374:0)
[01:15:28.052] Timer tick, asking Buildbucket for the build status
[01:15:32.235] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:32.235] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:375:0) after 1m0s
[01:16:33.013] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:375:0)
[01:16:33.013] Timer tick, asking Buildbucket for the build status
[01:16:33.358] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:33.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:376:0) after 1m0s
[01:17:33.498] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:376:0)
[01:17:33.498] Timer tick, asking Buildbucket for the build status
[01:17:33.914] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:33.914] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:377:0) after 1m0s
[01:18:34.254] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:377:0)
[01:18:34.254] Timer tick, asking Buildbucket for the build status
[01:18:34.334] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:34.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:378:0) after 1m0s
[01:19:34.442] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:378:0)
[01:19:34.442] Timer tick, asking Buildbucket for the build status
[01:19:34.580] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:34.580] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:379:0) after 1m0s
[01:20:34.715] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:379:0)
[01:20:34.715] Timer tick, asking Buildbucket for the build status
[01:20:34.817] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:34.817] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:380:0) after 1m0s
[01:21:34.938] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:380:0)
[01:21:34.938] Timer tick, asking Buildbucket for the build status
[01:21:35.201] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:35.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:381:0) after 1m0s
[01:22:35.418] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:381:0)
[01:22:35.418] Timer tick, asking Buildbucket for the build status
[01:22:35.792] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:35.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:382:0) after 1m0s
[01:23:35.879] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:382:0)
[01:23:35.879] Timer tick, asking Buildbucket for the build status
[01:23:35.980] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:35.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:383:0) after 1m0s
[01:24:36.382] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:383:0)
[01:24:36.382] Timer tick, asking Buildbucket for the build status
[01:24:36.489] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:36.489] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:384:0) after 1m0s
[01:25:36.786] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:384:0)
[01:25:36.786] Timer tick, asking Buildbucket for the build status
[01:25:37.081] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:37.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:385:0) after 1m0s
[01:26:37.119] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:385:0)
[01:26:37.119] Timer tick, asking Buildbucket for the build status
[01:26:37.210] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:37.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:386:0) after 1m0s
[01:27:37.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:386:0)
[01:27:37.487] Timer tick, asking Buildbucket for the build status
[01:27:37.909] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:37.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:387:0) after 1m0s
[01:28:38.114] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:387:0)
[01:28:38.114] Timer tick, asking Buildbucket for the build status
[01:28:38.264] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:38.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:388:0) after 1m0s
[01:29:38.378] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:388:0)
[01:29:38.378] Timer tick, asking Buildbucket for the build status
[01:29:38.488] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:38.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:389:0) after 1m0s
[01:30:38.622] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:389:0)
[01:30:38.622] Timer tick, asking Buildbucket for the build status
[01:30:38.966] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:38.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:390:0) after 1m0s
[01:31:39.132] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:390:0)
[01:31:39.132] Timer tick, asking Buildbucket for the build status
[01:31:41.113] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:41.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:391:0) after 1m0s
[01:32:42.058] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:391:0)
[01:32:42.058] Timer tick, asking Buildbucket for the build status
[01:32:42.645] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:42.646] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:392:0) after 1m0s
[01:33:42.700] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:392:0)
[01:33:42.700] Timer tick, asking Buildbucket for the build status
[01:33:42.769] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:42.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:393:0) after 1m0s
[01:34:42.806] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:393:0)
[01:34:42.806] Timer tick, asking Buildbucket for the build status
[01:34:42.858] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:42.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:394:0) after 1m0s
[01:35:43.025] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:394:0)
[01:35:43.025] Timer tick, asking Buildbucket for the build status
[01:35:43.148] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:43.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:395:0) after 1m0s
[01:36:43.966] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:395:0)
[01:36:43.966] Timer tick, asking Buildbucket for the build status
[01:36:44.124] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:44.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:396:0) after 1m0s
[01:37:44.336] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:396:0)
[01:37:44.336] Timer tick, asking Buildbucket for the build status
[01:37:44.405] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:44.405] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:397:0) after 1m0s
[01:38:44.487] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:397:0)
[01:38:44.487] Timer tick, asking Buildbucket for the build status
[01:38:44.734] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:44.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:398:0) after 1m0s
[01:39:45.172] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:398:0)
[01:39:45.172] Timer tick, asking Buildbucket for the build status
[01:39:45.266] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:45.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:399:0) after 1m0s
[01:40:45.898] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:399:0)
[01:40:45.898] Timer tick, asking Buildbucket for the build status
[01:40:46.028] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:46.028] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:400:0) after 1m0s
[01:41:46.592] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:400:0)
[01:41:46.592] Timer tick, asking Buildbucket for the build status
[01:41:46.821] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:46.821] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:401:0) after 1m0s
[01:42:46.987] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:401:0)
[01:42:46.987] Timer tick, asking Buildbucket for the build status
[01:42:47.045] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:47.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:402:0) after 1m0s
[01:43:47.178] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:402:0)
[01:43:47.178] Timer tick, asking Buildbucket for the build status
[01:43:47.256] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:47.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:403:0) after 1m0s
[01:44:47.411] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:403:0)
[01:44:47.411] Timer tick, asking Buildbucket for the build status
[01:44:47.505] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:47.505] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:404:0) after 1m0s
[01:45:48.135] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:404:0)
[01:45:48.135] Timer tick, asking Buildbucket for the build status
[01:45:48.322] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:48.322] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:405:0) after 1m0s
[01:46:48.536] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:405:0)
[01:46:48.536] Timer tick, asking Buildbucket for the build status
[01:46:50.497] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:50.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:406:0) after 1m0s
[01:47:50.626] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:406:0)
[01:47:50.626] Timer tick, asking Buildbucket for the build status
[01:47:50.772] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:50.772] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:407:0) after 1m0s
[01:48:50.842] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:407:0)
[01:48:50.842] Timer tick, asking Buildbucket for the build status
[01:48:50.920] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:50.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:408:0) after 1m0s
[01:49:51.080] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:408:0)
[01:49:51.080] Timer tick, asking Buildbucket for the build status
[01:49:51.158] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:51.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:409:0) after 1m0s
[01:50:51.781] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:409:0)
[01:50:51.781] Timer tick, asking Buildbucket for the build status
[01:50:51.920] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:51.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:410:0) after 1m0s
[01:51:52.155] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:410:0)
[01:51:52.155] Timer tick, asking Buildbucket for the build status
[01:51:52.569] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:52.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:411:0) after 1m0s
[01:52:52.663] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:411:0)
[01:52:52.663] Timer tick, asking Buildbucket for the build status
[01:52:52.747] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:52.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:412:0) after 1m0s
[01:53:52.935] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:412:0)
[01:53:52.935] Timer tick, asking Buildbucket for the build status
[01:53:53.234] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:53.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:413:0) after 1m0s
[01:54:53.257] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:413:0)
[01:54:53.257] Timer tick, asking Buildbucket for the build status
[01:54:53.328] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:53.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:414:0) after 1m0s
[01:55:53.333] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:414:0)
[01:55:53.333] Timer tick, asking Buildbucket for the build status
[01:55:53.492] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:53.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:415:0) after 1m0s
[01:56:53.605] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:415:0)
[01:56:53.605] Timer tick, asking Buildbucket for the build status
[01:56:53.849] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:53.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:416:0) after 1m0s
[01:57:54.292] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:416:0)
[01:57:54.292] Timer tick, asking Buildbucket for the build status
[01:57:54.351] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:54.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:417:0) after 1m0s
[01:58:54.451] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:417:0)
[01:58:54.451] Timer tick, asking Buildbucket for the build status
[01:58:54.513] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:54.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:418:0) after 1m0s
[01:59:54.687] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:418:0)
[01:59:54.687] Timer tick, asking Buildbucket for the build status
[01:59:54.799] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:54.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:419:0) after 1m0s
[02:00:55.189] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:419:0)
[02:00:55.189] Timer tick, asking Buildbucket for the build status
[02:00:55.370] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:55.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:420:0) after 1m0s
[02:01:55.686] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:420:0)
[02:01:55.686] Timer tick, asking Buildbucket for the build status
[02:01:55.745] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:55.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:421:0) after 1m0s
[02:02:55.856] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:421:0)
[02:02:55.856] Timer tick, asking Buildbucket for the build status
[02:02:56.142] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:56.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:422:0) after 1m0s
[02:03:56.188] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:422:0)
[02:03:56.188] Timer tick, asking Buildbucket for the build status
[02:03:56.258] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:56.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:423:0) after 1m0s
[02:04:56.301] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:423:0)
[02:04:56.301] Timer tick, asking Buildbucket for the build status
[02:04:58.881] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:58.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:424:0) after 1m0s
[02:05:59.209] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:424:0)
[02:05:59.209] Timer tick, asking Buildbucket for the build status
[02:05:59.347] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:59.347] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:425:0) after 1m0s
[02:06:59.429] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:425:0)
[02:06:59.429] Timer tick, asking Buildbucket for the build status
[02:06:59.830] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:59.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:426:0) after 1m0s
[02:07:59.993] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:426:0)
[02:07:59.993] Timer tick, asking Buildbucket for the build status
[02:08:00.188] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:00.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:427:0) after 1m0s
[02:09:00.227] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:427:0)
[02:09:00.227] Timer tick, asking Buildbucket for the build status
[02:09:00.295] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:00.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:428:0) after 1m0s
[02:10:00.397] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:428:0)
[02:10:00.397] Timer tick, asking Buildbucket for the build status
[02:10:00.541] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:00.541] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:429:0) after 1m0s
[02:11:00.620] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:429:0)
[02:11:00.620] Timer tick, asking Buildbucket for the build status
[02:11:01.467] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:01.467] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:430:0) after 1m0s
[02:12:01.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:430:0)
[02:12:01.738] Timer tick, asking Buildbucket for the build status
[02:12:01.859] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
--- the log has been cut here ---
[05:24:15.943] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:15.943] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:621:0) after 1m0s
[05:25:15.970] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:621:0)
[05:25:15.970] Timer tick, asking Buildbucket for the build status
[05:25:16.061] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:16.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:622:0) after 1m0s
[05:26:16.211] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:622:0)
[05:26:16.211] Timer tick, asking Buildbucket for the build status
[05:26:16.583] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:16.583] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:623:0) after 1m0s
[05:27:16.619] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:623:0)
[05:27:16.619] Timer tick, asking Buildbucket for the build status
[05:27:16.671] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:16.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:624:0) after 1m0s
[05:28:16.773] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:624:0)
[05:28:16.773] Timer tick, asking Buildbucket for the build status
[05:28:16.844] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:16.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:625:0) after 1m0s
[05:29:16.930] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:625:0)
[05:29:16.930] Timer tick, asking Buildbucket for the build status
[05:29:17.008] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:17.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:626:0) after 1m0s
[05:30:17.046] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:626:0)
[05:30:17.046] Timer tick, asking Buildbucket for the build status
[05:30:17.109] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:17.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:627:0) after 1m0s
[05:31:17.224] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:627:0)
[05:31:17.224] Timer tick, asking Buildbucket for the build status
[05:31:17.999] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:17.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:628:0) after 1m0s
[05:32:18.087] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:628:0)
[05:32:18.087] Timer tick, asking Buildbucket for the build status
[05:32:18.501] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:18.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:629:0) after 1m0s
[05:33:18.559] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:629:0)
[05:33:18.559] Timer tick, asking Buildbucket for the build status
[05:33:18.694] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:18.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:630:0) after 1m0s
[05:34:18.785] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:630:0)
[05:34:18.785] Timer tick, asking Buildbucket for the build status
[05:34:18.866] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:18.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:631:0) after 1m0s
[05:35:18.924] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:631:0)
[05:35:18.924] Timer tick, asking Buildbucket for the build status
[05:35:18.991] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:18.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:632:0) after 1m0s
[05:36:19.131] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:632:0)
[05:36:19.131] Timer tick, asking Buildbucket for the build status
[05:36:19.215] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:19.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:633:0) after 1m0s
[05:37:19.288] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:633:0)
[05:37:19.288] Timer tick, asking Buildbucket for the build status
[05:37:19.369] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:19.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:634:0) after 1m0s
[05:38:19.511] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:634:0)
[05:38:19.511] Timer tick, asking Buildbucket for the build status
[05:38:19.564] Build 8855748413834025792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:19.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9021178476043677200:635:0) after 1m0s
[05:39:08.034] Received PubSub notification, asking Buildbucket for the build status
[05:39:08.167] Build 8855748413834025792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:39:08.167] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "completed_ts": "1612935546854882",
    "created_by": "project:nacl",
    "created_ts": "1612897207379926",
    "id": "8855748413834025792",
    "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\": \"4de55da44c4b511989359381e8b7a88a01fe0634\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4de55da44c4b511989359381e8b7a88a01fe0634\", \"title\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/4de55da44c4b511989359381e8b7a88a01fe0634\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\"}}",
    "project": "nacl",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@4de55da44c4b511989359381e8b7a88a01fe0634\", \"title\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/4de55da44c4b511989359381e8b7a88a01fe0634\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-flex-ci-xenial-5-n3mr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.nacl\", \"buildername\": \"linux-64-validator-opt\", \"buildnumber\": 162, \"got_revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_652d1a85f59d6ac7e9be85dfbfa556796d3839fbf4982bbced94564eb5c7b05b_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-flex-ci-xenial-5-n3mr\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.flex.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1612898267933797",
    "status": "COMPLETED",
    "status_changed_ts": "1612935547474845",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/162",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/4de55da44c4b511989359381e8b7a88a01fe0634",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/4de55da44c4b511989359381e8b7a88a01fe0634",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9021178476043677200",
      "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/8855748413834025792/+/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:51a0fbf57334f010",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1612935547576760",
    "url": "https://ci.chromium.org/b/8855748413834025792",
    "utcnow_ts": "1612935548149234"
  }
}
[05:39:08.167] Invocation finished in 10h39m2.279483936s with status SUCCEEDED