buildbucket: <
  server: "cr-buildbucket.appspot.com"
  bucket: "luci.nacl.toolchain"
  builder: "linux-pnacl-x86_64"
>

• 21be4b46c82c14625859b4929af9ef6433fa04a5 (5 years ago)

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

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

[21:25:58.228] New invocation is queued and will start shortly
[21:26:00.985] Starting the invocation (attempt 1)
[21:26:01.067] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:26:01.067] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:26:01.067] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9052697042880079424",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64\",\"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\":\"21be4b46c82c14625859b4929af9ef6433fa04a5\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@21be4b46c82c14625859b4929af9ef6433fa04a5\",\"title\":\"21be4b46c82c14625859b4929af9ef6433fa04a5\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/21be4b46c82c14625859b4929af9ef6433fa04a5\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"21be4b46c82c14625859b4929af9ef6433fa04a5\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-pnacl-x86_64",
    "scheduler_invocation_id:9052697042880079424",
    "scheduler_job_id:nacl/linux-pnacl-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/21be4b46c82c14625859b4929af9ef6433fa04a5",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/21be4b46c82c14625859b4929af9ef6433fa04a5",
    "gitiles_ref:refs/heads/master"
  ]
}
[21:26:02.314] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1582838761233996",
    "id": "8887266979059845136",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64\", \"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\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@21be4b46c82c14625859b4929af9ef6433fa04a5\", \"title\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/21be4b46c82c14625859b4929af9ef6433fa04a5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1582838762058270",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7048",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/21be4b46c82c14625859b4929af9ef6433fa04a5",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/21be4b46c82c14625859b4929af9ef6433fa04a5",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9052697042880079424",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8887266979059845136/+/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": "1582838762058398",
    "url": "https://ci.chromium.org/b/8887266979059845136",
    "utcnow_ts": "1582838762252778"
  }
}
[21:26:02.314] Task URL: https://ci.chromium.org/b/8887266979059845136
[21:26:02.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:2:0) after 1m0s
[21:26:52.451] Received PubSub notification, asking Buildbucket for the build status
[21:26:52.588] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:02.365] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:2:0)
[21:27:02.365] Timer tick, asking Buildbucket for the build status
[21:27:02.587] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:02.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:4:0) after 1m0s
[21:28:02.662] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:4:0)
[21:28:02.662] Timer tick, asking Buildbucket for the build status
[21:28:03.293] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:03.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:5:0) after 1m0s
[21:29:03.410] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:5:0)
[21:29:03.410] Timer tick, asking Buildbucket for the build status
[21:29:03.823] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:03.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:6:0) after 1m0s
[21:30:04.021] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:6:0)
[21:30:04.022] Timer tick, asking Buildbucket for the build status
[21:30:04.188] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:04.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:7:0) after 1m0s
[21:31:04.301] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:7:0)
[21:31:04.301] Timer tick, asking Buildbucket for the build status
[21:31:04.504] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:04.504] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:8:0) after 1m0s
[21:32:04.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:8:0)
[21:32:04.597] Timer tick, asking Buildbucket for the build status
[21:32:04.999] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:04.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:9:0) after 1m0s
[21:33:05.225] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:9:0)
[21:33:05.225] Timer tick, asking Buildbucket for the build status
[21:33:05.345] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:05.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:10:0) after 1m0s
[21:34:05.423] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:10:0)
[21:34:05.423] Timer tick, asking Buildbucket for the build status
[21:34:05.514] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:05.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:11:0) after 1m0s
[21:35:05.636] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:11:0)
[21:35:05.636] Timer tick, asking Buildbucket for the build status
[21:35:05.808] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:05.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:12:0) after 1m0s
[21:36:05.857] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:12:0)
[21:36:05.857] Timer tick, asking Buildbucket for the build status
[21:36:05.973] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:05.973] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:13:0) after 1m0s
[21:37:06.052] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:13:0)
[21:37:06.052] Timer tick, asking Buildbucket for the build status
[21:37:06.199] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:06.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:14:0) after 1m0s
[21:38:06.313] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:14:0)
[21:38:06.313] Timer tick, asking Buildbucket for the build status
[21:38:06.393] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:06.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:15:0) after 1m0s
[21:39:06.470] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:15:0)
[21:39:06.470] Timer tick, asking Buildbucket for the build status
[21:39:06.544] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:06.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:16:0) after 1m0s
[21:40:06.617] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:16:0)
[21:40:06.617] Timer tick, asking Buildbucket for the build status
[21:40:06.716] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:06.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:17:0) after 1m0s
[21:41:06.806] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:17:0)
[21:41:06.806] Timer tick, asking Buildbucket for the build status
[21:41:07.198] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:07.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:18:0) after 1m0s
[21:42:07.311] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:18:0)
[21:42:07.311] Timer tick, asking Buildbucket for the build status
[21:42:07.417] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:07.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:19:0) after 1m0s
[21:43:07.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:19:0)
[21:43:07.556] Timer tick, asking Buildbucket for the build status
[21:43:07.637] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:07.637] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:20:0) after 1m0s
[21:44:07.693] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:20:0)
[21:44:07.693] Timer tick, asking Buildbucket for the build status
[21:44:07.888] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:07.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:21:0) after 1m0s
[21:45:07.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:21:0)
[21:45:07.894] Timer tick, asking Buildbucket for the build status
[21:45:08.214] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:08.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:22:0) after 1m0s
[21:46:08.241] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:22:0)
[21:46:08.241] Timer tick, asking Buildbucket for the build status
[21:46:08.516] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:08.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:23:0) after 1m0s
[21:47:08.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:23:0)
[21:47:08.660] Timer tick, asking Buildbucket for the build status
[21:47:08.830] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:08.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:24:0) after 1m0s
[21:48:08.907] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:24:0)
[21:48:08.908] Timer tick, asking Buildbucket for the build status
[21:48:09.230] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:09.230] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:25:0) after 1m0s
[21:49:09.234] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:25:0)
[21:49:09.234] Timer tick, asking Buildbucket for the build status
[21:49:09.975] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:09.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:26:0) after 1m0s
[21:50:10.021] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:26:0)
[21:50:10.021] Timer tick, asking Buildbucket for the build status
[21:50:10.137] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:10.137] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:27:0) after 1m0s
[21:51:10.162] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:27:0)
[21:51:10.162] Timer tick, asking Buildbucket for the build status
[21:51:10.376] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:10.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:28:0) after 1m0s
[21:52:10.454] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:28:0)
[21:52:10.454] Timer tick, asking Buildbucket for the build status
[21:52:10.561] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:10.561] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:29:0) after 1m0s
[21:53:10.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:29:0)
[21:53:10.587] Timer tick, asking Buildbucket for the build status
[21:53:10.818] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:10.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:30:0) after 1m0s
[21:54:10.838] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:30:0)
[21:54:10.838] Timer tick, asking Buildbucket for the build status
[21:54:10.962] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:10.962] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:31:0) after 1m0s
[21:55:11.046] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:31:0)
[21:55:11.046] Timer tick, asking Buildbucket for the build status
[21:55:11.261] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:11.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:32:0) after 1m0s
[21:56:11.333] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:32:0)
[21:56:11.333] Timer tick, asking Buildbucket for the build status
[21:56:11.701] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:11.701] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:33:0) after 1m0s
[21:57:11.766] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:33:0)
[21:57:11.766] Timer tick, asking Buildbucket for the build status
[21:57:11.922] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:11.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:34:0) after 1m0s
[21:58:11.947] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:34:0)
[21:58:11.947] Timer tick, asking Buildbucket for the build status
[21:58:12.376] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:12.376] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:35:0) after 1m0s
[21:59:12.454] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:35:0)
[21:59:12.454] Timer tick, asking Buildbucket for the build status
[21:59:12.581] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:12.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:36:0) after 1m0s
[22:00:12.707] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:36:0)
[22:00:12.707] Timer tick, asking Buildbucket for the build status
[22:00:12.855] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:12.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:37:0) after 1m0s
[22:01:12.888] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:37:0)
[22:01:12.888] Timer tick, asking Buildbucket for the build status
[22:01:13.102] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:13.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:38:0) after 1m0s
[22:02:13.182] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:38:0)
[22:02:13.182] Timer tick, asking Buildbucket for the build status
[22:02:13.491] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:13.491] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:39:0) after 1m0s
[22:03:13.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:39:0)
[22:03:13.587] Timer tick, asking Buildbucket for the build status
[22:03:13.889] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:13.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:40:0) after 1m0s
[22:04:13.929] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:40:0)
[22:04:13.929] Timer tick, asking Buildbucket for the build status
[22:04:14.132] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:14.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:41:0) after 1m0s
[22:05:14.238] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:41:0)
[22:05:14.238] Timer tick, asking Buildbucket for the build status
[22:05:14.363] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:14.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:42:0) after 1m0s
[22:06:14.674] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:42:0)
[22:06:14.674] Timer tick, asking Buildbucket for the build status
[22:06:14.792] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:14.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:43:0) after 1m0s
[22:07:14.864] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:43:0)
[22:07:14.864] Timer tick, asking Buildbucket for the build status
[22:07:15.009] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:15.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:44:0) after 1m0s
[22:08:15.092] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:44:0)
[22:08:15.092] Timer tick, asking Buildbucket for the build status
[22:08:15.208] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:15.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:45:0) after 1m0s
[22:09:15.250] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:45:0)
[22:09:15.250] Timer tick, asking Buildbucket for the build status
[22:09:15.352] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:15.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:46:0) after 1m0s
[22:10:15.399] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:46:0)
[22:10:15.400] Timer tick, asking Buildbucket for the build status
[22:10:15.543] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:15.543] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:47:0) after 1m0s
[22:11:15.602] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:47:0)
[22:11:15.602] Timer tick, asking Buildbucket for the build status
[22:11:15.896] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:15.896] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:48:0) after 1m0s
[22:12:15.988] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:48:0)
[22:12:15.988] Timer tick, asking Buildbucket for the build status
[22:12:21.748] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:21.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:49:0) after 1m0s
[22:13:21.796] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:49:0)
[22:13:21.796] Timer tick, asking Buildbucket for the build status
[22:13:22.207] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:22.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:50:0) after 1m0s
[22:14:22.273] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:50:0)
[22:14:22.273] Timer tick, asking Buildbucket for the build status
[22:14:22.857] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:22.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:51:0) after 1m0s
[22:15:22.929] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:51:0)
[22:15:22.929] Timer tick, asking Buildbucket for the build status
[22:15:23.063] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:23.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:52:0) after 1m0s
[22:16:23.310] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:52:0)
[22:16:23.310] Timer tick, asking Buildbucket for the build status
[22:16:23.798] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:23.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:53:0) after 1m0s
[22:17:23.869] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:53:0)
[22:17:23.869] Timer tick, asking Buildbucket for the build status
[22:17:23.981] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:23.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:54:0) after 1m0s
[22:18:24.065] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:54:0)
[22:18:24.065] Timer tick, asking Buildbucket for the build status
[22:18:24.168] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:24.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:55:0) after 1m0s
[22:19:24.293] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:55:0)
[22:19:24.293] Timer tick, asking Buildbucket for the build status
[22:19:24.386] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:24.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:56:0) after 1m0s
[22:20:24.463] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:56:0)
[22:20:24.463] Timer tick, asking Buildbucket for the build status
[22:20:24.592] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:24.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:57:0) after 1m0s
[22:21:24.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:57:0)
[22:21:24.646] Timer tick, asking Buildbucket for the build status
[22:21:24.920] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:24.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:58:0) after 1m0s
[22:22:25.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:58:0)
[22:22:25.006] Timer tick, asking Buildbucket for the build status
[22:22:25.120] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:25.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:59:0) after 1m0s
[22:23:25.201] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:59:0)
[22:23:25.201] Timer tick, asking Buildbucket for the build status
[22:23:25.533] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:25.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:60:0) after 1m0s
[22:24:25.607] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:60:0)
[22:24:25.607] Timer tick, asking Buildbucket for the build status
[22:24:25.709] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:25.709] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:61:0) after 1m0s
[22:25:25.754] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:61:0)
[22:25:25.754] Timer tick, asking Buildbucket for the build status
[22:25:25.845] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:25.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:62:0) after 1m0s
[22:26:25.895] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:62:0)
[22:26:25.895] Timer tick, asking Buildbucket for the build status
[22:26:26.102] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:26.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:63:0) after 1m0s
[22:27:26.273] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:63:0)
[22:27:26.273] Timer tick, asking Buildbucket for the build status
[22:27:26.463] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:26.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:64:0) after 1m0s
[22:28:26.530] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:64:0)
[22:28:26.530] Timer tick, asking Buildbucket for the build status
[22:28:26.782] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:26.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:65:0) after 1m0s
[22:29:26.877] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:65:0)
[22:29:26.877] Timer tick, asking Buildbucket for the build status
[22:29:27.147] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:27.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:66:0) after 1m0s
[22:30:27.174] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:66:0)
[22:30:27.174] Timer tick, asking Buildbucket for the build status
[22:30:27.278] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:27.278] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:67:0) after 1m0s
[22:31:27.382] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:67:0)
[22:31:27.382] Timer tick, asking Buildbucket for the build status
[22:31:27.512] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:27.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:68:0) after 1m0s
[22:32:27.599] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:68:0)
[22:32:27.599] Timer tick, asking Buildbucket for the build status
[22:32:27.702] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:27.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:69:0) after 1m0s
[22:33:27.805] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:69:0)
[22:33:27.805] Timer tick, asking Buildbucket for the build status
[22:33:28.185] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:28.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:70:0) after 1m0s
[22:34:28.226] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:70:0)
[22:34:28.226] Timer tick, asking Buildbucket for the build status
[22:34:28.335] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:28.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:71:0) after 1m0s
[22:35:28.585] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:71:0)
[22:35:28.585] Timer tick, asking Buildbucket for the build status
[22:35:28.977] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:28.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:72:0) after 1m0s
[22:36:29.191] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:72:0)
[22:36:29.191] Timer tick, asking Buildbucket for the build status
[22:36:29.290] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:29.290] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:73:0) after 1m0s
[22:37:29.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:73:0)
[22:37:29.459] Timer tick, asking Buildbucket for the build status
[22:37:29.590] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:29.590] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:74:0) after 1m0s
[22:38:29.676] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:74:0)
[22:38:29.676] Timer tick, asking Buildbucket for the build status
[22:38:30.068] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:30.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:75:0) after 1m0s
[22:39:30.183] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:75:0)
[22:39:30.183] Timer tick, asking Buildbucket for the build status
[22:39:30.300] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:30.300] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:76:0) after 1m0s
[22:40:30.404] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:76:0)
[22:40:30.404] Timer tick, asking Buildbucket for the build status
[22:40:30.633] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:30.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:77:0) after 1m0s
[22:41:30.792] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:77:0)
[22:41:30.792] Timer tick, asking Buildbucket for the build status
[22:41:30.943] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:30.943] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:78:0) after 1m0s
[22:42:31.098] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:78:0)
[22:42:31.098] Timer tick, asking Buildbucket for the build status
[22:42:31.225] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:31.225] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:79:0) after 1m0s
[22:43:31.486] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:79:0)
[22:43:31.486] Timer tick, asking Buildbucket for the build status
[22:43:31.703] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:31.703] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:80:0) after 1m0s
[22:44:31.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:80:0)
[22:44:31.749] Timer tick, asking Buildbucket for the build status
[22:44:31.892] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:31.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:81:0) after 1m0s
[22:45:31.958] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:81:0)
[22:45:31.958] Timer tick, asking Buildbucket for the build status
[22:45:32.088] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:32.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:82:0) after 1m0s
[22:46:32.181] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:82:0)
[22:46:32.181] Timer tick, asking Buildbucket for the build status
[22:46:32.292] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:32.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:83:0) after 1m0s
[22:47:32.358] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:83:0)
[22:47:32.358] Timer tick, asking Buildbucket for the build status
[22:47:32.468] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:32.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:84:0) after 1m0s
[22:48:32.649] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:84:0)
[22:48:32.649] Timer tick, asking Buildbucket for the build status
[22:48:32.811] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:32.811] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:85:0) after 1m0s
[22:49:32.959] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:85:0)
[22:49:32.959] Timer tick, asking Buildbucket for the build status
[22:49:33.134] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:33.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:86:0) after 1m0s
[22:50:33.216] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:86:0)
[22:50:33.216] Timer tick, asking Buildbucket for the build status
[22:50:33.403] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:33.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:87:0) after 1m0s
[22:51:33.479] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:87:0)
[22:51:33.479] Timer tick, asking Buildbucket for the build status
[22:51:33.633] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:33.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:88:0) after 1m0s
[22:52:33.648] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:88:0)
[22:52:33.648] Timer tick, asking Buildbucket for the build status
[22:52:33.776] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:33.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:89:0) after 1m0s
[22:53:33.849] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:89:0)
[22:53:33.849] Timer tick, asking Buildbucket for the build status
[22:53:33.962] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:33.962] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:90:0) after 1m0s
[22:54:34.128] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:90:0)
[22:54:34.128] Timer tick, asking Buildbucket for the build status
[22:54:34.359] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:34.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:91:0) after 1m0s
[22:55:34.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:91:0)
[22:55:34.414] Timer tick, asking Buildbucket for the build status
[22:55:34.728] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:34.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:92:0) after 1m0s
[22:56:34.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:92:0)
[22:56:34.832] Timer tick, asking Buildbucket for the build status
[22:56:34.956] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:34.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:93:0) after 1m0s
[22:57:35.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:93:0)
[22:57:35.018] Timer tick, asking Buildbucket for the build status
[22:57:35.191] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:35.191] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:94:0) after 1m0s
[22:58:35.276] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:94:0)
[22:58:35.276] Timer tick, asking Buildbucket for the build status
[22:58:35.387] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:35.387] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:95:0) after 1m0s
[22:59:35.480] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:95:0)
[22:59:35.480] Timer tick, asking Buildbucket for the build status
[22:59:35.598] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:35.598] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:96:0) after 1m0s
[23:00:35.698] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:96:0)
[23:00:35.698] Timer tick, asking Buildbucket for the build status
[23:00:36.117] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:36.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:97:0) after 1m0s
[23:01:36.304] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:97:0)
[23:01:36.304] Timer tick, asking Buildbucket for the build status
[23:01:36.451] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:36.451] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:98:0) after 1m0s
[23:02:36.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:98:0)
[23:02:36.503] Timer tick, asking Buildbucket for the build status
[23:02:36.631] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:36.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:99:0) after 1m0s
[23:03:36.659] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:99:0)
[23:03:36.659] Timer tick, asking Buildbucket for the build status
[23:03:36.833] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:36.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:100:0) after 1m0s
[23:04:36.992] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:100:0)
[23:04:36.992] Timer tick, asking Buildbucket for the build status
[23:04:37.143] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:37.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:101:0) after 1m0s
[23:05:37.209] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:101:0)
[23:05:37.209] Timer tick, asking Buildbucket for the build status
[23:05:37.487] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:37.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:102:0) after 1m0s
[23:06:37.555] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:102:0)
[23:06:37.555] Timer tick, asking Buildbucket for the build status
[23:06:37.759] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:37.759] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:103:0) after 1m0s
[23:07:37.845] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:103:0)
[23:07:37.845] Timer tick, asking Buildbucket for the build status
[23:07:38.034] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:38.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:104:0) after 1m0s
[23:08:38.251] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:104:0)
[23:08:38.251] Timer tick, asking Buildbucket for the build status
[23:08:38.477] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:38.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:105:0) after 1m0s
[23:09:38.604] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:105:0)
[23:09:38.604] Timer tick, asking Buildbucket for the build status
[23:09:38.720] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:38.720] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:106:0) after 1m0s
[23:10:39.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:106:0)
[23:10:39.207] Timer tick, asking Buildbucket for the build status
[23:10:39.313] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:39.313] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:107:0) after 1m0s
[23:11:39.483] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:107:0)
[23:11:39.483] Timer tick, asking Buildbucket for the build status
[23:11:39.704] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:39.704] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:108:0) after 1m0s
[23:12:39.980] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:108:0)
[23:12:39.980] Timer tick, asking Buildbucket for the build status
[23:12:40.084] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:40.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:109:0) after 1m0s
[23:13:40.345] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:109:0)
[23:13:40.345] Timer tick, asking Buildbucket for the build status
[23:13:40.463] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:40.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:110:0) after 1m0s
[23:14:40.581] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:110:0)
[23:14:40.581] Timer tick, asking Buildbucket for the build status
[23:14:41.039] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:41.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:111:0) after 1m0s
[23:15:41.161] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:111:0)
[23:15:41.161] Timer tick, asking Buildbucket for the build status
[23:15:42.310] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:42.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:112:0) after 1m0s
[23:16:42.333] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:112:0)
[23:16:42.333] Timer tick, asking Buildbucket for the build status
[23:16:42.465] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:42.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:113:0) after 1m0s
[23:17:42.512] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:113:0)
[23:17:42.512] Timer tick, asking Buildbucket for the build status
[23:17:42.905] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:42.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:114:0) after 1m0s
[23:18:42.976] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:114:0)
[23:18:42.976] Timer tick, asking Buildbucket for the build status
[23:18:43.113] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:43.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:115:0) after 1m0s
[23:19:43.156] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:115:0)
[23:19:43.156] Timer tick, asking Buildbucket for the build status
[23:19:43.258] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:43.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:116:0) after 1m0s
[23:20:43.324] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:116:0)
[23:20:43.324] Timer tick, asking Buildbucket for the build status
[23:20:43.497] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:43.497] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:117:0) after 1m0s
[23:21:43.548] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:117:0)
[23:21:43.548] Timer tick, asking Buildbucket for the build status
[23:21:43.707] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:43.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:118:0) after 1m0s
[23:22:43.756] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:118:0)
[23:22:43.756] Timer tick, asking Buildbucket for the build status
[23:22:43.906] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:43.906] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:119:0) after 1m0s
[23:23:43.936] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:119:0)
[23:23:43.936] Timer tick, asking Buildbucket for the build status
[23:23:44.277] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:44.277] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:120:0) after 1m0s
[23:24:44.368] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:120:0)
[23:24:44.368] Timer tick, asking Buildbucket for the build status
[23:24:44.507] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:44.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:121:0) after 1m0s
[23:25:44.544] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:121:0)
[23:25:44.544] Timer tick, asking Buildbucket for the build status
[23:25:44.776] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:44.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:122:0) after 1m0s
[23:26:44.799] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:122:0)
[23:26:44.799] Timer tick, asking Buildbucket for the build status
[23:26:44.888] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:44.888] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:123:0) after 1m0s
[23:27:44.976] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:123:0)
[23:27:44.976] Timer tick, asking Buildbucket for the build status
[23:27:45.077] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:45.077] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:124:0) after 1m0s
[23:28:45.278] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:124:0)
[23:28:45.278] Timer tick, asking Buildbucket for the build status
[23:28:45.537] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:45.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:125:0) after 1m0s
[23:29:45.680] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:125:0)
[23:29:45.681] Timer tick, asking Buildbucket for the build status
[23:29:46.088] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:46.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:126:0) after 1m0s
[23:30:46.317] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:126:0)
[23:30:46.317] Timer tick, asking Buildbucket for the build status
[23:30:46.496] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:46.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:127:0) after 1m0s
[23:31:46.541] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:127:0)
[23:31:46.541] Timer tick, asking Buildbucket for the build status
[23:31:46.677] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:46.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:128:0) after 1m0s
[23:32:46.947] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:128:0)
[23:32:46.947] Timer tick, asking Buildbucket for the build status
[23:32:47.067] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:47.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:129:0) after 1m0s
[23:33:47.096] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:129:0)
[23:33:47.096] Timer tick, asking Buildbucket for the build status
[23:33:47.505] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:47.505] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:130:0) after 1m0s
[23:34:48.769] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:130:0)
[23:34:48.769] Timer tick, asking Buildbucket for the build status
[23:34:49.154] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:49.154] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:131:0) after 1m0s
[23:35:49.178] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:131:0)
[23:35:49.178] Timer tick, asking Buildbucket for the build status
[23:35:49.281] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:49.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:132:0) after 1m0s
[23:36:49.420] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:132:0)
[23:36:49.420] Timer tick, asking Buildbucket for the build status
[23:36:49.558] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:49.558] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:133:0) after 1m0s
[23:37:49.606] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:133:0)
[23:37:49.606] Timer tick, asking Buildbucket for the build status
[23:37:49.880] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:49.880] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:134:0) after 1m0s
[23:38:49.925] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:134:0)
[23:38:49.925] Timer tick, asking Buildbucket for the build status
[23:38:50.184] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:50.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:135:0) after 1m0s
[23:39:50.206] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:135:0)
[23:39:50.206] Timer tick, asking Buildbucket for the build status
[23:39:50.355] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:50.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:136:0) after 1m0s
[23:40:50.435] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:136:0)
[23:40:50.435] Timer tick, asking Buildbucket for the build status
[23:40:50.548] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:50.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:137:0) after 1m0s
[23:41:50.629] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:137:0)
[23:41:50.629] Timer tick, asking Buildbucket for the build status
[23:41:50.825] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:50.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:138:0) after 1m0s
[23:42:51.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:138:0)
[23:42:51.168] Timer tick, asking Buildbucket for the build status
[23:42:51.500] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:51.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:139:0) after 1m0s
[23:43:51.533] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:139:0)
[23:43:51.533] Timer tick, asking Buildbucket for the build status
[23:43:51.936] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:51.936] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:140:0) after 1m0s
[23:44:52.384] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:140:0)
[23:44:52.384] Timer tick, asking Buildbucket for the build status
[23:44:52.584] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:52.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:141:0) after 1m0s
[23:45:52.692] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:141:0)
[23:45:52.692] Timer tick, asking Buildbucket for the build status
[23:45:53.258] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:53.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:142:0) after 1m0s
[23:46:53.435] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:142:0)
[23:46:53.435] Timer tick, asking Buildbucket for the build status
[23:46:53.579] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:53.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:143:0) after 1m0s
[23:47:53.641] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:143:0)
[23:47:53.641] Timer tick, asking Buildbucket for the build status
[23:47:53.812] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:53.813] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:144:0) after 1m0s
[23:48:53.857] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:144:0)
[23:48:53.857] Timer tick, asking Buildbucket for the build status
[23:48:53.998] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:53.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:145:0) after 1m0s
[23:49:54.034] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:145:0)
[23:49:54.034] Timer tick, asking Buildbucket for the build status
[23:49:54.164] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:54.164] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:146:0) after 1m0s
[23:50:54.227] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:146:0)
[23:50:54.227] Timer tick, asking Buildbucket for the build status
[23:50:54.364] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:54.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:147:0) after 1m0s
[23:51:54.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:147:0)
[23:51:54.397] Timer tick, asking Buildbucket for the build status
[23:51:54.561] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:54.561] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:148:0) after 1m0s
[23:52:54.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:148:0)
[23:52:54.656] Timer tick, asking Buildbucket for the build status
[23:52:54.777] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:54.777] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:149:0) after 1m0s
[23:53:54.826] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:149:0)
[23:53:54.826] Timer tick, asking Buildbucket for the build status
[23:53:55.036] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:55.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:150:0) after 1m0s
[23:54:55.263] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:150:0)
[23:54:55.263] Timer tick, asking Buildbucket for the build status
[23:54:55.425] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:55.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:151:0) after 1m0s
[23:55:55.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:151:0)
[23:55:55.491] Timer tick, asking Buildbucket for the build status
[23:55:55.755] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:55.756] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:152:0) after 1m0s
[23:56:55.881] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:152:0)
[23:56:55.881] Timer tick, asking Buildbucket for the build status
[23:56:55.998] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:55.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:153:0) after 1m0s
[23:57:56.079] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:153:0)
[23:57:56.079] Timer tick, asking Buildbucket for the build status
[23:57:56.198] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:56.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:154:0) after 1m0s
[23:58:56.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:154:0)
[23:58:56.280] Timer tick, asking Buildbucket for the build status
[23:58:56.732] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:56.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:155:0) after 1m0s
[23:59:56.847] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:155:0)
[23:59:56.847] Timer tick, asking Buildbucket for the build status
[23:59:56.985] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:56.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:156:0) after 1m0s
[00:00:57.173] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:156:0)
[00:00:57.173] Timer tick, asking Buildbucket for the build status
[00:00:57.300] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:57.300] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:157:0) after 1m0s
[00:01:57.442] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:157:0)
[00:01:57.442] Timer tick, asking Buildbucket for the build status
[00:01:57.631] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:57.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:158:0) after 1m0s
[00:02:57.691] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:158:0)
[00:02:57.691] Timer tick, asking Buildbucket for the build status
[00:02:57.835] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:57.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:159:0) after 1m0s
[00:03:57.965] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:159:0)
[00:03:57.965] Timer tick, asking Buildbucket for the build status
[00:03:58.100] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:58.100] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:160:0) after 1m0s
[00:04:58.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:160:0)
[00:04:58.149] Timer tick, asking Buildbucket for the build status
[00:04:58.568] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:58.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:161:0) after 1m0s
[00:05:58.647] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:161:0)
[00:05:58.647] Timer tick, asking Buildbucket for the build status
[00:05:58.782] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:58.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:162:0) after 1m0s
[00:06:59.042] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:162:0)
[00:06:59.042] Timer tick, asking Buildbucket for the build status
[00:06:59.260] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:59.260] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:163:0) after 1m0s
[00:07:59.281] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:163:0)
[00:07:59.281] Timer tick, asking Buildbucket for the build status
[00:07:59.395] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:59.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:164:0) after 1m0s
[00:08:59.637] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:164:0)
[00:08:59.637] Timer tick, asking Buildbucket for the build status
[00:08:59.796] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:59.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:165:0) after 1m0s
[00:09:59.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:165:0)
[00:09:59.832] Timer tick, asking Buildbucket for the build status
[00:09:59.926] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:59.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:166:0) after 1m0s
[00:11:00.066] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:166:0)
[00:11:00.066] Timer tick, asking Buildbucket for the build status
[00:11:00.253] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:00.253] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:167:0) after 1m0s
[00:12:00.294] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:167:0)
[00:12:00.294] Timer tick, asking Buildbucket for the build status
[00:12:00.641] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:00.642] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:168:0) after 1m0s
[00:13:00.677] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:168:0)
[00:13:00.677] Timer tick, asking Buildbucket for the build status
[00:13:00.767] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:00.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:169:0) after 1m0s
[00:14:00.939] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:169:0)
[00:14:00.939] Timer tick, asking Buildbucket for the build status
[00:14:01.217] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:01.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:170:0) after 1m0s
[00:15:01.250] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:170:0)
[00:15:01.250] Timer tick, asking Buildbucket for the build status
[00:15:01.645] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:01.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:171:0) after 1m0s
[00:16:01.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:171:0)
[00:16:01.671] Timer tick, asking Buildbucket for the build status
[00:16:01.879] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:01.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:172:0) after 1m0s
[00:17:01.958] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:172:0)
[00:17:01.958] Timer tick, asking Buildbucket for the build status
[00:17:02.328] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:02.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:173:0) after 1m0s
[00:18:02.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:173:0)
[00:18:02.491] Timer tick, asking Buildbucket for the build status
[00:18:02.635] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:02.635] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:174:0) after 1m0s
[00:19:02.716] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:174:0)
[00:19:02.716] Timer tick, asking Buildbucket for the build status
[00:19:02.830] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:02.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:175:0) after 1m0s
[00:20:02.983] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:175:0)
[00:20:02.983] Timer tick, asking Buildbucket for the build status
[00:20:03.145] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:03.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:176:0) after 1m0s
[00:21:03.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:176:0)
[00:21:03.168] Timer tick, asking Buildbucket for the build status
[00:21:03.336] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:03.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:177:0) after 1m0s
[00:22:03.435] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:177:0)
[00:22:03.435] Timer tick, asking Buildbucket for the build status
[00:22:03.559] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:03.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:178:0) after 1m0s
[00:23:03.793] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:178:0)
[00:23:03.793] Timer tick, asking Buildbucket for the build status
[00:23:03.966] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:03.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:179:0) after 1m0s
[00:24:04.282] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:179:0)
[00:24:04.282] Timer tick, asking Buildbucket for the build status
[00:24:05.229] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:05.229] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:180:0) after 1m0s
[00:25:05.657] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:180:0)
[00:25:05.657] Timer tick, asking Buildbucket for the build status
[00:25:05.765] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:05.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:181:0) after 1m0s
[00:26:06.054] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:181:0)
[00:26:06.054] Timer tick, asking Buildbucket for the build status
[00:26:06.186] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:06.186] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:182:0) after 1m0s
[00:27:06.779] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:182:0)
[00:27:06.779] Timer tick, asking Buildbucket for the build status
[00:27:07.019] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:07.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:183:0) after 1m0s
[00:28:07.146] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:183:0)
[00:28:07.146] Timer tick, asking Buildbucket for the build status
[00:28:07.293] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:07.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:184:0) after 1m0s
[00:29:07.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:184:0)
[00:29:07.577] Timer tick, asking Buildbucket for the build status
[00:29:07.737] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:07.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:185:0) after 1m0s
[00:30:07.934] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:185:0)
[00:30:07.934] Timer tick, asking Buildbucket for the build status
[00:30:08.094] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:08.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:186:0) after 1m0s
[00:31:08.309] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:186:0)
[00:31:08.309] Timer tick, asking Buildbucket for the build status
[00:31:08.438] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:08.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:187:0) after 1m0s
[00:32:08.741] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:187:0)
[00:32:08.741] Timer tick, asking Buildbucket for the build status
[00:32:08.958] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:08.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:188:0) after 1m0s
[00:33:08.993] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:188:0)
[00:33:08.993] Timer tick, asking Buildbucket for the build status
[00:33:09.274] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:09.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:189:0) after 1m0s
[00:34:09.393] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:189:0)
[00:34:09.393] Timer tick, asking Buildbucket for the build status
[00:34:09.645] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:09.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:190:0) after 1m0s
[00:35:09.665] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:190:0)
[00:35:09.665] Timer tick, asking Buildbucket for the build status
[00:35:09.798] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:09.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:191:0) after 1m0s
[00:36:09.951] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:191:0)
[00:36:09.951] Timer tick, asking Buildbucket for the build status
[00:36:10.126] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:10.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:192:0) after 1m0s
[00:37:10.171] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:192:0)
[00:37:10.171] Timer tick, asking Buildbucket for the build status
[00:37:10.343] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:10.343] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:193:0) after 1m0s
[00:38:10.469] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:193:0)
[00:38:10.469] Timer tick, asking Buildbucket for the build status
[00:38:10.934] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:10.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:194:0) after 1m0s
[00:39:11.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:194:0)
[00:39:11.089] Timer tick, asking Buildbucket for the build status
[00:39:11.439] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:11.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:195:0) after 1m0s
[00:40:11.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:195:0)
[00:40:11.608] Timer tick, asking Buildbucket for the build status
[00:40:11.912] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:11.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:196:0) after 1m0s
[00:41:11.998] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:196:0)
[00:41:11.998] Timer tick, asking Buildbucket for the build status
[00:41:12.176] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:12.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:197:0) after 1m0s
[00:42:12.312] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:197:0)
[00:42:12.312] Timer tick, asking Buildbucket for the build status
[00:42:12.645] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:12.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:198:0) after 1m0s
[00:43:12.758] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:198:0)
[00:43:12.758] Timer tick, asking Buildbucket for the build status
[00:43:13.001] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:13.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:199:0) after 1m0s
[00:44:13.104] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:199:0)
[00:44:13.104] Timer tick, asking Buildbucket for the build status
[00:44:13.247] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:13.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:200:0) after 1m0s
[00:45:13.372] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:200:0)
[00:45:13.372] Timer tick, asking Buildbucket for the build status
[00:45:13.517] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:13.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:201:0) after 1m0s
[00:46:13.592] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:201:0)
[00:46:13.592] Timer tick, asking Buildbucket for the build status
[00:46:13.696] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:13.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:202:0) after 1m0s
[00:47:13.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:202:0)
[00:47:13.844] Timer tick, asking Buildbucket for the build status
[00:47:14.216] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:14.216] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:203:0) after 1m0s
[00:48:14.488] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:203:0)
[00:48:14.488] Timer tick, asking Buildbucket for the build status
[00:48:14.826] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:14.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:204:0) after 1m0s
[00:49:14.875] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:204:0)
[00:49:14.875] Timer tick, asking Buildbucket for the build status
[00:49:15.036] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:15.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:205:0) after 1m0s
[00:50:15.089] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:205:0)
[00:50:15.089] Timer tick, asking Buildbucket for the build status
[00:50:15.203] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:15.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:206:0) after 1m0s
[00:51:15.337] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:206:0)
[00:51:15.337] Timer tick, asking Buildbucket for the build status
[00:51:15.447] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:15.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:207:0) after 1m0s
[00:52:15.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:207:0)
[00:52:15.616] Timer tick, asking Buildbucket for the build status
[00:52:15.862] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:15.862] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:208:0) after 1m0s
[00:53:15.886] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:208:0)
[00:53:15.886] Timer tick, asking Buildbucket for the build status
[00:53:16.045] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:16.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:209:0) after 1m0s
[00:54:16.142] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:209:0)
[00:54:16.142] Timer tick, asking Buildbucket for the build status
[00:54:16.291] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:16.291] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:210:0) after 1m0s
[00:55:16.374] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:210:0)
[00:55:16.374] Timer tick, asking Buildbucket for the build status
[00:55:16.588] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:16.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:211:0) after 1m0s
[00:56:16.666] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:211:0)
[00:56:16.666] Timer tick, asking Buildbucket for the build status
[00:56:16.767] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:16.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:212:0) after 1m0s
[00:57:16.814] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:212:0)
[00:57:16.814] Timer tick, asking Buildbucket for the build status
[00:57:16.951] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:16.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:213:0) after 1m0s
[00:58:17.074] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:213:0)
[00:58:17.074] Timer tick, asking Buildbucket for the build status
[00:58:17.325] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:17.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:214:0) after 1m0s
[00:59:17.406] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:214:0)
[00:59:17.406] Timer tick, asking Buildbucket for the build status
[00:59:17.690] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:17.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:215:0) after 1m0s
[01:00:17.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:215:0)
[01:00:17.832] Timer tick, asking Buildbucket for the build status
[01:00:18.171] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:18.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:216:0) after 1m0s
[01:01:18.377] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:216:0)
[01:01:18.377] Timer tick, asking Buildbucket for the build status
[01:01:18.494] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:18.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:217:0) after 1m0s
[01:02:18.576] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:217:0)
[01:02:18.576] Timer tick, asking Buildbucket for the build status
[01:02:18.736] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:18.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:218:0) after 1m0s
[01:03:18.829] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:218:0)
[01:03:18.829] Timer tick, asking Buildbucket for the build status
[01:03:19.084] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:19.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:219:0) after 1m0s
[01:04:19.209] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:219:0)
[01:04:19.209] Timer tick, asking Buildbucket for the build status
[01:04:19.568] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:19.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:220:0) after 1m0s
[01:05:19.673] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:220:0)
[01:05:19.673] Timer tick, asking Buildbucket for the build status
[01:05:19.893] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:19.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:221:0) after 1m0s
[01:06:20.013] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:221:0)
[01:06:20.013] Timer tick, asking Buildbucket for the build status
[01:06:20.211] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:20.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:222:0) after 1m0s
[01:07:20.327] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:222:0)
[01:07:20.328] Timer tick, asking Buildbucket for the build status
[01:07:20.454] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:20.454] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:223:0) after 1m0s
[01:08:20.626] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:223:0)
[01:08:20.626] Timer tick, asking Buildbucket for the build status
[01:08:20.803] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:20.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:224:0) after 1m0s
[01:09:20.811] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:224:0)
[01:09:20.811] Timer tick, asking Buildbucket for the build status
[01:09:21.003] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:21.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:225:0) after 1m0s
[01:10:21.054] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:225:0)
[01:10:21.054] Timer tick, asking Buildbucket for the build status
[01:10:21.455] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:21.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:226:0) after 1m0s
[01:11:21.583] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:226:0)
[01:11:21.583] Timer tick, asking Buildbucket for the build status
[01:11:21.847] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:21.847] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:227:0) after 1m0s
[01:12:21.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:227:0)
[01:12:21.921] Timer tick, asking Buildbucket for the build status
[01:12:22.200] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:22.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:228:0) after 1m0s
[01:13:22.264] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:228:0)
[01:13:22.264] Timer tick, asking Buildbucket for the build status
[01:13:22.443] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:22.443] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:229:0) after 1m0s
[01:14:22.488] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:229:0)
[01:14:22.488] Timer tick, asking Buildbucket for the build status
[01:14:22.893] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:22.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:230:0) after 1m0s
[01:15:22.907] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:230:0)
[01:15:22.907] Timer tick, asking Buildbucket for the build status
[01:15:23.008] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:23.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:231:0) after 1m0s
[01:16:23.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:231:0)
[01:16:23.127] Timer tick, asking Buildbucket for the build status
[01:16:23.264] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:23.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:232:0) after 1m0s
[01:17:23.304] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:232:0)
[01:17:23.304] Timer tick, asking Buildbucket for the build status
[01:17:23.604] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:23.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:233:0) after 1m0s
[01:18:23.634] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:233:0)
[01:18:23.634] Timer tick, asking Buildbucket for the build status
[01:18:23.731] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:23.731] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:234:0) after 1m0s
[01:19:23.789] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:234:0)
[01:19:23.789] Timer tick, asking Buildbucket for the build status
[01:19:24.086] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:24.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:235:0) after 1m0s
[01:20:24.223] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:235:0)
[01:20:24.223] Timer tick, asking Buildbucket for the build status
[01:20:24.357] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:24.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:236:0) after 1m0s
[01:21:24.388] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:236:0)
[01:21:24.388] Timer tick, asking Buildbucket for the build status
[01:21:24.495] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:24.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:237:0) after 1m0s
[01:22:24.571] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:237:0)
[01:22:24.571] Timer tick, asking Buildbucket for the build status
[01:22:25.105] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:25.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:238:0) after 1m0s
[01:23:25.102] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:238:0)
[01:23:25.102] Timer tick, asking Buildbucket for the build status
[01:23:25.220] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:25.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:239:0) after 1m0s
[01:24:25.263] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:239:0)
[01:24:25.263] Timer tick, asking Buildbucket for the build status
[01:24:25.386] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:25.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:240:0) after 1m0s
[01:25:25.418] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:240:0)
[01:25:25.418] Timer tick, asking Buildbucket for the build status
[01:25:25.516] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:25.517] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:241:0) after 1m0s
[01:26:25.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:241:0)
[01:26:25.553] Timer tick, asking Buildbucket for the build status
[01:26:25.705] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:25.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:242:0) after 1m0s
[01:27:25.759] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:242:0)
[01:27:25.760] Timer tick, asking Buildbucket for the build status
[01:27:25.901] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:25.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:243:0) after 1m0s
[01:28:25.927] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:243:0)
[01:28:25.927] Timer tick, asking Buildbucket for the build status
[01:28:26.364] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:26.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:244:0) after 1m0s
[01:29:26.424] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:244:0)
[01:29:26.424] Timer tick, asking Buildbucket for the build status
[01:29:26.597] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:26.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:245:0) after 1m0s
[01:30:26.645] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:245:0)
[01:30:26.645] Timer tick, asking Buildbucket for the build status
[01:30:26.748] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:26.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:246:0) after 1m0s
[01:31:26.797] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:246:0)
[01:31:26.797] Timer tick, asking Buildbucket for the build status
[01:31:26.967] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:26.967] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:247:0) after 1m0s
[01:32:26.975] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:247:0)
[01:32:26.975] Timer tick, asking Buildbucket for the build status
[01:32:27.158] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:27.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:248:0) after 1m0s
[01:33:27.196] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:248:0)
[01:33:27.196] Timer tick, asking Buildbucket for the build status
[01:33:27.441] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:27.441] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:249:0) after 1m0s
[01:34:27.564] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:249:0)
[01:34:27.564] Timer tick, asking Buildbucket for the build status
[01:34:27.665] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:27.665] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:250:0) after 1m0s
[01:35:27.729] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:250:0)
[01:35:27.729] Timer tick, asking Buildbucket for the build status
[01:35:27.846] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:27.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:251:0) after 1m0s
[01:36:27.898] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:251:0)
[01:36:27.898] Timer tick, asking Buildbucket for the build status
[01:36:28.027] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:28.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:252:0) after 1m0s
[01:37:28.033] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:252:0)
[01:37:28.033] Timer tick, asking Buildbucket for the build status
[01:37:28.195] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:28.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:253:0) after 1m0s
[01:38:28.236] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:253:0)
[01:38:28.236] Timer tick, asking Buildbucket for the build status
[01:38:28.351] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:28.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:254:0) after 1m0s
[01:39:28.408] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:254:0)
[01:39:28.408] Timer tick, asking Buildbucket for the build status
[01:39:28.949] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:28.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:255:0) after 1m0s
[01:40:29.086] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:255:0)
[01:40:29.086] Timer tick, asking Buildbucket for the build status
[01:40:29.196] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:29.196] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:256:0) after 1m0s
[01:41:29.241] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:256:0)
[01:41:29.241] Timer tick, asking Buildbucket for the build status
[01:41:29.491] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:29.491] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:257:0) after 1m0s
[01:42:29.604] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:257:0)
[01:42:29.604] Timer tick, asking Buildbucket for the build status
[01:42:29.820] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:29.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:258:0) after 1m0s
[01:43:29.885] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:258:0)
[01:43:29.885] Timer tick, asking Buildbucket for the build status
[01:43:29.997] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:29.997] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:259:0) after 1m0s
[01:44:30.095] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:259:0)
[01:44:30.095] Timer tick, asking Buildbucket for the build status
[01:44:30.261] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:30.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:260:0) after 1m0s
[01:45:30.338] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:260:0)
[01:45:30.338] Timer tick, asking Buildbucket for the build status
[01:45:30.650] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:30.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:261:0) after 1m0s
[01:46:30.853] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:261:0)
[01:46:30.853] Timer tick, asking Buildbucket for the build status
[01:46:31.106] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:31.106] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:262:0) after 1m0s
[01:47:31.166] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:262:0)
[01:47:31.166] Timer tick, asking Buildbucket for the build status
[01:47:31.396] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:31.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:263:0) after 1m0s
[01:48:31.551] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:263:0)
[01:48:31.551] Timer tick, asking Buildbucket for the build status
[01:48:31.682] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:31.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:264:0) after 1m0s
[01:49:31.822] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:264:0)
[01:49:31.822] Timer tick, asking Buildbucket for the build status
[01:49:31.976] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:31.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:265:0) after 1m0s
[01:50:32.077] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:265:0)
[01:50:32.077] Timer tick, asking Buildbucket for the build status
[01:50:32.178] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:32.178] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:266:0) after 1m0s
[01:51:32.210] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:266:0)
[01:51:32.210] Timer tick, asking Buildbucket for the build status
[01:51:32.417] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:32.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:267:0) after 1m0s
[01:52:32.446] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:267:0)
[01:52:32.446] Timer tick, asking Buildbucket for the build status
[01:52:32.536] Build 8887266979059845136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:32.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9052697042880079424:268:0) after 1m0s
[01:52:55.303] Received PubSub notification, asking Buildbucket for the build status
[01:52:55.393] Build 8887266979059845136: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:52:55.393] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "completed_ts": "1582854774758475",
    "created_by": "project:nacl",
    "created_ts": "1582838761233996",
    "failure_reason": "BUILD_FAILURE",
    "id": "8887266979059845136",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64\", \"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\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@21be4b46c82c14625859b4929af9ef6433fa04a5\", \"title\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/21be4b46c82c14625859b4929af9ef6433fa04a5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"Step('annotated steps') (retcode: 1)\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@21be4b46c82c14625859b4929af9ef6433fa04a5\", \"title\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/21be4b46c82c14625859b4929af9ef6433fa04a5\"}]}, \"bot_id\": \"luci-nacl-toolchain-xenial-0-gg6z\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-pnacl-x86_64\", \"buildnumber\": 7048, \"got_revision\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\", \"mastername\": \"client.nacl.toolchain\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"21be4b46c82c14625859b4929af9ef6433fa04a5\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"16\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-nacl-toolchain-xenial-0-gg6z\"], \"image\": [\"chrome-xenial-20022300-4c0e34b5b5e\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.nacl.toolchain\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4838-b69615e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}, \"ui\": {\"info\": \"Step('annotated steps') (retcode: 1)\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1582838811607255",
    "status": "COMPLETED",
    "status_changed_ts": "1582838812049014",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7048",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/21be4b46c82c14625859b4929af9ef6433fa04a5",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/21be4b46c82c14625859b4929af9ef6433fa04a5",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9052697042880079424",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8887266979059845136/+/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:4aa15c54c1f96310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1582854774911859",
    "url": "https://ci.chromium.org/b/8887266979059845136",
    "utcnow_ts": "1582854775385303"
  }
}
[01:52:55.393] Invocation finished in 4h26m57.186398795s with status FAILED