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

• f2b7d37238a5f49ba00fc1c152cbd5caa278d030 (4 years ago)

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

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

[17:39:46.730] New invocation is queued and will start shortly
[17:39:49.989] Starting the invocation (attempt 1)
[17:39:50.027] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:39:50.028] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:39:50.028] Buildbucket request:
{
  "bucket": "luci.nacl.ci",
  "client_operation_id": "9040661877091456992",
  "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\":\"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f2b7d37238a5f49ba00fc1c152cbd5caa278d030\",\"title\":\"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}}",
  "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:9040661877091456992",
    "scheduler_job_id:nacl/linux-64-validator-opt",
    "user_agent:luci-scheduler",
    "buildset:commit/git/f2b7d37238a5f49ba00fc1c152cbd5caa278d030",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f2b7d37238a5f49ba00fc1c152cbd5caa278d030",
    "gitiles_ref:refs/heads/master"
  ]
}
[17:39:50.989] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1594316390147815",
    "id": "8875231812843605904",
    "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\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f2b7d37238a5f49ba00fc1c152cbd5caa278d030\", \"title\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1594316390817860",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/148",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/f2b7d37238a5f49ba00fc1c152cbd5caa278d030",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f2b7d37238a5f49ba00fc1c152cbd5caa278d030",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9040661877091456992",
      "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/8875231812843605904/+/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": "1594316390818088",
    "url": "https://ci.chromium.org/b/8875231812843605904",
    "utcnow_ts": "1594316390976680"
  }
}
[17:39:50.989] Task URL: https://ci.chromium.org/b/8875231812843605904
[17:39:50.989] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:2:0) after 1m0s
[17:40:51.051] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:2:0)
[17:40:51.051] Timer tick, asking Buildbucket for the build status
[17:40:51.242] Build 8875231812843605904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:40:51.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:3:0) after 1m0s
[17:41:42.066] Received PubSub notification, asking Buildbucket for the build status
[17:41:42.288] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:51.314] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:3:0)
[17:41:51.315] Timer tick, asking Buildbucket for the build status
[17:41:51.408] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:51.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:5:0) after 1m0s
[17:42:51.561] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:5:0)
[17:42:51.561] Timer tick, asking Buildbucket for the build status
[17:42:51.909] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:51.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:6:0) after 1m0s
[17:43:51.939] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:6:0)
[17:43:51.939] Timer tick, asking Buildbucket for the build status
[17:43:52.115] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:52.115] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:7:0) after 1m0s
[17:44:53.143] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:7:0)
[17:44:53.143] Timer tick, asking Buildbucket for the build status
[17:44:54.039] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:54.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:8:0) after 1m0s
[17:45:54.503] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:8:0)
[17:45:54.503] Timer tick, asking Buildbucket for the build status
[17:45:54.666] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:54.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:9:0) after 1m0s
[17:46:54.784] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:9:0)
[17:46:54.784] Timer tick, asking Buildbucket for the build status
[17:46:55.026] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:55.026] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:10:0) after 1m0s
[17:47:55.097] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:10:0)
[17:47:55.097] Timer tick, asking Buildbucket for the build status
[17:47:55.224] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:55.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:11:0) after 1m0s
[17:48:55.391] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:11:0)
[17:48:55.391] Timer tick, asking Buildbucket for the build status
[17:48:55.545] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:55.545] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:12:0) after 1m0s
[17:49:55.787] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:12:0)
[17:49:55.787] Timer tick, asking Buildbucket for the build status
[17:49:58.928] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:58.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:13:0) after 1m0s
[17:50:59.549] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:13:0)
[17:50:59.549] Timer tick, asking Buildbucket for the build status
[17:50:59.686] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:59.686] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:14:0) after 1m0s
[17:51:59.731] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:14:0)
[17:51:59.731] Timer tick, asking Buildbucket for the build status
[17:52:00.169] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:00.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:15:0) after 1m0s
[17:53:00.184] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:15:0)
[17:53:00.184] Timer tick, asking Buildbucket for the build status
[17:53:00.762] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:00.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:16:0) after 1m0s
[17:54:00.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:16:0)
[17:54:00.788] Timer tick, asking Buildbucket for the build status
[17:54:01.104] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:01.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:17:0) after 1m0s
[17:55:01.141] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:17:0)
[17:55:01.141] Timer tick, asking Buildbucket for the build status
[17:55:01.351] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:01.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:18:0) after 1m0s
[17:56:01.367] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:18:0)
[17:56:01.367] Timer tick, asking Buildbucket for the build status
[17:56:01.548] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:01.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:19:0) after 1m0s
[17:57:01.753] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:19:0)
[17:57:01.753] Timer tick, asking Buildbucket for the build status
[17:57:01.877] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:01.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:20:0) after 1m0s
[17:58:01.969] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:20:0)
[17:58:01.969] Timer tick, asking Buildbucket for the build status
[17:58:02.279] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:02.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:21:0) after 1m0s
[17:59:02.856] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:21:0)
[17:59:02.856] Timer tick, asking Buildbucket for the build status
[17:59:03.034] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:03.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:22:0) after 1m0s
[18:00:03.142] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:22:0)
[18:00:03.142] Timer tick, asking Buildbucket for the build status
[18:00:03.325] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:03.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:23:0) after 1m0s
[18:01:03.346] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:23:0)
[18:01:03.346] Timer tick, asking Buildbucket for the build status
[18:01:03.682] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:03.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:24:0) after 1m0s
[18:02:03.832] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:24:0)
[18:02:03.832] Timer tick, asking Buildbucket for the build status
[18:02:04.496] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:04.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:25:0) after 1m0s
[18:03:04.602] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:25:0)
[18:03:04.602] Timer tick, asking Buildbucket for the build status
[18:03:04.759] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:04.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:26:0) after 1m0s
[18:04:04.800] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:26:0)
[18:04:04.800] Timer tick, asking Buildbucket for the build status
[18:04:04.966] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:04.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:27:0) after 1m0s
[18:05:05.050] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:27:0)
[18:05:05.050] Timer tick, asking Buildbucket for the build status
[18:05:05.563] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:05.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:28:0) after 1m0s
[18:06:05.677] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:28:0)
[18:06:05.677] Timer tick, asking Buildbucket for the build status
[18:06:05.810] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:05.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:29:0) after 1m0s
[18:07:05.960] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:29:0)
[18:07:05.960] Timer tick, asking Buildbucket for the build status
[18:07:06.215] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:06.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:30:0) after 1m0s
[18:08:06.384] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:30:0)
[18:08:06.384] Timer tick, asking Buildbucket for the build status
[18:08:06.736] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:06.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:31:0) after 1m0s
[18:09:06.886] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:31:0)
[18:09:06.886] Timer tick, asking Buildbucket for the build status
[18:09:10.261] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:10.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:32:0) after 1m0s
[18:10:10.265] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:32:0)
[18:10:10.265] Timer tick, asking Buildbucket for the build status
[18:10:10.482] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:10.482] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:33:0) after 1m0s
[18:11:10.574] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:33:0)
[18:11:10.574] Timer tick, asking Buildbucket for the build status
[18:11:10.723] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:10.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:34:0) after 1m0s
[18:12:10.834] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:34:0)
[18:12:10.834] Timer tick, asking Buildbucket for the build status
[18:12:11.008] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:11.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:35:0) after 1m0s
[18:13:11.039] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:35:0)
[18:13:11.039] Timer tick, asking Buildbucket for the build status
[18:13:11.201] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:11.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:36:0) after 1m0s
[18:14:11.269] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:36:0)
[18:14:11.270] Timer tick, asking Buildbucket for the build status
[18:14:12.814] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:12.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:37:0) after 1m0s
[18:15:12.993] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:37:0)
[18:15:12.993] Timer tick, asking Buildbucket for the build status
[18:15:13.125] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:13.125] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:38:0) after 1m0s
[18:16:13.159] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:38:0)
[18:16:13.159] Timer tick, asking Buildbucket for the build status
[18:16:13.357] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:13.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:39:0) after 1m0s
[18:17:13.450] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:39:0)
[18:17:13.450] Timer tick, asking Buildbucket for the build status
[18:17:13.602] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:13.602] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:40:0) after 1m0s
[18:18:13.597] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:40:0)
[18:18:13.597] Timer tick, asking Buildbucket for the build status
[18:18:13.740] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:13.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:41:0) after 1m0s
[18:19:13.786] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:41:0)
[18:19:13.786] Timer tick, asking Buildbucket for the build status
[18:19:14.076] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:14.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:42:0) after 1m0s
[18:20:14.108] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:42:0)
[18:20:14.108] Timer tick, asking Buildbucket for the build status
[18:20:14.430] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:14.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:43:0) after 1m0s
[18:21:14.463] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:43:0)
[18:21:14.463] Timer tick, asking Buildbucket for the build status
[18:21:14.659] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:14.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:44:0) after 1m0s
[18:22:14.680] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:44:0)
[18:22:14.680] Timer tick, asking Buildbucket for the build status
[18:22:15.355] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:15.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:45:0) after 1m0s
[18:23:15.396] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:45:0)
[18:23:15.396] Timer tick, asking Buildbucket for the build status
[18:23:16.007] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:16.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:46:0) after 1m0s
[18:24:16.088] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:46:0)
[18:24:16.089] Timer tick, asking Buildbucket for the build status
[18:24:16.501] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:16.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:47:0) after 1m0s
[18:25:16.542] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:47:0)
[18:25:16.542] Timer tick, asking Buildbucket for the build status
[18:25:17.099] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:17.099] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:48:0) after 1m0s
[18:26:17.157] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:48:0)
[18:26:17.157] Timer tick, asking Buildbucket for the build status
[18:26:22.107] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:22.107] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:49:0) after 1m0s
[18:27:22.226] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:49:0)
[18:27:22.226] Timer tick, asking Buildbucket for the build status
[18:27:22.342] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:22.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:50:0) after 1m0s
[18:28:22.400] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:50:0)
[18:28:22.400] Timer tick, asking Buildbucket for the build status
[18:28:22.688] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:22.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:51:0) after 1m0s
[18:29:22.793] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:51:0)
[18:29:22.793] Timer tick, asking Buildbucket for the build status
[18:29:22.959] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:22.959] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:52:0) after 1m0s
[18:30:23.050] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:52:0)
[18:30:23.050] Timer tick, asking Buildbucket for the build status
[18:30:23.421] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:23.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:53:0) after 1m0s
[18:31:23.519] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:53:0)
[18:31:23.519] Timer tick, asking Buildbucket for the build status
[18:31:24.027] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:24.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:54:0) after 1m0s
[18:32:24.093] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:54:0)
[18:32:24.093] Timer tick, asking Buildbucket for the build status
[18:32:25.591] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:25.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:55:0) after 1m0s
[18:33:25.611] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:55:0)
[18:33:25.611] Timer tick, asking Buildbucket for the build status
[18:33:25.856] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:25.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:56:0) after 1m0s
[18:34:25.857] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:56:0)
[18:34:25.857] Timer tick, asking Buildbucket for the build status
[18:34:26.143] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:26.143] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:57:0) after 1m0s
[18:35:26.214] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:57:0)
[18:35:26.214] Timer tick, asking Buildbucket for the build status
[18:35:26.468] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:26.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:58:0) after 1m0s
[18:36:26.610] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:58:0)
[18:36:26.610] Timer tick, asking Buildbucket for the build status
[18:36:26.896] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:26.896] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:59:0) after 1m0s
[18:37:26.922] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:59:0)
[18:37:26.922] Timer tick, asking Buildbucket for the build status
[18:37:27.490] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:27.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:60:0) after 1m0s
[18:38:27.508] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:60:0)
[18:38:27.508] Timer tick, asking Buildbucket for the build status
[18:38:28.654] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:28.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:61:0) after 1m0s
[18:39:28.725] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:61:0)
[18:39:28.725] Timer tick, asking Buildbucket for the build status
[18:39:28.873] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:28.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:62:0) after 1m0s
[18:40:28.957] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:62:0)
[18:40:28.957] Timer tick, asking Buildbucket for the build status
[18:40:29.329] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:29.329] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:63:0) after 1m0s
[18:41:29.348] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:63:0)
[18:41:29.348] Timer tick, asking Buildbucket for the build status
[18:41:29.513] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:29.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:64:0) after 1m0s
[18:42:29.594] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:64:0)
[18:42:29.594] Timer tick, asking Buildbucket for the build status
[18:42:29.764] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:29.764] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:65:0) after 1m0s
[18:43:29.778] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:65:0)
[18:43:29.778] Timer tick, asking Buildbucket for the build status
[18:43:30.090] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:30.090] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:66:0) after 1m0s
[18:44:30.152] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:66:0)
[18:44:30.152] Timer tick, asking Buildbucket for the build status
[18:44:30.348] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:30.348] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:67:0) after 1m0s
[18:45:30.405] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:67:0)
[18:45:30.405] Timer tick, asking Buildbucket for the build status
[18:45:30.785] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:30.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:68:0) after 1m0s
[18:46:30.870] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:68:0)
[18:46:30.870] Timer tick, asking Buildbucket for the build status
[18:46:31.105] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:31.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:69:0) after 1m0s
[18:47:31.122] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:69:0)
[18:47:31.122] Timer tick, asking Buildbucket for the build status
[18:47:31.286] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:31.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:70:0) after 1m0s
[18:48:31.313] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:70:0)
[18:48:31.313] Timer tick, asking Buildbucket for the build status
[18:48:31.643] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:31.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:71:0) after 1m0s
[18:49:31.676] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:71:0)
[18:49:31.676] Timer tick, asking Buildbucket for the build status
[18:49:31.937] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:31.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:72:0) after 1m0s
[18:50:32.043] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:72:0)
[18:50:32.043] Timer tick, asking Buildbucket for the build status
[18:50:32.588] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:32.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:73:0) after 1m0s
[18:51:32.579] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:73:0)
[18:51:32.579] Timer tick, asking Buildbucket for the build status
[18:51:32.796] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:32.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:74:0) after 1m0s
[18:52:32.871] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:74:0)
[18:52:32.871] Timer tick, asking Buildbucket for the build status
[18:52:33.014] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:33.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:75:0) after 1m0s
[18:53:33.094] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:75:0)
[18:53:33.094] Timer tick, asking Buildbucket for the build status
[18:53:33.319] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:33.319] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:76:0) after 1m0s
[18:54:33.351] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:76:0)
[18:54:33.351] Timer tick, asking Buildbucket for the build status
[18:54:33.790] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:33.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:77:0) after 1m0s
[18:55:33.901] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:77:0)
[18:55:33.901] Timer tick, asking Buildbucket for the build status
[18:55:34.313] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:34.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:78:0) after 1m0s
[18:56:34.392] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:78:0)
[18:56:34.392] Timer tick, asking Buildbucket for the build status
[18:56:34.614] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:34.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:79:0) after 1m0s
[18:57:34.641] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:79:0)
[18:57:34.641] Timer tick, asking Buildbucket for the build status
[18:57:34.796] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:34.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:80:0) after 1m0s
[18:58:34.840] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:80:0)
[18:58:34.840] Timer tick, asking Buildbucket for the build status
[18:58:34.952] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:34.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:81:0) after 1m0s
[18:59:35.036] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:81:0)
[18:59:35.036] Timer tick, asking Buildbucket for the build status
[18:59:35.192] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:35.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:82:0) after 1m0s
[19:00:35.290] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:82:0)
[19:00:35.290] Timer tick, asking Buildbucket for the build status
[19:00:35.857] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:35.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:83:0) after 1m0s
[19:01:35.912] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:83:0)
[19:01:35.913] Timer tick, asking Buildbucket for the build status
[19:01:36.252] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:36.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:84:0) after 1m0s
[19:02:36.285] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:84:0)
[19:02:36.285] Timer tick, asking Buildbucket for the build status
[19:02:37.411] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:37.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:85:0) after 1m0s
[19:03:37.449] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:85:0)
[19:03:37.450] Timer tick, asking Buildbucket for the build status
[19:03:38.094] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:38.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:86:0) after 1m0s
[19:04:38.135] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:86:0)
[19:04:38.135] Timer tick, asking Buildbucket for the build status
[19:04:38.269] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:38.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:87:0) after 1m0s
[19:05:38.259] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:87:0)
[19:05:38.259] Timer tick, asking Buildbucket for the build status
[19:05:38.695] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:38.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:88:0) after 1m0s
[19:06:38.709] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:88:0)
[19:06:38.709] Timer tick, asking Buildbucket for the build status
[19:06:38.891] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:38.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:89:0) after 1m0s
[19:07:38.916] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:89:0)
[19:07:38.916] Timer tick, asking Buildbucket for the build status
[19:07:39.122] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:39.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:90:0) after 1m0s
[19:08:39.220] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:90:0)
[19:08:39.220] Timer tick, asking Buildbucket for the build status
[19:08:39.459] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:39.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:91:0) after 1m0s
[19:09:39.621] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:91:0)
[19:09:39.621] Timer tick, asking Buildbucket for the build status
[19:09:40.241] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:40.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:92:0) after 1m0s
[19:10:40.320] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:92:0)
[19:10:40.320] Timer tick, asking Buildbucket for the build status
[19:10:40.451] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:40.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:93:0) after 1m0s
[19:11:40.523] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:93:0)
[19:11:40.523] Timer tick, asking Buildbucket for the build status
[19:11:40.643] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:40.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:94:0) after 1m0s
[19:12:40.713] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:94:0)
[19:12:40.713] Timer tick, asking Buildbucket for the build status
[19:12:40.872] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:40.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:95:0) after 1m0s
[19:13:40.867] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:95:0)
[19:13:40.867] Timer tick, asking Buildbucket for the build status
[19:13:41.066] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:41.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:96:0) after 1m0s
[19:14:41.251] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:96:0)
[19:14:41.251] Timer tick, asking Buildbucket for the build status
[19:14:41.487] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:41.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:97:0) after 1m0s
[19:15:41.544] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:97:0)
[19:15:41.544] Timer tick, asking Buildbucket for the build status
[19:15:41.703] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:41.703] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:98:0) after 1m0s
[19:16:41.800] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:98:0)
[19:16:41.800] Timer tick, asking Buildbucket for the build status
[19:16:41.965] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:41.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:99:0) after 1m0s
[19:17:41.964] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:99:0)
[19:17:41.964] Timer tick, asking Buildbucket for the build status
[19:17:42.417] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:42.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:100:0) after 1m0s
[19:18:42.454] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:100:0)
[19:18:42.454] Timer tick, asking Buildbucket for the build status
[19:18:42.653] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:42.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:101:0) after 1m0s
[19:19:42.688] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:101:0)
[19:19:42.688] Timer tick, asking Buildbucket for the build status
[19:19:42.934] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:42.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:102:0) after 1m0s
[19:20:43.318] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:102:0)
[19:20:43.318] Timer tick, asking Buildbucket for the build status
[19:20:49.425] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:49.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:103:0) after 1m0s
[19:21:49.478] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:103:0)
[19:21:49.478] Timer tick, asking Buildbucket for the build status
[19:21:49.620] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:49.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:104:0) after 1m0s
[19:22:49.611] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:104:0)
[19:22:49.611] Timer tick, asking Buildbucket for the build status
[19:22:49.736] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:49.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:105:0) after 1m0s
[19:23:49.741] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:105:0)
[19:23:49.741] Timer tick, asking Buildbucket for the build status
[19:23:50.005] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:50.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:106:0) after 1m0s
[19:24:50.034] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:106:0)
[19:24:50.034] Timer tick, asking Buildbucket for the build status
[19:24:50.397] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:50.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:107:0) after 1m0s
[19:25:50.517] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:107:0)
[19:25:50.517] Timer tick, asking Buildbucket for the build status
[19:25:50.802] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:50.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:108:0) after 1m0s
[19:26:50.837] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:108:0)
[19:26:50.837] Timer tick, asking Buildbucket for the build status
[19:26:50.967] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:50.967] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:109:0) after 1m0s
[19:27:50.991] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:109:0)
[19:27:50.991] Timer tick, asking Buildbucket for the build status
[19:27:51.111] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:51.111] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:110:0) after 1m0s
[19:28:51.186] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:110:0)
[19:28:51.186] Timer tick, asking Buildbucket for the build status
[19:28:51.375] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:51.375] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:111:0) after 1m0s
[19:29:51.445] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:111:0)
[19:29:51.445] Timer tick, asking Buildbucket for the build status
[19:29:51.630] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:51.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:112:0) after 1m0s
[19:30:51.623] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:112:0)
[19:30:51.623] Timer tick, asking Buildbucket for the build status
[19:30:51.754] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:51.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:113:0) after 1m0s
[19:31:51.917] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:113:0)
[19:31:51.917] Timer tick, asking Buildbucket for the build status
[19:31:52.716] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:52.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:114:0) after 1m0s
[19:32:52.751] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:114:0)
[19:32:52.751] Timer tick, asking Buildbucket for the build status
[19:32:53.007] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:53.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:115:0) after 1m0s
[19:33:53.087] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:115:0)
[19:33:53.087] Timer tick, asking Buildbucket for the build status
[19:33:53.239] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:53.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:116:0) after 1m0s
[19:34:53.310] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:116:0)
[19:34:53.311] Timer tick, asking Buildbucket for the build status
[19:34:53.877] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:53.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:117:0) after 1m0s
[19:35:53.920] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:117:0)
[19:35:53.920] Timer tick, asking Buildbucket for the build status
[19:35:54.326] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:54.326] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:118:0) after 1m0s
[19:36:54.400] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:118:0)
[19:36:54.400] Timer tick, asking Buildbucket for the build status
[19:36:54.699] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:54.699] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:119:0) after 1m0s
[19:37:54.726] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:119:0)
[19:37:54.726] Timer tick, asking Buildbucket for the build status
[19:37:56.035] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:56.035] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:120:0) after 1m0s
[19:38:56.188] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:120:0)
[19:38:56.188] Timer tick, asking Buildbucket for the build status
[19:38:57.106] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:57.107] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:121:0) after 1m0s
[19:39:57.154] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:121:0)
[19:39:57.154] Timer tick, asking Buildbucket for the build status
[19:39:57.337] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:57.337] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:122:0) after 1m0s
[19:40:57.334] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:122:0)
[19:40:57.334] Timer tick, asking Buildbucket for the build status
[19:40:57.499] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:57.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:123:0) after 1m0s
[19:41:57.565] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:123:0)
[19:41:57.565] Timer tick, asking Buildbucket for the build status
[19:41:58.022] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:58.022] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:124:0) after 1m0s
[19:42:58.609] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:124:0)
[19:42:58.609] Timer tick, asking Buildbucket for the build status
[19:42:58.761] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:58.761] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:125:0) after 1m0s
[19:43:58.780] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:125:0)
[19:43:58.780] Timer tick, asking Buildbucket for the build status
[19:43:59.010] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:59.010] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:126:0) after 1m0s
[19:44:59.039] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:126:0)
[19:44:59.039] Timer tick, asking Buildbucket for the build status
[19:44:59.174] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:59.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:127:0) after 1m0s
[19:45:59.208] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:127:0)
[19:45:59.208] Timer tick, asking Buildbucket for the build status
[19:45:59.332] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:59.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:128:0) after 1m0s
[19:46:59.429] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:128:0)
[19:46:59.429] Timer tick, asking Buildbucket for the build status
[19:46:59.562] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:59.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:129:0) after 1m0s
[19:47:59.653] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:129:0)
[19:47:59.653] Timer tick, asking Buildbucket for the build status
[19:47:59.805] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:59.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:130:0) after 1m0s
[19:48:59.892] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:130:0)
[19:48:59.892] Timer tick, asking Buildbucket for the build status
[19:49:00.163] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:00.163] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:131:0) after 1m0s
[19:50:00.202] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:131:0)
[19:50:00.202] Timer tick, asking Buildbucket for the build status
[19:50:00.393] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:00.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:132:0) after 1m0s
[19:51:00.427] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:132:0)
[19:51:00.427] Timer tick, asking Buildbucket for the build status
[19:51:00.602] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:00.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:133:0) after 1m0s
[19:52:00.665] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:133:0)
[19:52:00.665] Timer tick, asking Buildbucket for the build status
[19:52:00.844] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:00.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:134:0) after 1m0s
[19:53:01.183] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:134:0)
[19:53:01.183] Timer tick, asking Buildbucket for the build status
[19:53:01.409] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:01.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:135:0) after 1m0s
[19:54:01.475] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:135:0)
[19:54:01.475] Timer tick, asking Buildbucket for the build status
[19:54:01.649] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:01.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:136:0) after 1m0s
[19:55:01.878] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:136:0)
[19:55:01.878] Timer tick, asking Buildbucket for the build status
[19:55:02.798] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:02.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:137:0) after 1m0s
[19:56:02.827] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:137:0)
[19:56:02.827] Timer tick, asking Buildbucket for the build status
[19:56:03.129] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:03.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:138:0) after 1m0s
[19:57:03.164] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:138:0)
[19:57:03.164] Timer tick, asking Buildbucket for the build status
[19:57:03.478] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:03.478] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:139:0) after 1m0s
[19:58:03.575] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:139:0)
[19:58:03.575] Timer tick, asking Buildbucket for the build status
[19:58:03.759] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:03.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:140:0) after 1m0s
[19:59:03.810] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:140:0)
[19:59:03.810] Timer tick, asking Buildbucket for the build status
[19:59:03.950] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:03.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:141:0) after 1m0s
[20:00:04.151] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:141:0)
[20:00:04.151] Timer tick, asking Buildbucket for the build status
[20:00:04.751] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:04.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:142:0) after 1m0s
[20:01:04.895] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:142:0)
[20:01:04.895] Timer tick, asking Buildbucket for the build status
[20:01:05.388] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:05.388] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:143:0) after 1m0s
[20:02:05.445] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:143:0)
[20:02:05.445] Timer tick, asking Buildbucket for the build status
[20:02:07.086] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:07.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:144:0) after 1m0s
[20:03:07.119] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:144:0)
[20:03:07.119] Timer tick, asking Buildbucket for the build status
[20:03:07.525] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:07.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:145:0) after 1m0s
[20:04:07.641] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:145:0)
[20:04:07.641] Timer tick, asking Buildbucket for the build status
[20:04:08.134] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:08.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:146:0) after 1m0s
[20:05:08.184] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:146:0)
[20:05:08.184] Timer tick, asking Buildbucket for the build status
[20:05:08.462] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:08.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:147:0) after 1m0s
[20:06:08.522] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:147:0)
[20:06:08.522] Timer tick, asking Buildbucket for the build status
[20:06:08.872] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:08.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:148:0) after 1m0s
[20:07:08.915] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:148:0)
[20:07:08.915] Timer tick, asking Buildbucket for the build status
[20:07:10.554] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:10.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:149:0) after 1m0s
[20:08:10.595] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:149:0)
[20:08:10.595] Timer tick, asking Buildbucket for the build status
[20:08:10.973] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:10.973] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:150:0) after 1m0s
[20:09:11.001] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:150:0)
[20:09:11.001] Timer tick, asking Buildbucket for the build status
[20:09:11.246] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:11.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:151:0) after 1m0s
[20:10:11.286] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:151:0)
[20:10:11.286] Timer tick, asking Buildbucket for the build status
[20:10:11.412] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:11.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:152:0) after 1m0s
[20:11:11.449] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:152:0)
[20:11:11.449] Timer tick, asking Buildbucket for the build status
[20:11:11.869] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:11.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:153:0) after 1m0s
[20:12:11.902] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:153:0)
[20:12:11.902] Timer tick, asking Buildbucket for the build status
[20:12:12.147] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:12.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:154:0) after 1m0s
[20:13:12.133] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:154:0)
[20:13:12.133] Timer tick, asking Buildbucket for the build status
[20:13:12.582] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:12.582] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:155:0) after 1m0s
[20:14:12.648] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:155:0)
[20:14:12.648] Timer tick, asking Buildbucket for the build status
[20:14:13.029] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:13.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:156:0) after 1m0s
[20:15:13.057] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:156:0)
[20:15:13.057] Timer tick, asking Buildbucket for the build status
[20:15:13.390] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:13.390] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:157:0) after 1m0s
[20:16:13.430] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:157:0)
[20:16:13.430] Timer tick, asking Buildbucket for the build status
[20:16:13.743] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:13.743] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:158:0) after 1m0s
[20:17:13.782] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:158:0)
[20:17:13.782] Timer tick, asking Buildbucket for the build status
[20:17:13.950] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:13.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:159:0) after 1m0s
[20:18:13.981] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:159:0)
[20:18:13.981] Timer tick, asking Buildbucket for the build status
[20:18:14.248] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:14.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:160:0) after 1m0s
[20:19:14.312] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:160:0)
[20:19:14.312] Timer tick, asking Buildbucket for the build status
[20:19:14.530] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:14.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:161:0) after 1m0s
[20:20:14.563] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:161:0)
[20:20:14.563] Timer tick, asking Buildbucket for the build status
[20:20:15.615] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:15.615] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:162:0) after 1m0s
[20:21:15.858] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:162:0)
[20:21:15.858] Timer tick, asking Buildbucket for the build status
[20:21:16.075] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:16.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:163:0) after 1m0s
[20:22:16.088] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:163:0)
[20:22:16.088] Timer tick, asking Buildbucket for the build status
[20:22:16.332] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:16.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:164:0) after 1m0s
[20:23:16.446] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:164:0)
[20:23:16.446] Timer tick, asking Buildbucket for the build status
[20:23:16.624] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:16.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:165:0) after 1m0s
[20:24:16.660] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:165:0)
[20:24:16.660] Timer tick, asking Buildbucket for the build status
[20:24:16.969] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:16.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:166:0) after 1m0s
[20:25:17.052] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:166:0)
[20:25:17.052] Timer tick, asking Buildbucket for the build status
[20:25:17.990] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:17.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:167:0) after 1m0s
[20:26:18.019] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:167:0)
[20:26:18.019] Timer tick, asking Buildbucket for the build status
[20:26:18.199] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:18.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:168:0) after 1m0s
[20:27:18.259] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:168:0)
[20:27:18.259] Timer tick, asking Buildbucket for the build status
[20:27:18.651] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:18.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:169:0) after 1m0s
[20:28:18.732] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:169:0)
[20:28:18.732] Timer tick, asking Buildbucket for the build status
[20:28:19.324] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:19.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:170:0) after 1m0s
[20:29:19.392] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:170:0)
[20:29:19.392] Timer tick, asking Buildbucket for the build status
[20:29:19.841] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:19.841] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:171:0) after 1m0s
[20:30:19.948] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:171:0)
[20:30:19.949] Timer tick, asking Buildbucket for the build status
[20:30:20.826] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:20.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:172:0) after 1m0s
[20:31:20.899] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:172:0)
[20:31:20.899] Timer tick, asking Buildbucket for the build status
[20:31:21.196] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:21.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:173:0) after 1m0s
[20:32:21.274] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:173:0)
[20:32:21.274] Timer tick, asking Buildbucket for the build status
[20:32:21.474] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:21.474] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:174:0) after 1m0s
[20:33:21.579] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:174:0)
[20:33:21.579] Timer tick, asking Buildbucket for the build status
[20:33:21.695] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:21.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:175:0) after 1m0s
[20:34:21.790] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:175:0)
[20:34:21.790] Timer tick, asking Buildbucket for the build status
[20:34:21.985] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:21.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:176:0) after 1m0s
[20:35:22.002] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:176:0)
[20:35:22.002] Timer tick, asking Buildbucket for the build status
[20:35:22.324] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:22.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:177:0) after 1m0s
[20:36:22.334] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:177:0)
[20:36:22.334] Timer tick, asking Buildbucket for the build status
[20:36:22.455] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:22.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:178:0) after 1m0s
[20:37:22.477] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:178:0)
[20:37:22.477] Timer tick, asking Buildbucket for the build status
[20:37:22.842] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:22.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:179:0) after 1m0s
[20:38:22.859] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:179:0)
[20:38:22.859] Timer tick, asking Buildbucket for the build status
[20:38:23.497] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:23.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:180:0) after 1m0s
[20:39:23.542] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:180:0)
[20:39:23.542] Timer tick, asking Buildbucket for the build status
[20:39:23.799] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:23.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:181:0) after 1m0s
[20:40:23.911] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:181:0)
[20:40:23.911] Timer tick, asking Buildbucket for the build status
[20:40:24.321] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:24.321] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:182:0) after 1m0s
[20:41:24.412] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:182:0)
[20:41:24.412] Timer tick, asking Buildbucket for the build status
[20:41:24.585] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:24.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:183:0) after 1m0s
[20:42:24.627] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:183:0)
[20:42:24.627] Timer tick, asking Buildbucket for the build status
[20:42:24.783] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:24.783] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:184:0) after 1m0s
[20:43:24.836] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:184:0)
[20:43:24.836] Timer tick, asking Buildbucket for the build status
[20:43:25.018] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:25.018] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:185:0) after 1m0s
[20:44:25.039] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:185:0)
[20:44:25.039] Timer tick, asking Buildbucket for the build status
[20:44:25.451] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:25.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:186:0) after 1m0s
[20:45:25.506] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:186:0)
[20:45:25.506] Timer tick, asking Buildbucket for the build status
[20:45:25.806] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:25.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:187:0) after 1m0s
[20:46:25.830] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:187:0)
[20:46:25.830] Timer tick, asking Buildbucket for the build status
[20:46:25.995] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:25.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:188:0) after 1m0s
[20:47:26.055] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:188:0)
[20:47:26.055] Timer tick, asking Buildbucket for the build status
[20:47:26.481] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:26.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:189:0) after 1m0s
[20:48:26.547] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:189:0)
[20:48:26.547] Timer tick, asking Buildbucket for the build status
[20:48:26.661] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:26.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:190:0) after 1m0s
[20:49:26.661] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:190:0)
[20:49:26.661] Timer tick, asking Buildbucket for the build status
[20:49:28.480] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:28.480] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:191:0) after 1m0s
[20:50:28.584] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:191:0)
[20:50:28.584] Timer tick, asking Buildbucket for the build status
[20:50:28.990] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:28.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:192:0) after 1m0s
[20:51:29.054] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:192:0)
[20:51:29.054] Timer tick, asking Buildbucket for the build status
[20:51:29.310] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:29.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:193:0) after 1m0s
[20:52:29.515] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:193:0)
[20:52:29.515] Timer tick, asking Buildbucket for the build status
[20:52:29.704] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:29.704] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:194:0) after 1m0s
[20:53:29.800] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:194:0)
[20:53:29.800] Timer tick, asking Buildbucket for the build status
[20:53:30.057] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:30.057] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:195:0) after 1m0s
[20:54:30.095] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:195:0)
[20:54:30.095] Timer tick, asking Buildbucket for the build status
[20:54:30.283] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:30.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:196:0) after 1m0s
[20:55:30.419] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:196:0)
[20:55:30.419] Timer tick, asking Buildbucket for the build status
[20:55:30.549] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:30.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:197:0) after 1m0s
[20:56:30.866] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:197:0)
[20:56:30.866] Timer tick, asking Buildbucket for the build status
[20:56:31.086] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:31.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:198:0) after 1m0s
[20:57:31.097] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:198:0)
[20:57:31.097] Timer tick, asking Buildbucket for the build status
[20:57:31.337] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:31.337] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:199:0) after 1m0s
[20:58:31.431] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:199:0)
[20:58:31.431] Timer tick, asking Buildbucket for the build status
[20:58:31.586] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:31.586] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:200:0) after 1m0s
[20:59:31.657] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:200:0)
[20:59:31.657] Timer tick, asking Buildbucket for the build status
[20:59:31.810] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:31.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:201:0) after 1m0s
[21:00:31.976] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:201:0)
[21:00:31.977] Timer tick, asking Buildbucket for the build status
[21:00:32.148] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:32.148] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:202:0) after 1m0s
[21:01:32.190] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:202:0)
[21:01:32.190] Timer tick, asking Buildbucket for the build status
[21:01:32.391] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:32.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:203:0) after 1m0s
[21:02:32.451] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:203:0)
[21:02:32.451] Timer tick, asking Buildbucket for the build status
[21:02:33.803] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:33.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:204:0) after 1m0s
[21:03:33.826] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:204:0)
[21:03:33.826] Timer tick, asking Buildbucket for the build status
[21:03:33.970] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:33.970] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:205:0) after 1m0s
[21:04:34.088] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:205:0)
[21:04:34.088] Timer tick, asking Buildbucket for the build status
[21:04:34.347] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:34.347] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:206:0) after 1m0s
[21:05:34.432] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:206:0)
[21:05:34.432] Timer tick, asking Buildbucket for the build status
[21:05:34.815] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:34.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:207:0) after 1m0s
[21:06:34.843] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:207:0)
[21:06:34.843] Timer tick, asking Buildbucket for the build status
[21:06:34.987] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:34.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:208:0) after 1m0s
[21:07:35.025] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:208:0)
[21:07:35.025] Timer tick, asking Buildbucket for the build status
[21:07:37.889] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:37.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:209:0) after 1m0s
[21:08:37.913] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:209:0)
[21:08:37.913] Timer tick, asking Buildbucket for the build status
[21:08:38.120] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:38.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:210:0) after 1m0s
[21:09:38.121] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:210:0)
[21:09:38.121] Timer tick, asking Buildbucket for the build status
[21:09:38.481] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:38.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:211:0) after 1m0s
[21:10:38.510] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:211:0)
[21:10:38.510] Timer tick, asking Buildbucket for the build status
[21:10:38.810] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:38.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:212:0) after 1m0s
[21:11:38.882] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:212:0)
[21:11:38.882] Timer tick, asking Buildbucket for the build status
[21:11:39.091] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:39.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:213:0) after 1m0s
[21:12:39.126] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:213:0)
[21:12:39.126] Timer tick, asking Buildbucket for the build status
[21:12:39.311] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:39.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:214:0) after 1m0s
[21:13:39.368] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:214:0)
[21:13:39.368] Timer tick, asking Buildbucket for the build status
[21:13:39.744] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:39.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:215:0) after 1m0s
[21:14:39.794] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:215:0)
[21:14:39.794] Timer tick, asking Buildbucket for the build status
[21:14:39.958] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:39.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:216:0) after 1m0s
[21:15:39.995] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:216:0)
[21:15:39.995] Timer tick, asking Buildbucket for the build status
[21:15:40.177] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:40.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:217:0) after 1m0s
[21:16:40.291] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:217:0)
[21:16:40.291] Timer tick, asking Buildbucket for the build status
[21:16:40.549] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:40.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:218:0) after 1m0s
[21:17:40.588] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:218:0)
[21:17:40.588] Timer tick, asking Buildbucket for the build status
[21:17:40.756] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:40.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:219:0) after 1m0s
[21:18:40.870] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:219:0)
[21:18:40.870] Timer tick, asking Buildbucket for the build status
[21:18:41.734] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:41.734] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:220:0) after 1m0s
[21:19:41.782] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:220:0)
[21:19:41.782] Timer tick, asking Buildbucket for the build status
[21:19:42.083] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:42.083] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:221:0) after 1m0s
[21:20:42.138] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:221:0)
[21:20:42.138] Timer tick, asking Buildbucket for the build status
[21:20:42.301] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:42.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:222:0) after 1m0s
[21:21:42.355] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:222:0)
[21:21:42.355] Timer tick, asking Buildbucket for the build status
[21:21:42.511] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:42.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:223:0) after 1m0s
[21:22:42.552] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:223:0)
[21:22:42.552] Timer tick, asking Buildbucket for the build status
[21:22:43.496] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:43.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:224:0) after 1m0s
[21:23:43.530] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:224:0)
[21:23:43.530] Timer tick, asking Buildbucket for the build status
[21:23:43.645] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:43.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:225:0) after 1m0s
[21:24:43.791] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:225:0)
[21:24:43.791] Timer tick, asking Buildbucket for the build status
[21:24:44.126] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:44.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:226:0) after 1m0s
[21:25:44.230] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:226:0)
[21:25:44.230] Timer tick, asking Buildbucket for the build status
[21:25:44.851] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:44.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:227:0) after 1m0s
[21:26:45.008] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:227:0)
[21:26:45.008] Timer tick, asking Buildbucket for the build status
[21:26:45.168] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:45.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:228:0) after 1m0s
[21:27:45.226] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:228:0)
[21:27:45.226] Timer tick, asking Buildbucket for the build status
[21:27:45.386] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:45.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:229:0) after 1m0s
[21:28:45.507] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:229:0)
[21:28:45.507] Timer tick, asking Buildbucket for the build status
[21:28:45.697] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:45.697] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:230:0) after 1m0s
[21:29:45.721] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:230:0)
[21:29:45.721] Timer tick, asking Buildbucket for the build status
[21:29:45.900] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:45.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:231:0) after 1m0s
[21:30:45.945] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:231:0)
[21:30:45.945] Timer tick, asking Buildbucket for the build status
[21:30:46.321] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:46.322] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:232:0) after 1m0s
[21:31:46.437] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:232:0)
[21:31:46.438] Timer tick, asking Buildbucket for the build status
[21:31:46.602] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:46.602] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:233:0) after 1m0s
[21:32:46.788] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:233:0)
[21:32:46.788] Timer tick, asking Buildbucket for the build status
[21:32:46.995] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:46.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:234:0) after 1m0s
[21:33:47.094] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:234:0)
[21:33:47.094] Timer tick, asking Buildbucket for the build status
[21:33:47.672] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:47.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:235:0) after 1m0s
[21:34:47.824] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:235:0)
[21:34:47.824] Timer tick, asking Buildbucket for the build status
[21:34:47.971] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:47.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:236:0) after 1m0s
[21:35:48.002] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:236:0)
[21:35:48.002] Timer tick, asking Buildbucket for the build status
[21:35:51.159] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:51.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:237:0) after 1m0s
[21:36:51.200] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:237:0)
[21:36:51.200] Timer tick, asking Buildbucket for the build status
[21:36:51.584] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:51.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:238:0) after 1m0s
[21:37:51.668] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:238:0)
[21:37:51.668] Timer tick, asking Buildbucket for the build status
[21:37:52.359] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:52.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:239:0) after 1m0s
[21:38:52.448] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:239:0)
[21:38:52.448] Timer tick, asking Buildbucket for the build status
[21:38:52.592] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:52.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:240:0) after 1m0s
[21:39:52.650] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:240:0)
[21:39:52.650] Timer tick, asking Buildbucket for the build status
[21:39:52.815] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:52.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:241:0) after 1m0s
[21:40:52.955] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:241:0)
[21:40:52.955] Timer tick, asking Buildbucket for the build status
[21:40:53.291] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:53.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:242:0) after 1m0s
[21:41:53.506] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:242:0)
[21:41:53.506] Timer tick, asking Buildbucket for the build status
[21:41:54.553] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:54.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:243:0) after 1m0s
[21:42:54.563] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:243:0)
[21:42:54.563] Timer tick, asking Buildbucket for the build status
[21:42:54.791] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:54.791] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:244:0) after 1m0s
[21:43:54.855] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:244:0)
[21:43:54.855] Timer tick, asking Buildbucket for the build status
[21:43:55.008] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:55.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:245:0) after 1m0s
[21:44:55.016] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:245:0)
[21:44:55.016] Timer tick, asking Buildbucket for the build status
[21:44:55.155] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:55.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:246:0) after 1m0s
[21:45:55.198] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:246:0)
[21:45:55.198] Timer tick, asking Buildbucket for the build status
[21:45:55.341] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:55.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:247:0) after 1m0s
[21:46:55.394] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:247:0)
[21:46:55.394] Timer tick, asking Buildbucket for the build status
[21:46:55.555] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:55.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:248:0) after 1m0s
[21:47:55.607] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:248:0)
[21:47:55.607] Timer tick, asking Buildbucket for the build status
[21:47:55.837] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:55.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:249:0) after 1m0s
[21:48:55.933] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:249:0)
[21:48:55.933] Timer tick, asking Buildbucket for the build status
[21:48:56.081] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:56.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:250:0) after 1m0s
[21:49:56.126] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:250:0)
[21:49:56.126] Timer tick, asking Buildbucket for the build status
[21:49:56.532] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:56.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:251:0) after 1m0s
[21:50:56.590] Handling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:251:0)
[21:50:56.590] Timer tick, asking Buildbucket for the build status
[21:50:56.744] Build 8875231812843605904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:56.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-64-validator-opt:9040661877091456992:252:0) after 1m0s
[21:51:42.898] Received PubSub notification, asking Buildbucket for the build status
[21:51:42.991] Build 8875231812843605904: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:51:42.991] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.ci",
    "canary_preference": "PROD",
    "completed_ts": "1594331502123266",
    "created_by": "project:nacl",
    "created_ts": "1594316390147815",
    "id": "8875231812843605904",
    "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\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f2b7d37238a5f49ba00fc1c152cbd5caa278d030\", \"title\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}}",
    "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\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@f2b7d37238a5f49ba00fc1c152cbd5caa278d030\", \"title\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/f2b7d37238a5f49ba00fc1c152cbd5caa278d030\"}]}, \"$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\": 148, \"got_revision\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\", \"mastername\": \"client.nacl\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"f2b7d37238a5f49ba00fc1c152cbd5caa278d030\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_149fed94fc0315f63a3ac899b53d3cfedce2ab533d8d891f9abe32610aa3106a_v2\", \"builder_ec3024801e8fae9a0c90cf0b91bc8fd309d619937749998ead917e6c37a3a5b5_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": "1594316501331307",
    "status": "COMPLETED",
    "status_changed_ts": "1594331502564329",
    "tags": [
      "build_address:luci.nacl.ci/linux-64-validator-opt/148",
      "builder:linux-64-validator-opt",
      "buildset:commit/git/f2b7d37238a5f49ba00fc1c152cbd5caa278d030",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/f2b7d37238a5f49ba00fc1c152cbd5caa278d030",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9040661877091456992",
      "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/8875231812843605904/+/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:4d4d7b16c80df210",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1594331502583770",
    "url": "https://ci.chromium.org/b/8875231812843605904",
    "utcnow_ts": "1594331502981368"
  }
}
[21:51:42.991] Invocation finished in 4h11m56.278637084s with status SUCCEEDED