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

• 6725bbc5ec5a64f7becb0a6eeba8395aa2a72972 (4 years ago)

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

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

[11:32:08.740] New invocation is queued and will start shortly
[11:32:12.909] Starting the invocation (attempt 1)
[11:32:12.957] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:32:12.957] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:32:12.957] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9040685006570405872",
  "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\":\"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\",\"title\":\"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}}",
  "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:9040685006570405872",
    "scheduler_job_id:nacl/linux-64-validator-opt",
    "user_agent:luci-scheduler",
    "buildset:commit/git/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972",
    "gitiles_ref:refs/heads/master"
  ]
}
[11:32:14.160] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1594294333074330",
    "id": "8875254941360704512",
    "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\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\", \"title\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1594294333769160",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/147",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9040685006570405872",
      "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/8875254941360704512/+/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": "1594294333769326",
    "url": "https://ci.chromium.org/b/8875254941360704512",
    "utcnow_ts": "1594294334091546"
  }
}
[11:32:14.160] Task URL: https://ci.chromium.org/b/8875254941360704512
[11:32:14.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:2:0) after 1m0s
[11:32:19.116] Received PubSub notification, asking Buildbucket for the build status
[11:32:19.222] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:14.299] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:2:0)
[11:33:14.299] Timer tick, asking Buildbucket for the build status
[11:33:14.966] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:14.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:4:0) after 1m0s
[11:34:15.139] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:4:0)
[11:34:15.139] Timer tick, asking Buildbucket for the build status
[11:34:15.683] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:15.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:5:0) after 1m0s
[11:35:15.817] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:5:0)
[11:35:15.817] Timer tick, asking Buildbucket for the build status
[11:35:15.968] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:15.968] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:6:0) after 1m0s
[11:36:15.992] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:6:0)
[11:36:15.992] Timer tick, asking Buildbucket for the build status
[11:36:16.294] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:16.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:7:0) after 1m0s
[11:37:16.399] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:7:0)
[11:37:16.399] Timer tick, asking Buildbucket for the build status
[11:37:16.593] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:16.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:8:0) after 1m0s
[11:38:16.772] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:8:0)
[11:38:16.772] Timer tick, asking Buildbucket for the build status
[11:38:17.226] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:17.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:9:0) after 1m0s
[11:39:17.225] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:9:0)
[11:39:17.225] Timer tick, asking Buildbucket for the build status
[11:39:17.369] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:17.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:10:0) after 1m0s
[11:40:17.787] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:10:0)
[11:40:17.787] Timer tick, asking Buildbucket for the build status
[11:40:17.957] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:17.957] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:11:0) after 1m0s
[11:41:18.139] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:11:0)
[11:41:18.139] Timer tick, asking Buildbucket for the build status
[11:41:18.438] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:18.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:12:0) after 1m0s
[11:42:18.577] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:12:0)
[11:42:18.577] Timer tick, asking Buildbucket for the build status
[11:42:18.727] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:18.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:13:0) after 1m0s
[11:43:18.841] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:13:0)
[11:43:18.841] Timer tick, asking Buildbucket for the build status
[11:43:19.890] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:19.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:14:0) after 1m0s
[11:44:19.995] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:14:0)
[11:44:19.995] Timer tick, asking Buildbucket for the build status
[11:44:20.340] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:20.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:15:0) after 1m0s
[11:45:20.687] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:15:0)
[11:45:20.687] Timer tick, asking Buildbucket for the build status
[11:45:20.902] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:20.902] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:16:0) after 1m0s
[11:46:21.004] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:16:0)
[11:46:21.004] Timer tick, asking Buildbucket for the build status
[11:46:21.318] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:21.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:17:0) after 1m0s
[11:47:21.432] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:17:0)
[11:47:21.432] Timer tick, asking Buildbucket for the build status
[11:47:21.612] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:21.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:18:0) after 1m0s
[11:48:21.725] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:18:0)
[11:48:21.725] Timer tick, asking Buildbucket for the build status
[11:48:21.866] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:21.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:19:0) after 1m0s
[11:49:21.956] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:19:0)
[11:49:21.956] Timer tick, asking Buildbucket for the build status
[11:49:22.125] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:22.125] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:20:0) after 1m0s
[11:50:22.473] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:20:0)
[11:50:22.473] Timer tick, asking Buildbucket for the build status
[11:50:22.756] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:22.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:21:0) after 1m0s
[11:51:22.955] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:21:0)
[11:51:22.955] Timer tick, asking Buildbucket for the build status
[11:51:23.122] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:23.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:22:0) after 1m0s
[11:52:23.285] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:22:0)
[11:52:23.285] Timer tick, asking Buildbucket for the build status
[11:52:23.407] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:23.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:23:0) after 1m0s
[11:53:23.478] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:23:0)
[11:53:23.478] Timer tick, asking Buildbucket for the build status
[11:53:23.673] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:23.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:24:0) after 1m0s
[11:54:23.719] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:24:0)
[11:54:23.719] Timer tick, asking Buildbucket for the build status
[11:54:24.348] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:24.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:25:0) after 1m0s
[11:55:24.378] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:25:0)
[11:55:24.378] Timer tick, asking Buildbucket for the build status
[11:55:24.570] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:24.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:26:0) after 1m0s
[11:56:24.637] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:26:0)
[11:56:24.637] Timer tick, asking Buildbucket for the build status
[11:56:24.795] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:24.795] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:27:0) after 1m0s
[11:57:24.919] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:27:0)
[11:57:24.919] Timer tick, asking Buildbucket for the build status
[11:57:25.087] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:25.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:28:0) after 1m0s
[11:58:25.172] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:28:0)
[11:58:25.172] Timer tick, asking Buildbucket for the build status
[11:58:26.337] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:26.337] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:29:0) after 1m0s
[11:59:26.402] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:29:0)
[11:59:26.402] Timer tick, asking Buildbucket for the build status
[11:59:27.039] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:27.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:30:0) after 1m0s
[12:00:27.097] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:30:0)
[12:00:27.097] Timer tick, asking Buildbucket for the build status
[12:00:29.024] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:29.024] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:31:0) after 1m0s
[12:01:29.126] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:31:0)
[12:01:29.126] Timer tick, asking Buildbucket for the build status
[12:01:31.472] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:31.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:32:0) after 1m0s
[12:02:31.584] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:32:0)
[12:02:31.584] Timer tick, asking Buildbucket for the build status
[12:02:33.045] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:33.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:33:0) after 1m0s
[12:03:33.085] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:33:0)
[12:03:33.085] Timer tick, asking Buildbucket for the build status
[12:03:33.207] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:33.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:34:0) after 1m0s
[12:04:33.279] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:34:0)
[12:04:33.279] Timer tick, asking Buildbucket for the build status
[12:04:33.391] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:33.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:35:0) after 1m0s
[12:05:33.414] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:35:0)
[12:05:33.414] Timer tick, asking Buildbucket for the build status
[12:05:33.553] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:33.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:36:0) after 1m0s
[12:06:33.536] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:36:0)
[12:06:33.536] Timer tick, asking Buildbucket for the build status
[12:06:34.223] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:34.223] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:37:0) after 1m0s
[12:07:34.271] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:37:0)
[12:07:34.271] Timer tick, asking Buildbucket for the build status
[12:07:34.456] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:34.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:38:0) after 1m0s
[12:08:34.565] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:38:0)
[12:08:34.565] Timer tick, asking Buildbucket for the build status
[12:08:34.805] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:34.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:39:0) after 1m0s
[12:09:34.871] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:39:0)
[12:09:34.871] Timer tick, asking Buildbucket for the build status
[12:09:35.024] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:35.024] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:40:0) after 1m0s
[12:10:35.124] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:40:0)
[12:10:35.124] Timer tick, asking Buildbucket for the build status
[12:10:35.242] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:35.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:41:0) after 1m0s
[12:11:35.307] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:41:0)
[12:11:35.307] Timer tick, asking Buildbucket for the build status
[12:11:35.443] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:35.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:42:0) after 1m0s
[12:12:35.511] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:42:0)
[12:12:35.511] Timer tick, asking Buildbucket for the build status
[12:12:35.948] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:35.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:43:0) after 1m0s
[12:13:35.974] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:43:0)
[12:13:35.974] Timer tick, asking Buildbucket for the build status
[12:13:36.300] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:36.300] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:44:0) after 1m0s
[12:14:36.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:44:0)
[12:14:36.290] Timer tick, asking Buildbucket for the build status
[12:14:36.394] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:36.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:45:0) after 1m0s
[12:15:36.397] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:45:0)
[12:15:36.397] Timer tick, asking Buildbucket for the build status
[12:15:36.525] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:36.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:46:0) after 1m0s
[12:16:36.653] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:46:0)
[12:16:36.653] Timer tick, asking Buildbucket for the build status
[12:16:36.785] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:36.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:47:0) after 1m0s
[12:17:36.862] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:47:0)
[12:17:36.862] Timer tick, asking Buildbucket for the build status
[12:17:37.049] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:37.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:48:0) after 1m0s
[12:18:37.213] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:48:0)
[12:18:37.213] Timer tick, asking Buildbucket for the build status
[12:18:37.354] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:37.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:49:0) after 1m0s
[12:19:37.372] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:49:0)
[12:19:37.372] Timer tick, asking Buildbucket for the build status
[12:19:37.632] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:37.632] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:50:0) after 1m0s
[12:20:38.218] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:50:0)
[12:20:38.218] Timer tick, asking Buildbucket for the build status
[12:20:38.475] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:38.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:51:0) after 1m0s
[12:21:38.505] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:51:0)
[12:21:38.505] Timer tick, asking Buildbucket for the build status
[12:21:38.662] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:38.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:52:0) after 1m0s
[12:22:38.919] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:52:0)
[12:22:38.919] Timer tick, asking Buildbucket for the build status
[12:22:39.077] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:39.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:53:0) after 1m0s
[12:23:39.173] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:53:0)
[12:23:39.173] Timer tick, asking Buildbucket for the build status
[12:23:39.340] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:39.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:54:0) after 1m0s
[12:24:41.509] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:54:0)
[12:24:41.509] Timer tick, asking Buildbucket for the build status
[12:24:41.990] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:41.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:55:0) after 1m0s
[12:25:42.240] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:55:0)
[12:25:42.240] Timer tick, asking Buildbucket for the build status
[12:25:42.476] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:42.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:56:0) after 1m0s
[12:26:44.715] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:56:0)
[12:26:44.715] Timer tick, asking Buildbucket for the build status
[12:26:44.956] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:44.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:57:0) after 1m0s
[12:27:45.297] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:57:0)
[12:27:45.297] Timer tick, asking Buildbucket for the build status
[12:27:45.453] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:45.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:58:0) after 1m0s
[12:28:45.851] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:58:0)
[12:28:45.851] Timer tick, asking Buildbucket for the build status
[12:28:46.055] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:46.055] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:59:0) after 1m0s
[12:29:46.312] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:59:0)
[12:29:46.312] Timer tick, asking Buildbucket for the build status
[12:29:46.435] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:46.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:60:0) after 1m0s
[12:30:46.854] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:60:0)
[12:30:46.854] Timer tick, asking Buildbucket for the build status
[12:30:47.682] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:47.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:61:0) after 1m0s
[12:31:48.025] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:61:0)
[12:31:48.025] Timer tick, asking Buildbucket for the build status
[12:31:48.426] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:48.426] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:62:0) after 1m0s
[12:32:48.454] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:62:0)
[12:32:48.454] Timer tick, asking Buildbucket for the build status
[12:32:49.257] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:49.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:63:0) after 1m0s
[12:33:49.351] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:63:0)
[12:33:49.351] Timer tick, asking Buildbucket for the build status
[12:33:49.721] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:49.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:64:0) after 1m0s
[12:34:49.822] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:64:0)
[12:34:49.822] Timer tick, asking Buildbucket for the build status
[12:34:50.133] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:50.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:65:0) after 1m0s
[12:35:50.341] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:65:0)
[12:35:50.341] Timer tick, asking Buildbucket for the build status
[12:35:50.501] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:50.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:66:0) after 1m0s
[12:36:52.592] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:66:0)
[12:36:52.592] Timer tick, asking Buildbucket for the build status
[12:36:52.754] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:52.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:67:0) after 1m0s
[12:37:52.989] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:67:0)
[12:37:52.989] Timer tick, asking Buildbucket for the build status
[12:38:02.282] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:02.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:68:0) after 1m0s
[12:39:05.246] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:68:0)
[12:39:05.246] Timer tick, asking Buildbucket for the build status
[12:39:05.516] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:05.516] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:69:0) after 1m0s
[12:40:05.555] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:69:0)
[12:40:05.555] Timer tick, asking Buildbucket for the build status
[12:40:05.673] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:05.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:70:0) after 1m0s
[12:41:05.696] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:70:0)
[12:41:05.697] Timer tick, asking Buildbucket for the build status
[12:41:06.083] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:06.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:71:0) after 1m0s
[12:42:06.263] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:71:0)
[12:42:06.263] Timer tick, asking Buildbucket for the build status
[12:42:06.532] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:06.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:72:0) after 1m0s
[12:43:06.686] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:72:0)
[12:43:06.686] Timer tick, asking Buildbucket for the build status
[12:43:07.011] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:07.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:73:0) after 1m0s
[12:44:07.051] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:73:0)
[12:44:07.051] Timer tick, asking Buildbucket for the build status
[12:44:07.252] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:07.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:74:0) after 1m0s
[12:45:07.353] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:74:0)
[12:45:07.353] Timer tick, asking Buildbucket for the build status
[12:45:09.903] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:09.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:75:0) after 1m0s
[12:46:10.042] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:75:0)
[12:46:10.042] Timer tick, asking Buildbucket for the build status
[12:46:10.733] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:10.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:76:0) after 1m0s
[12:47:10.763] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:76:0)
[12:47:10.763] Timer tick, asking Buildbucket for the build status
[12:47:11.468] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:11.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:77:0) after 1m0s
[12:48:11.488] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:77:0)
[12:48:11.488] Timer tick, asking Buildbucket for the build status
[12:48:12.495] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:12.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:78:0) after 1m0s
[12:49:12.596] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:78:0)
[12:49:12.596] Timer tick, asking Buildbucket for the build status
[12:49:12.762] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:12.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:79:0) after 1m0s
[12:50:12.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:79:0)
[12:50:12.834] Timer tick, asking Buildbucket for the build status
[12:50:13.260] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:13.260] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:80:0) after 1m0s
[12:51:13.302] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:80:0)
[12:51:13.302] Timer tick, asking Buildbucket for the build status
[12:51:13.447] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:13.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:81:0) after 1m0s
[12:52:13.500] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:81:0)
[12:52:13.500] Timer tick, asking Buildbucket for the build status
[12:52:13.662] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:13.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:82:0) after 1m0s
[12:53:13.706] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:82:0)
[12:53:13.706] Timer tick, asking Buildbucket for the build status
[12:53:13.829] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:13.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:83:0) after 1m0s
[12:54:14.097] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:83:0)
[12:54:14.097] Timer tick, asking Buildbucket for the build status
[12:54:14.224] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:14.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:84:0) after 1m0s
[12:55:14.576] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:84:0)
[12:55:14.576] Timer tick, asking Buildbucket for the build status
[12:55:15.511] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:15.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:85:0) after 1m0s
[12:56:15.658] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:85:0)
[12:56:15.658] Timer tick, asking Buildbucket for the build status
[12:56:15.851] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:15.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:86:0) after 1m0s
[12:57:15.911] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:86:0)
[12:57:15.911] Timer tick, asking Buildbucket for the build status
[12:57:16.092] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:16.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:87:0) after 1m0s
[12:58:16.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:87:0)
[12:58:16.186] Timer tick, asking Buildbucket for the build status
[12:58:16.599] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:16.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:88:0) after 1m0s
[12:59:16.638] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:88:0)
[12:59:16.638] Timer tick, asking Buildbucket for the build status
[12:59:17.866] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:17.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:89:0) after 1m0s
[13:00:17.879] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:89:0)
[13:00:17.879] Timer tick, asking Buildbucket for the build status
[13:00:18.031] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:18.031] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:90:0) after 1m0s
[13:01:18.056] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:90:0)
[13:01:18.056] Timer tick, asking Buildbucket for the build status
[13:01:27.366] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:27.366] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:91:0) after 1m0s
[13:02:27.447] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:91:0)
[13:02:27.447] Timer tick, asking Buildbucket for the build status
[13:02:27.815] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:27.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:92:0) after 1m0s
[13:03:27.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:92:0)
[13:03:27.920] Timer tick, asking Buildbucket for the build status
[13:03:28.097] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:28.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:93:0) after 1m0s
[13:04:28.263] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:93:0)
[13:04:28.263] Timer tick, asking Buildbucket for the build status
[13:04:28.690] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:28.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:94:0) after 1m0s
[13:05:28.813] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:94:0)
[13:05:28.813] Timer tick, asking Buildbucket for the build status
[13:05:29.094] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:29.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:95:0) after 1m0s
[13:06:29.129] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:95:0)
[13:06:29.129] Timer tick, asking Buildbucket for the build status
[13:06:29.266] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:29.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:96:0) after 1m0s
[13:07:29.330] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:96:0)
[13:07:29.330] Timer tick, asking Buildbucket for the build status
[13:07:29.676] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:29.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:97:0) after 1m0s
[13:08:29.958] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:97:0)
[13:08:29.958] Timer tick, asking Buildbucket for the build status
[13:08:30.170] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:30.170] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:98:0) after 1m0s
[13:09:30.258] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:98:0)
[13:09:30.258] Timer tick, asking Buildbucket for the build status
[13:09:30.550] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:30.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:99:0) after 1m0s
[13:10:30.694] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:99:0)
[13:10:30.694] Timer tick, asking Buildbucket for the build status
[13:10:31.192] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:31.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:100:0) after 1m0s
[13:11:31.214] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:100:0)
[13:11:31.214] Timer tick, asking Buildbucket for the build status
[13:11:31.510] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:31.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:101:0) after 1m0s
[13:12:31.524] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:101:0)
[13:12:31.524] Timer tick, asking Buildbucket for the build status
[13:12:31.721] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:31.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:102:0) after 1m0s
[13:13:31.782] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:102:0)
[13:13:31.782] Timer tick, asking Buildbucket for the build status
[13:13:32.384] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:32.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:103:0) after 1m0s
[13:14:32.482] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:103:0)
[13:14:32.482] Timer tick, asking Buildbucket for the build status
[13:14:32.689] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:32.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:104:0) after 1m0s
[13:15:32.720] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:104:0)
[13:15:32.720] Timer tick, asking Buildbucket for the build status
[13:15:32.863] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:32.863] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:105:0) after 1m0s
[13:16:32.935] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:105:0)
[13:16:32.935] Timer tick, asking Buildbucket for the build status
[13:16:33.176] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:33.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:106:0) after 1m0s
[13:17:33.203] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:106:0)
[13:17:33.203] Timer tick, asking Buildbucket for the build status
[13:17:33.386] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:33.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:107:0) after 1m0s
[13:18:33.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:107:0)
[13:18:33.394] Timer tick, asking Buildbucket for the build status
[13:18:33.560] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:33.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:108:0) after 1m0s
[13:19:33.556] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:108:0)
[13:19:33.556] Timer tick, asking Buildbucket for the build status
[13:19:33.729] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:33.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:109:0) after 1m0s
[13:20:33.758] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:109:0)
[13:20:33.759] Timer tick, asking Buildbucket for the build status
[13:20:34.713] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:34.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:110:0) after 1m0s
[13:21:34.740] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:110:0)
[13:21:34.740] Timer tick, asking Buildbucket for the build status
[13:21:36.754] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:36.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:111:0) after 1m0s
[13:22:36.815] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:111:0)
[13:22:36.815] Timer tick, asking Buildbucket for the build status
[13:22:36.963] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:36.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:112:0) after 1m0s
[13:23:36.989] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:112:0)
[13:23:36.989] Timer tick, asking Buildbucket for the build status
[13:23:37.143] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:37.143] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:113:0) after 1m0s
[13:24:37.172] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:113:0)
[13:24:37.172] Timer tick, asking Buildbucket for the build status
[13:24:37.340] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:37.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:114:0) after 1m0s
[13:25:37.372] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:114:0)
[13:25:37.372] Timer tick, asking Buildbucket for the build status
[13:25:37.678] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:37.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:115:0) after 1m0s
[13:26:37.728] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:115:0)
[13:26:37.728] Timer tick, asking Buildbucket for the build status
[13:26:38.287] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:38.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:116:0) after 1m0s
[13:27:38.348] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:116:0)
[13:27:38.348] Timer tick, asking Buildbucket for the build status
[13:27:38.506] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:38.506] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:117:0) after 1m0s
[13:28:38.516] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:117:0)
[13:28:38.516] Timer tick, asking Buildbucket for the build status
[13:28:38.636] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:38.636] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:118:0) after 1m0s
[13:29:38.682] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:118:0)
[13:29:38.682] Timer tick, asking Buildbucket for the build status
[13:29:38.838] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:38.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:119:0) after 1m0s
[13:30:38.916] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:119:0)
[13:30:38.916] Timer tick, asking Buildbucket for the build status
[13:30:39.063] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:39.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:120:0) after 1m0s
[13:31:39.535] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:120:0)
[13:31:39.535] Timer tick, asking Buildbucket for the build status
[13:31:40.202] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:40.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:121:0) after 1m0s
[13:32:40.380] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:121:0)
[13:32:40.380] Timer tick, asking Buildbucket for the build status
[13:32:40.621] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:40.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:122:0) after 1m0s
[13:33:40.738] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:122:0)
[13:33:40.738] Timer tick, asking Buildbucket for the build status
[13:33:40.882] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:40.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:123:0) after 1m0s
[13:34:40.894] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:123:0)
[13:34:40.894] Timer tick, asking Buildbucket for the build status
[13:34:41.028] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:41.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:124:0) after 1m0s
[13:35:41.053] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:124:0)
[13:35:41.053] Timer tick, asking Buildbucket for the build status
[13:35:41.261] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:41.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:125:0) after 1m0s
[13:36:41.327] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:125:0)
[13:36:41.327] Timer tick, asking Buildbucket for the build status
[13:36:41.520] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:41.520] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:126:0) after 1m0s
[13:37:41.567] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:126:0)
[13:37:41.567] Timer tick, asking Buildbucket for the build status
[13:37:41.683] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:41.683] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:127:0) after 1m0s
[13:38:41.682] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:127:0)
[13:38:41.682] Timer tick, asking Buildbucket for the build status
[13:38:41.855] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:41.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:128:0) after 1m0s
[13:39:41.885] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:128:0)
[13:39:41.885] Timer tick, asking Buildbucket for the build status
[13:39:42.103] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:42.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:129:0) after 1m0s
[13:40:42.098] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:129:0)
[13:40:42.098] Timer tick, asking Buildbucket for the build status
[13:40:42.231] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:42.231] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:130:0) after 1m0s
[13:41:42.239] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:130:0)
[13:41:42.239] Timer tick, asking Buildbucket for the build status
[13:41:42.413] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:42.413] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:131:0) after 1m0s
[13:42:42.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:131:0)
[13:42:42.517] Timer tick, asking Buildbucket for the build status
[13:42:42.729] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:42.729] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:132:0) after 1m0s
[13:43:42.795] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:132:0)
[13:43:42.795] Timer tick, asking Buildbucket for the build status
[13:43:42.921] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:42.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:133:0) after 1m0s
[13:44:42.918] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:133:0)
[13:44:42.918] Timer tick, asking Buildbucket for the build status
[13:44:43.035] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:43.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:134:0) after 1m0s
[13:45:43.075] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:134:0)
[13:45:43.075] Timer tick, asking Buildbucket for the build status
[13:45:44.304] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:44.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:135:0) after 1m0s
[13:46:44.599] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:135:0)
[13:46:44.599] Timer tick, asking Buildbucket for the build status
[13:46:45.015] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:45.015] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:136:0) after 1m0s
[13:47:45.322] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:136:0)
[13:47:45.322] Timer tick, asking Buildbucket for the build status
[13:47:45.445] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:45.445] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:137:0) after 1m0s
[13:48:45.702] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:137:0)
[13:48:45.702] Timer tick, asking Buildbucket for the build status
[13:48:46.204] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:46.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:138:0) after 1m0s
[13:49:46.360] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:138:0)
[13:49:46.360] Timer tick, asking Buildbucket for the build status
[13:49:46.451] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:46.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:139:0) after 1m0s
[13:50:46.550] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:139:0)
[13:50:46.550] Timer tick, asking Buildbucket for the build status
[13:50:46.650] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:46.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:140:0) after 1m0s
[13:51:46.800] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:140:0)
[13:51:46.800] Timer tick, asking Buildbucket for the build status
[13:51:48.005] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:48.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:141:0) after 1m0s
[13:52:48.220] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:141:0)
[13:52:48.220] Timer tick, asking Buildbucket for the build status
[13:52:48.446] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:48.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:142:0) after 1m0s
[13:53:48.760] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:142:0)
[13:53:48.761] Timer tick, asking Buildbucket for the build status
[13:53:48.937] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:48.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:143:0) after 1m0s
[13:54:48.950] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:143:0)
[13:54:48.950] Timer tick, asking Buildbucket for the build status
[13:54:49.066] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:49.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:144:0) after 1m0s
[13:55:49.147] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:144:0)
[13:55:49.147] Timer tick, asking Buildbucket for the build status
[13:55:49.287] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:49.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:145:0) after 1m0s
[13:56:49.376] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:145:0)
[13:56:49.376] Timer tick, asking Buildbucket for the build status
[13:56:49.828] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:49.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:146:0) after 1m0s
[13:57:49.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:146:0)
[13:57:49.834] Timer tick, asking Buildbucket for the build status
[13:57:50.198] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:50.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:147:0) after 1m0s
[13:58:50.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:147:0)
[13:58:50.238] Timer tick, asking Buildbucket for the build status
[13:58:50.434] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:50.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:148:0) after 1m0s
[13:59:50.495] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:148:0)
[13:59:50.495] Timer tick, asking Buildbucket for the build status
[13:59:50.647] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:50.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:149:0) after 1m0s
[14:00:50.726] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:149:0)
[14:00:50.726] Timer tick, asking Buildbucket for the build status
[14:00:50.914] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:50.914] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:150:0) after 1m0s
[14:01:51.499] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:150:0)
[14:01:51.499] Timer tick, asking Buildbucket for the build status
[14:01:51.682] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:51.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:151:0) after 1m0s
[14:02:52.674] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:151:0)
[14:02:52.674] Timer tick, asking Buildbucket for the build status
[14:02:53.172] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:53.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:152:0) after 1m0s
[14:03:53.244] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:152:0)
[14:03:53.244] Timer tick, asking Buildbucket for the build status
[14:03:53.351] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:53.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:153:0) after 1m0s
[14:04:53.402] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:153:0)
[14:04:53.402] Timer tick, asking Buildbucket for the build status
[14:04:53.534] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:53.534] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:154:0) after 1m0s
[14:05:53.550] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:154:0)
[14:05:53.550] Timer tick, asking Buildbucket for the build status
[14:05:53.704] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:53.704] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:155:0) after 1m0s
[14:06:53.796] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:155:0)
[14:06:53.796] Timer tick, asking Buildbucket for the build status
[14:06:54.229] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:54.229] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:156:0) after 1m0s
[14:07:54.296] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:156:0)
[14:07:54.296] Timer tick, asking Buildbucket for the build status
[14:07:54.572] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:54.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:157:0) after 1m0s
[14:08:54.671] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:157:0)
[14:08:54.671] Timer tick, asking Buildbucket for the build status
[14:08:54.885] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:54.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:158:0) after 1m0s
[14:09:54.906] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:158:0)
[14:09:54.906] Timer tick, asking Buildbucket for the build status
[14:09:55.064] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:55.064] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:159:0) after 1m0s
[14:10:55.130] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:159:0)
[14:10:55.130] Timer tick, asking Buildbucket for the build status
[14:10:55.361] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:55.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:160:0) after 1m0s
[14:11:55.400] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:160:0)
[14:11:55.400] Timer tick, asking Buildbucket for the build status
[14:11:55.625] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:55.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:161:0) after 1m0s
[14:12:55.680] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:161:0)
[14:12:55.680] Timer tick, asking Buildbucket for the build status
[14:12:55.808] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:55.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:162:0) after 1m0s
[14:13:55.826] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:162:0)
[14:13:55.826] Timer tick, asking Buildbucket for the build status
[14:13:56.308] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:56.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:163:0) after 1m0s
[14:14:56.373] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:163:0)
[14:14:56.373] Timer tick, asking Buildbucket for the build status
[14:14:56.610] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:56.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:164:0) after 1m0s
[14:15:56.681] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:164:0)
[14:15:56.681] Timer tick, asking Buildbucket for the build status
[14:15:57.022] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:57.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:165:0) after 1m0s
[14:16:57.062] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:165:0)
[14:16:57.062] Timer tick, asking Buildbucket for the build status
[14:16:57.293] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:57.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:166:0) after 1m0s
[14:17:57.351] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:166:0)
[14:17:57.351] Timer tick, asking Buildbucket for the build status
[14:17:57.699] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:57.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:167:0) after 1m0s
[14:18:57.785] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:167:0)
[14:18:57.785] Timer tick, asking Buildbucket for the build status
[14:18:57.992] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:57.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:168:0) after 1m0s
[14:19:58.086] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:168:0)
[14:19:58.086] Timer tick, asking Buildbucket for the build status
[14:19:58.247] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:58.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:169:0) after 1m0s
[14:20:58.364] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:169:0)
[14:20:58.364] Timer tick, asking Buildbucket for the build status
[14:20:58.486] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:58.486] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:170:0) after 1m0s
[14:21:58.835] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:170:0)
[14:21:58.835] Timer tick, asking Buildbucket for the build status
[14:21:59.181] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:59.181] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:171:0) after 1m0s
[14:22:59.328] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:171:0)
[14:22:59.328] Timer tick, asking Buildbucket for the build status
[14:22:59.781] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:59.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:172:0) after 1m0s
[14:23:59.868] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:172:0)
[14:23:59.868] Timer tick, asking Buildbucket for the build status
[14:24:00.176] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:00.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:173:0) after 1m0s
[14:25:01.509] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:173:0)
[14:25:01.509] Timer tick, asking Buildbucket for the build status
[14:25:01.724] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:01.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:174:0) after 1m0s
[14:26:02.275] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:174:0)
[14:26:02.275] Timer tick, asking Buildbucket for the build status
[14:26:02.393] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:02.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:175:0) after 1m0s
[14:27:02.475] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:175:0)
[14:27:02.475] Timer tick, asking Buildbucket for the build status
[14:27:02.708] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:02.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:176:0) after 1m0s
[14:28:02.815] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:176:0)
[14:28:02.816] Timer tick, asking Buildbucket for the build status
[14:28:02.952] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:02.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:177:0) after 1m0s
[14:29:02.993] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:177:0)
[14:29:02.993] Timer tick, asking Buildbucket for the build status
[14:29:03.174] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:03.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:178:0) after 1m0s
[14:30:03.239] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:178:0)
[14:30:03.239] Timer tick, asking Buildbucket for the build status
[14:30:03.816] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:03.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:179:0) after 1m0s
[14:31:03.911] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:179:0)
[14:31:03.911] Timer tick, asking Buildbucket for the build status
[14:31:04.388] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:04.388] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:180:0) after 1m0s
[14:32:04.375] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:180:0)
[14:32:04.375] Timer tick, asking Buildbucket for the build status
[14:32:04.524] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:04.524] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:181:0) after 1m0s
[14:33:04.550] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:181:0)
[14:33:04.550] Timer tick, asking Buildbucket for the build status
[14:33:06.935] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:06.935] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:182:0) after 1m0s
[14:34:06.977] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:182:0)
[14:34:06.977] Timer tick, asking Buildbucket for the build status
[14:34:07.185] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:07.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:183:0) after 1m0s
[14:35:07.194] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:183:0)
[14:35:07.194] Timer tick, asking Buildbucket for the build status
[14:35:08.014] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:08.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:184:0) after 1m0s
[14:36:08.056] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:184:0)
[14:36:08.056] Timer tick, asking Buildbucket for the build status
[14:36:08.269] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:08.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:185:0) after 1m0s
[14:37:08.313] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:185:0)
[14:37:08.313] Timer tick, asking Buildbucket for the build status
[14:37:09.016] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:09.016] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:186:0) after 1m0s
[14:38:09.087] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:186:0)
[14:38:09.087] Timer tick, asking Buildbucket for the build status
[14:38:09.395] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:09.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:187:0) after 1m0s
[14:39:09.423] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:187:0)
[14:39:09.424] Timer tick, asking Buildbucket for the build status
[14:39:12.124] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:12.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:188:0) after 1m0s
[14:40:12.229] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:188:0)
[14:40:12.229] Timer tick, asking Buildbucket for the build status
[14:40:12.511] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:12.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:189:0) after 1m0s
[14:41:12.571] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:189:0)
[14:41:12.571] Timer tick, asking Buildbucket for the build status
[14:41:12.700] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:12.700] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:190:0) after 1m0s
[14:42:12.721] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:190:0)
[14:42:12.721] Timer tick, asking Buildbucket for the build status
[14:42:12.957] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:12.957] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:191:0) after 1m0s
[14:43:13.019] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:191:0)
[14:43:13.019] Timer tick, asking Buildbucket for the build status
[14:43:13.161] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:13.161] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:192:0) after 1m0s
[14:44:13.281] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:192:0)
[14:44:13.281] Timer tick, asking Buildbucket for the build status
[14:44:13.423] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:13.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:193:0) after 1m0s
[14:45:13.486] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:193:0)
[14:45:13.486] Timer tick, asking Buildbucket for the build status
[14:45:13.695] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:13.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:194:0) after 1m0s
[14:46:13.822] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:194:0)
[14:46:13.822] Timer tick, asking Buildbucket for the build status
[14:46:13.957] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:13.957] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:195:0) after 1m0s
[14:47:13.972] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:195:0)
[14:47:13.972] Timer tick, asking Buildbucket for the build status
[14:47:14.186] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:14.186] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:196:0) after 1m0s
[14:48:14.256] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:196:0)
[14:48:14.256] Timer tick, asking Buildbucket for the build status
[14:48:14.846] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:14.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:197:0) after 1m0s
[14:49:14.900] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:197:0)
[14:49:14.900] Timer tick, asking Buildbucket for the build status
[14:49:15.024] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:15.024] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:198:0) after 1m0s
[14:50:15.035] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:198:0)
[14:50:15.035] Timer tick, asking Buildbucket for the build status
[14:50:15.285] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:15.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:199:0) after 1m0s
[14:51:15.371] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:199:0)
[14:51:15.371] Timer tick, asking Buildbucket for the build status
[14:51:17.675] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:17.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:200:0) after 1m0s
[14:52:17.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:200:0)
[14:52:17.808] Timer tick, asking Buildbucket for the build status
[14:52:18.044] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:18.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:201:0) after 1m0s
[14:53:18.101] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:201:0)
[14:53:18.101] Timer tick, asking Buildbucket for the build status
[14:53:18.489] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:18.489] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:202:0) after 1m0s
[14:54:18.540] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:202:0)
[14:54:18.540] Timer tick, asking Buildbucket for the build status
[14:54:18.664] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:18.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:203:0) after 1m0s
[14:55:18.713] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:203:0)
[14:55:18.713] Timer tick, asking Buildbucket for the build status
[14:55:18.849] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:18.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:204:0) after 1m0s
[14:56:18.891] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:204:0)
[14:56:18.891] Timer tick, asking Buildbucket for the build status
[14:56:19.018] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:19.018] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:205:0) after 1m0s
[14:57:19.067] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:205:0)
[14:57:19.067] Timer tick, asking Buildbucket for the build status
[14:57:19.214] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:19.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:206:0) after 1m0s
[14:58:19.303] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:206:0)
[14:58:19.303] Timer tick, asking Buildbucket for the build status
[14:58:21.655] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:21.655] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:207:0) after 1m0s
[14:59:21.797] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:207:0)
[14:59:21.797] Timer tick, asking Buildbucket for the build status
[14:59:22.002] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:22.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:208:0) after 1m0s
[15:00:22.099] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:208:0)
[15:00:22.099] Timer tick, asking Buildbucket for the build status
[15:00:22.226] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:22.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:209:0) after 1m0s
[15:01:22.410] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:209:0)
[15:01:22.410] Timer tick, asking Buildbucket for the build status
[15:01:22.571] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:22.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:210:0) after 1m0s
[15:02:22.624] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:210:0)
[15:02:22.624] Timer tick, asking Buildbucket for the build status
[15:02:23.382] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:23.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:211:0) after 1m0s
[15:03:23.609] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:211:0)
[15:03:23.609] Timer tick, asking Buildbucket for the build status
[15:03:24.014] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:24.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:212:0) after 1m0s
[15:04:24.153] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:212:0)
[15:04:24.153] Timer tick, asking Buildbucket for the build status
[15:04:28.127] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:28.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:213:0) after 1m0s
[15:05:28.304] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:213:0)
[15:05:28.304] Timer tick, asking Buildbucket for the build status
[15:05:28.496] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:28.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:214:0) after 1m0s
[15:06:28.533] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:214:0)
[15:06:28.533] Timer tick, asking Buildbucket for the build status
[15:06:28.753] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:28.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:215:0) after 1m0s
[15:07:28.934] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:215:0)
[15:07:28.934] Timer tick, asking Buildbucket for the build status
[15:07:29.234] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:29.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:216:0) after 1m0s
[15:08:29.272] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:216:0)
[15:08:29.273] Timer tick, asking Buildbucket for the build status
[15:08:29.468] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:29.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:217:0) after 1m0s
[15:09:29.511] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:217:0)
[15:09:29.511] Timer tick, asking Buildbucket for the build status
[15:09:29.670] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:29.670] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:218:0) after 1m0s
[15:10:29.703] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:218:0)
[15:10:29.703] Timer tick, asking Buildbucket for the build status
[15:10:30.032] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:30.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:219:0) after 1m0s
[15:11:30.116] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:219:0)
[15:11:30.116] Timer tick, asking Buildbucket for the build status
[15:11:30.363] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:30.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:220:0) after 1m0s
[15:12:30.439] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:220:0)
[15:12:30.439] Timer tick, asking Buildbucket for the build status
[15:12:30.573] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:30.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:221:0) after 1m0s
[15:13:30.785] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:221:0)
[15:13:30.785] Timer tick, asking Buildbucket for the build status
[15:13:30.939] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:30.939] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:222:0) after 1m0s
[15:14:31.198] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:222:0)
[15:14:31.198] Timer tick, asking Buildbucket for the build status
[15:14:31.390] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:31.390] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:223:0) after 1m0s
[15:15:31.445] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:223:0)
[15:15:31.445] Timer tick, asking Buildbucket for the build status
[15:15:31.592] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:31.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:224:0) after 1m0s
[15:16:31.649] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:224:0)
[15:16:31.649] Timer tick, asking Buildbucket for the build status
[15:16:31.808] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:31.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:225:0) after 1m0s
[15:17:31.895] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:225:0)
[15:17:31.895] Timer tick, asking Buildbucket for the build status
[15:17:35.102] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:35.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:226:0) after 1m0s
[15:18:35.231] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:226:0)
[15:18:35.231] Timer tick, asking Buildbucket for the build status
[15:18:35.800] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:35.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:227:0) after 1m0s
[15:19:35.798] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:227:0)
[15:19:35.798] Timer tick, asking Buildbucket for the build status
[15:19:35.930] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:35.930] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:228:0) after 1m0s
[15:20:36.055] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:228:0)
[15:20:36.055] Timer tick, asking Buildbucket for the build status
[15:20:36.221] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:36.221] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:229:0) after 1m0s
[15:21:36.246] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:229:0)
[15:21:36.246] Timer tick, asking Buildbucket for the build status
[15:21:36.716] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:36.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:230:0) after 1m0s
[15:22:36.925] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:230:0)
[15:22:36.925] Timer tick, asking Buildbucket for the build status
[15:22:37.301] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:37.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:231:0) after 1m0s
[15:23:37.396] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:231:0)
[15:23:37.396] Timer tick, asking Buildbucket for the build status
[15:23:37.541] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:37.541] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:232:0) after 1m0s
[15:24:37.736] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:232:0)
[15:24:37.736] Timer tick, asking Buildbucket for the build status
[15:24:38.111] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:38.111] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:233:0) after 1m0s
[15:25:38.163] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:233:0)
[15:25:38.163] Timer tick, asking Buildbucket for the build status
[15:25:38.302] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:38.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:234:0) after 1m0s
[15:26:38.429] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:234:0)
[15:26:38.429] Timer tick, asking Buildbucket for the build status
[15:26:38.793] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:38.793] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:235:0) after 1m0s
[15:27:38.827] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:235:0)
[15:27:38.827] Timer tick, asking Buildbucket for the build status
[15:27:39.164] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:39.164] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:236:0) after 1m0s
[15:28:39.214] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:236:0)
[15:28:39.214] Timer tick, asking Buildbucket for the build status
[15:28:39.659] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:39.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:237:0) after 1m0s
[15:29:39.686] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:237:0)
[15:29:39.686] Timer tick, asking Buildbucket for the build status
[15:29:39.913] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:39.913] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:238:0) after 1m0s
[15:30:39.972] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:238:0)
[15:30:39.972] Timer tick, asking Buildbucket for the build status
[15:30:43.641] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:43.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:239:0) after 1m0s
[15:31:43.719] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:239:0)
[15:31:43.719] Timer tick, asking Buildbucket for the build status
[15:31:43.886] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:43.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:240:0) after 1m0s
[15:32:44.063] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:240:0)
[15:32:44.063] Timer tick, asking Buildbucket for the build status
[15:32:44.179] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:44.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:241:0) after 1m0s
[15:33:44.216] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:241:0)
[15:33:44.216] Timer tick, asking Buildbucket for the build status
[15:33:44.351] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:44.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:242:0) after 1m0s
[15:34:45.262] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:242:0)
[15:34:45.262] Timer tick, asking Buildbucket for the build status
[15:34:52.198] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:52.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:243:0) after 1m0s
[15:35:52.187] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:243:0)
[15:35:52.187] Timer tick, asking Buildbucket for the build status
[15:35:52.601] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:52.601] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:244:0) after 1m0s
[15:36:52.612] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:244:0)
[15:36:52.612] Timer tick, asking Buildbucket for the build status
[15:36:52.805] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:52.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:245:0) after 1m0s
[15:37:52.892] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:245:0)
[15:37:52.892] Timer tick, asking Buildbucket for the build status
[15:37:53.190] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:53.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:246:0) after 1m0s
[15:38:53.273] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:246:0)
[15:38:53.273] Timer tick, asking Buildbucket for the build status
[15:38:53.451] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:53.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:247:0) after 1m0s
[15:39:53.577] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:247:0)
[15:39:53.577] Timer tick, asking Buildbucket for the build status
[15:39:53.778] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:53.778] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:248:0) after 1m0s
[15:40:53.828] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:248:0)
[15:40:53.828] Timer tick, asking Buildbucket for the build status
[15:40:54.008] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:54.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:249:0) after 1m0s
[15:41:54.378] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:249:0)
[15:41:54.378] Timer tick, asking Buildbucket for the build status
[15:41:54.870] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:54.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:250:0) after 1m0s
[15:42:54.951] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:250:0)
[15:42:54.951] Timer tick, asking Buildbucket for the build status
[15:42:55.176] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:55.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:251:0) after 1m0s
[15:43:55.307] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:251:0)
[15:43:55.307] Timer tick, asking Buildbucket for the build status
[15:43:55.799] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:55.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:252:0) after 1m0s
[15:44:55.921] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:252:0)
[15:44:55.921] Timer tick, asking Buildbucket for the build status
[15:44:56.234] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:56.234] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:253:0) after 1m0s
[15:45:56.412] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:253:0)
[15:45:56.412] Timer tick, asking Buildbucket for the build status
[15:46:02.359] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:02.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:254:0) after 1m0s
[15:47:02.401] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:254:0)
[15:47:02.401] Timer tick, asking Buildbucket for the build status
[15:47:02.570] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:02.570] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:255:0) after 1m0s
[15:48:02.721] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:255:0)
[15:48:02.721] Timer tick, asking Buildbucket for the build status
[15:48:03.444] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:03.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:256:0) after 1m0s
[15:49:03.480] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:256:0)
[15:49:03.480] Timer tick, asking Buildbucket for the build status
[15:49:04.007] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:04.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:257:0) after 1m0s
[15:50:04.140] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:257:0)
[15:50:04.140] Timer tick, asking Buildbucket for the build status
[15:50:04.428] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:04.428] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:258:0) after 1m0s
[15:51:04.598] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:258:0)
[15:51:04.598] Timer tick, asking Buildbucket for the build status
[15:51:04.969] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:04.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:259:0) after 1m0s
[15:52:05.105] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:259:0)
[15:52:05.105] Timer tick, asking Buildbucket for the build status
[15:52:05.368] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:05.368] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:260:0) after 1m0s
[15:53:05.419] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:260:0)
[15:53:05.419] Timer tick, asking Buildbucket for the build status
[15:53:05.603] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:05.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:261:0) after 1m0s
[15:54:05.682] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:261:0)
[15:54:05.682] Timer tick, asking Buildbucket for the build status
[15:54:05.815] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:05.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:262:0) after 1m0s
[15:55:05.984] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:262:0)
[15:55:05.984] Timer tick, asking Buildbucket for the build status
[15:55:06.376] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:06.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:263:0) after 1m0s
[15:56:06.372] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:263:0)
[15:56:06.372] Timer tick, asking Buildbucket for the build status
[15:56:06.517] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:06.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:264:0) after 1m0s
[15:57:06.614] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:264:0)
[15:57:06.615] Timer tick, asking Buildbucket for the build status
[15:57:06.738] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:06.738] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:265:0) after 1m0s
[15:58:06.796] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:265:0)
[15:58:06.796] Timer tick, asking Buildbucket for the build status
[15:58:08.146] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:08.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:266:0) after 1m0s
[15:59:08.223] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:266:0)
[15:59:08.223] Timer tick, asking Buildbucket for the build status
[15:59:08.544] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:08.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:267:0) after 1m0s
[16:00:08.705] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:267:0)
[16:00:08.705] Timer tick, asking Buildbucket for the build status
[16:00:09.001] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:09.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:268:0) after 1m0s
[16:01:09.067] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:268:0)
[16:01:09.067] Timer tick, asking Buildbucket for the build status
[16:01:09.411] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:09.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:269:0) after 1m0s
[16:02:09.463] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:269:0)
[16:02:09.463] Timer tick, asking Buildbucket for the build status
[16:02:10.113] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:10.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:270:0) after 1m0s
[16:03:10.196] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:270:0)
[16:03:10.196] Timer tick, asking Buildbucket for the build status
[16:03:10.414] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:10.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:271:0) after 1m0s
[16:04:10.509] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:271:0)
[16:04:10.509] Timer tick, asking Buildbucket for the build status
[16:04:10.706] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:10.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:272:0) after 1m0s
[16:05:10.771] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:272:0)
[16:05:10.771] Timer tick, asking Buildbucket for the build status
[16:05:10.985] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:10.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:273:0) after 1m0s
[16:06:11.084] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:273:0)
[16:06:11.084] Timer tick, asking Buildbucket for the build status
[16:06:11.417] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:11.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:274:0) after 1m0s
[16:07:11.443] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:274:0)
[16:07:11.443] Timer tick, asking Buildbucket for the build status
[16:07:12.038] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:12.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:275:0) after 1m0s
[16:08:12.069] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:275:0)
[16:08:12.069] Timer tick, asking Buildbucket for the build status
[16:08:12.394] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:12.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:276:0) after 1m0s
[16:09:12.454] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:276:0)
[16:09:12.454] Timer tick, asking Buildbucket for the build status
[16:09:12.797] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:12.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:277:0) after 1m0s
[16:10:12.830] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:277:0)
[16:10:12.830] Timer tick, asking Buildbucket for the build status
[16:10:13.307] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:13.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:278:0) after 1m0s
[16:11:13.325] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:278:0)
[16:11:13.325] Timer tick, asking Buildbucket for the build status
[16:11:13.487] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:13.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:279:0) after 1m0s
[16:12:13.562] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:279:0)
[16:12:13.562] Timer tick, asking Buildbucket for the build status
[16:12:14.033] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:14.033] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:280:0) after 1m0s
[16:13:14.071] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:280:0)
[16:13:14.071] Timer tick, asking Buildbucket for the build status
[16:13:14.268] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:14.268] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:281:0) after 1m0s
[16:14:14.435] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:281:0)
[16:14:14.435] Timer tick, asking Buildbucket for the build status
[16:14:14.744] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:14.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:282:0) after 1m0s
[16:15:14.844] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:282:0)
[16:15:14.845] Timer tick, asking Buildbucket for the build status
[16:15:14.956] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:14.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:283:0) after 1m0s
[16:16:15.029] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:283:0)
[16:16:15.029] Timer tick, asking Buildbucket for the build status
[16:16:15.401] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:15.401] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:284:0) after 1m0s
[16:17:15.518] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:284:0)
[16:17:15.518] Timer tick, asking Buildbucket for the build status
[16:17:15.759] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:15.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:285:0) after 1m0s
[16:18:15.814] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:285:0)
[16:18:15.814] Timer tick, asking Buildbucket for the build status
[16:18:16.108] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:16.108] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:286:0) after 1m0s
[16:19:16.235] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:286:0)
[16:19:16.235] Timer tick, asking Buildbucket for the build status
[16:19:16.382] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:16.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:287:0) after 1m0s
[16:20:16.446] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:287:0)
[16:20:16.446] Timer tick, asking Buildbucket for the build status
[16:20:16.885] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:16.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:288:0) after 1m0s
[16:21:17.053] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:288:0)
[16:21:17.053] Timer tick, asking Buildbucket for the build status
[16:21:17.372] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:17.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:289:0) after 1m0s
[16:22:17.391] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:289:0)
[16:22:17.391] Timer tick, asking Buildbucket for the build status
[16:22:17.769] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:17.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:290:0) after 1m0s
[16:23:17.964] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:290:0)
[16:23:17.964] Timer tick, asking Buildbucket for the build status
[16:23:18.156] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:18.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:291:0) after 1m0s
[16:24:18.271] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:291:0)
[16:24:18.271] Timer tick, asking Buildbucket for the build status
[16:24:19.276] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:19.276] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:292:0) after 1m0s
[16:25:19.353] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:292:0)
[16:25:19.353] Timer tick, asking Buildbucket for the build status
[16:25:20.400] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:20.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:293:0) after 1m0s
[16:26:20.602] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:293:0)
[16:26:20.602] Timer tick, asking Buildbucket for the build status
[16:26:21.072] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:21.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:294:0) after 1m0s
[16:27:21.095] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:294:0)
[16:27:21.095] Timer tick, asking Buildbucket for the build status
[16:27:21.370] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:21.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:295:0) after 1m0s
[16:28:21.441] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:295:0)
[16:28:21.441] Timer tick, asking Buildbucket for the build status
[16:28:21.593] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:21.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:296:0) after 1m0s
[16:29:21.660] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:296:0)
[16:29:21.660] Timer tick, asking Buildbucket for the build status
[16:29:21.853] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:21.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:297:0) after 1m0s
[16:30:22.110] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:297:0)
[16:30:22.110] Timer tick, asking Buildbucket for the build status
[16:30:22.313] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:22.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:298:0) after 1m0s
[16:31:22.503] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:298:0)
[16:31:22.503] Timer tick, asking Buildbucket for the build status
[16:31:22.652] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:22.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:299:0) after 1m0s
[16:32:22.745] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:299:0)
[16:32:22.745] Timer tick, asking Buildbucket for the build status
[16:32:23.359] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:23.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:300:0) after 1m0s
[16:33:23.445] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:300:0)
[16:33:23.445] Timer tick, asking Buildbucket for the build status
[16:33:23.567] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:23.567] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:301:0) after 1m0s
[16:34:23.582] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:301:0)
[16:34:23.582] Timer tick, asking Buildbucket for the build status
[16:34:23.706] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:23.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:302:0) after 1m0s
[16:35:23.772] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:302:0)
[16:35:23.772] Timer tick, asking Buildbucket for the build status
[16:35:23.960] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:23.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:303:0) after 1m0s
[16:36:24.151] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:303:0)
[16:36:24.151] Timer tick, asking Buildbucket for the build status
[16:36:24.415] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:24.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:304:0) after 1m0s
[16:37:24.539] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:304:0)
[16:37:24.539] Timer tick, asking Buildbucket for the build status
[16:37:24.884] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:24.884] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:305:0) after 1m0s
[16:38:24.904] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:305:0)
[16:38:24.904] Timer tick, asking Buildbucket for the build status
[16:38:25.164] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:25.164] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:306:0) after 1m0s
[16:39:25.291] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:306:0)
[16:39:25.291] Timer tick, asking Buildbucket for the build status
[16:39:25.425] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:25.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:307:0) after 1m0s
[16:40:25.504] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:307:0)
[16:40:25.504] Timer tick, asking Buildbucket for the build status
[16:40:25.702] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:25.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:308:0) after 1m0s
[16:41:25.958] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:308:0)
[16:41:25.958] Timer tick, asking Buildbucket for the build status
[16:41:26.352] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:26.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:309:0) after 1m0s
[16:42:27.069] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:309:0)
[16:42:27.069] Timer tick, asking Buildbucket for the build status
[16:42:27.911] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:27.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:310:0) after 1m0s
[16:43:28.149] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:310:0)
[16:43:28.149] Timer tick, asking Buildbucket for the build status
[16:43:28.305] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:28.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:311:0) after 1m0s
[16:44:28.574] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:311:0)
[16:44:28.574] Timer tick, asking Buildbucket for the build status
[16:44:28.778] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:28.778] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:312:0) after 1m0s
[16:45:28.903] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:312:0)
[16:45:28.903] Timer tick, asking Buildbucket for the build status
[16:45:29.143] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:29.143] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:313:0) after 1m0s
[16:46:29.278] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:313:0)
[16:46:29.278] Timer tick, asking Buildbucket for the build status
[16:46:29.738] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:29.738] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:314:0) after 1m0s
[16:47:29.846] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:314:0)
[16:47:29.846] Timer tick, asking Buildbucket for the build status
[16:47:30.038] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:30.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:315:0) after 1m0s
[16:48:30.190] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:315:0)
[16:48:30.190] Timer tick, asking Buildbucket for the build status
[16:48:30.361] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:30.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:316:0) after 1m0s
[16:49:30.386] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:316:0)
[16:49:30.386] Timer tick, asking Buildbucket for the build status
[16:49:30.834] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:30.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:317:0) after 1m0s
[16:50:31.007] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:317:0)
[16:50:31.007] Timer tick, asking Buildbucket for the build status
[16:50:31.411] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:31.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:318:0) after 1m0s
[16:51:31.623] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:318:0)
[16:51:31.623] Timer tick, asking Buildbucket for the build status
[16:51:31.790] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:31.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:319:0) after 1m0s
[16:52:31.808] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:319:0)
[16:52:31.808] Timer tick, asking Buildbucket for the build status
[16:52:32.171] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:32.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:320:0) after 1m0s
[16:53:32.484] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:320:0)
[16:53:32.484] Timer tick, asking Buildbucket for the build status
[16:53:32.625] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:32.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:321:0) after 1m0s
[16:54:32.843] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:321:0)
[16:54:32.843] Timer tick, asking Buildbucket for the build status
[16:54:32.977] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:32.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:322:0) after 1m0s
[16:55:33.131] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:322:0)
[16:55:33.131] Timer tick, asking Buildbucket for the build status
[16:55:33.363] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:33.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:323:0) after 1m0s
[16:56:33.429] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:323:0)
[16:56:33.429] Timer tick, asking Buildbucket for the build status
[16:56:33.585] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:33.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:324:0) after 1m0s
[16:57:33.671] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:324:0)
[16:57:33.671] Timer tick, asking Buildbucket for the build status
[16:57:34.882] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:34.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:325:0) after 1m0s
[16:58:34.958] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:325:0)
[16:58:34.958] Timer tick, asking Buildbucket for the build status
[16:58:35.145] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:35.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:326:0) after 1m0s
[16:59:35.240] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:326:0)
[16:59:35.240] Timer tick, asking Buildbucket for the build status
[16:59:35.423] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:35.424] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:327:0) after 1m0s
[17:00:35.504] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:327:0)
[17:00:35.504] Timer tick, asking Buildbucket for the build status
[17:00:35.755] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:35.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:328:0) after 1m0s
[17:01:35.860] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:328:0)
[17:01:35.860] Timer tick, asking Buildbucket for the build status
[17:01:36.098] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:36.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:329:0) after 1m0s
[17:02:36.151] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:329:0)
[17:02:36.151] Timer tick, asking Buildbucket for the build status
[17:02:36.327] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:36.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:330:0) after 1m0s
[17:03:36.513] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:330:0)
[17:03:36.513] Timer tick, asking Buildbucket for the build status
[17:03:36.747] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:36.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:331:0) after 1m0s
[17:04:36.985] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:331:0)
[17:04:36.985] Timer tick, asking Buildbucket for the build status
[17:04:37.182] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:37.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:332:0) after 1m0s
[17:05:37.820] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:332:0)
[17:05:37.820] Timer tick, asking Buildbucket for the build status
[17:05:38.036] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:38.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:333:0) after 1m0s
[17:06:38.238] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:333:0)
[17:06:38.238] Timer tick, asking Buildbucket for the build status
[17:06:38.424] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:38.424] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:334:0) after 1m0s
[17:07:38.584] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:334:0)
[17:07:38.584] Timer tick, asking Buildbucket for the build status
[17:07:38.716] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:38.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:335:0) after 1m0s
[17:08:38.800] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:335:0)
[17:08:38.800] Timer tick, asking Buildbucket for the build status
[17:08:39.400] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:39.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:336:0) after 1m0s
[17:09:39.653] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:336:0)
[17:09:39.653] Timer tick, asking Buildbucket for the build status
[17:09:39.808] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:39.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:337:0) after 1m0s
[17:10:40.091] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:337:0)
[17:10:40.091] Timer tick, asking Buildbucket for the build status
[17:10:40.538] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:40.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:338:0) after 1m0s
[17:11:40.599] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:338:0)
[17:11:40.599] Timer tick, asking Buildbucket for the build status
[17:11:40.719] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:40.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:339:0) after 1m0s
[17:12:41.017] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:339:0)
[17:12:41.017] Timer tick, asking Buildbucket for the build status
[17:12:41.450] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:41.450] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:340:0) after 1m0s
[17:13:41.719] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:340:0)
[17:13:41.719] Timer tick, asking Buildbucket for the build status
[17:13:41.961] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:41.961] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:341:0) after 1m0s
[17:14:42.098] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:341:0)
[17:14:42.098] Timer tick, asking Buildbucket for the build status
[17:14:42.398] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:42.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:342:0) after 1m0s
[17:15:42.655] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:342:0)
[17:15:42.655] Timer tick, asking Buildbucket for the build status
[17:15:42.795] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:42.795] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:343:0) after 1m0s
[17:16:43.079] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:343:0)
[17:16:43.079] Timer tick, asking Buildbucket for the build status
[17:16:43.613] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:43.613] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:344:0) after 1m0s
[17:17:43.725] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:344:0)
[17:17:43.725] Timer tick, asking Buildbucket for the build status
[17:17:43.854] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:43.854] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:345:0) after 1m0s
[17:18:43.891] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:345:0)
[17:18:43.891] Timer tick, asking Buildbucket for the build status
[17:18:44.078] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:44.078] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:346:0) after 1m0s
[17:19:44.233] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:346:0)
[17:19:44.233] Timer tick, asking Buildbucket for the build status
[17:19:44.441] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:44.441] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:347:0) after 1m0s
[17:20:44.508] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:347:0)
[17:20:44.508] Timer tick, asking Buildbucket for the build status
[17:20:44.752] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:44.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:348:0) after 1m0s
[17:21:44.964] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:348:0)
[17:21:44.964] Timer tick, asking Buildbucket for the build status
[17:21:45.591] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:45.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:349:0) after 1m0s
[17:22:45.733] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:349:0)
[17:22:45.733] Timer tick, asking Buildbucket for the build status
[17:22:45.992] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:45.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:350:0) after 1m0s
[17:23:46.121] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:350:0)
[17:23:46.121] Timer tick, asking Buildbucket for the build status
[17:23:46.273] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:46.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:351:0) after 1m0s
[17:24:46.437] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:351:0)
[17:24:46.437] Timer tick, asking Buildbucket for the build status
[17:24:46.906] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:46.906] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:352:0) after 1m0s
[17:25:47.045] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:352:0)
[17:25:47.045] Timer tick, asking Buildbucket for the build status
[17:25:47.346] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:47.346] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:353:0) after 1m0s
[17:26:47.497] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:353:0)
[17:26:47.497] Timer tick, asking Buildbucket for the build status
[17:26:47.631] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:47.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:354:0) after 1m0s
[17:27:47.711] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:354:0)
[17:27:47.711] Timer tick, asking Buildbucket for the build status
[17:27:47.882] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:47.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:355:0) after 1m0s
[17:28:48.006] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:355:0)
[17:28:48.006] Timer tick, asking Buildbucket for the build status
[17:28:48.585] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:48.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:356:0) after 1m0s
[17:29:48.626] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:356:0)
[17:29:48.626] Timer tick, asking Buildbucket for the build status
[17:29:48.806] Build 8875254941360704512: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:48.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040685006570405872:357:0) after 1m0s
[17:30:38.297] Received PubSub notification, asking Buildbucket for the build status
[17:30:38.358] Build 8875254941360704512: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:30:38.358] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "completed_ts": "1594315837356220",
    "created_by": "project:nacl",
    "created_ts": "1594294333074330",
    "id": "8875254941360704512",
    "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\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\", \"title\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}}",
    "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\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\", \"title\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-flex-ci-xenial-2-0win\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-64-validator-opt\", \"buildnumber\": 147, \"got_revision\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\", \"mastername\": \"client.nacl\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"6725bbc5ec5a64f7becb0a6eeba8395aa2a72972\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_149fed94fc0315f63a3ac899b53d3cfedce2ab533d8d891f9abe32610aa3106a_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-2-0win\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.flex.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5378-e275056\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1594294338139648",
    "status": "COMPLETED",
    "status_changed_ts": "1594315837841372",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/147",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/6725bbc5ec5a64f7becb0a6eeba8395aa2a72972",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9040685006570405872",
      "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/8875254941360704512/+/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:4d4c2a7b5c2fc910",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1594315837867516",
    "url": "https://ci.chromium.org/b/8875254941360704512",
    "utcnow_ts": "1594315838351451"
  }
}
[17:30:38.358] Invocation finished in 5h58m29.635779334s with status SUCCEEDED