LUCI Scheduler :: nacl :: linux-pnacl-x86_64

Status: SUCCEEDED

Triggered by: -

Duration: 3 hours

Actions:

Definition (rev 1c82d86159c2071b02a7ddf08ffd2ae0bff92186)

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

Incoming triggers

15362ac60573769f6606ab1d1c11668052e411a7 (6 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[20:31:24.218] New invocation is queued and will start shortly
[20:31:25.490] Starting the invocation (attempt 1)
[20:31:25.541] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:31:25.541] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:31:25.542] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9086946129230809104",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"15362ac60573769f6606ab1d1c11668052e411a7\"}}",
  "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:9086946129230809104",
    "scheduler_job_id:nacl/linux-pnacl-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/15362ac60573769f6606ab1d1c11668052e411a7",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/15362ac60573769f6606ab1d1c11668052e411a7",
    "gitiles_ref:refs/heads/master"
  ]
}
[20:31:27.292] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1550176285672749",
    "id": "8921516067033525632",
    "lease_expiration_ts": "1550327486841940",
    "lease_key": "194826565",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"15362ac60573769f6606ab1d1c11668052e411a7\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1550176287073414",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7027",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/15362ac60573769f6606ab1d1c11668052e411a7",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/15362ac60573769f6606ab1d1c11668052e411a7",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9086946129230809104",
      "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/8921516067033525632/+/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:4306867ec8a35310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1550176287073559",
    "url": "https://ci.chromium.org/b/8921516067033525632",
    "utcnow_ts": "1550176287282394"
  }
}
[20:31:27.292] Task URL: https://ci.chromium.org/b/8921516067033525632
[20:31:27.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:2:0) after 1m0s
[20:31:43.099] Received PubSub notification, asking Buildbucket for the build status
[20:31:43.168] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:27.307] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:2:0)
[20:32:27.307] Timer tick, asking Buildbucket for the build status
[20:32:27.417] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:27.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:4:0) after 1m0s
[20:33:27.437] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:4:0)
[20:33:27.437] Timer tick, asking Buildbucket for the build status
[20:33:27.647] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:27.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:5:0) after 1m0s
[20:34:27.664] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:5:0)
[20:34:27.664] Timer tick, asking Buildbucket for the build status
[20:34:27.851] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:27.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:6:0) after 1m0s
[20:35:27.868] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:6:0)
[20:35:27.868] Timer tick, asking Buildbucket for the build status
[20:35:27.951] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:27.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:7:0) after 1m0s
[20:36:27.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:7:0)
[20:36:27.967] Timer tick, asking Buildbucket for the build status
[20:36:28.020] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:28.020] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:8:0) after 1m0s
[20:37:28.043] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:8:0)
[20:37:28.043] Timer tick, asking Buildbucket for the build status
[20:37:28.406] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:28.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:9:0) after 1m0s
[20:38:28.421] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:9:0)
[20:38:28.421] Timer tick, asking Buildbucket for the build status
[20:38:28.537] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:28.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:10:0) after 1m0s
[20:39:28.643] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:10:0)
[20:39:28.643] Timer tick, asking Buildbucket for the build status
[20:39:28.766] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:28.766] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:11:0) after 1m0s
[20:40:28.782] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:11:0)
[20:40:28.782] Timer tick, asking Buildbucket for the build status
[20:40:29.124] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:29.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:12:0) after 1m0s
[20:41:29.140] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:12:0)
[20:41:29.140] Timer tick, asking Buildbucket for the build status
[20:41:29.349] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:29.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:13:0) after 1m0s
[20:42:29.390] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:13:0)
[20:42:29.390] Timer tick, asking Buildbucket for the build status
[20:42:29.458] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:29.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:14:0) after 1m0s
[20:43:29.472] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:14:0)
[20:43:29.472] Timer tick, asking Buildbucket for the build status
[20:43:29.539] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:29.539] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:15:0) after 1m0s
[20:44:29.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:15:0)
[20:44:29.556] Timer tick, asking Buildbucket for the build status
[20:44:29.646] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:29.646] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:16:0) after 1m0s
[20:45:29.664] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:16:0)
[20:45:29.664] Timer tick, asking Buildbucket for the build status
[20:45:29.785] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:29.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:17:0) after 1m0s
[20:46:29.802] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:17:0)
[20:46:29.802] Timer tick, asking Buildbucket for the build status
[20:46:29.976] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:29.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:18:0) after 1m0s
[20:47:29.992] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:18:0)
[20:47:29.992] Timer tick, asking Buildbucket for the build status
[20:47:30.264] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:30.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:19:0) after 1m0s
[20:48:30.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:19:0)
[20:48:30.280] Timer tick, asking Buildbucket for the build status
[20:48:30.405] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:30.405] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:20:0) after 1m0s
[20:49:30.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:20:0)
[20:49:30.491] Timer tick, asking Buildbucket for the build status
[20:49:30.629] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:30.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:21:0) after 1m0s
[20:50:30.644] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:21:0)
[20:50:30.644] Timer tick, asking Buildbucket for the build status
[20:50:30.867] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:30.867] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:22:0) after 1m0s
[20:51:30.886] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:22:0)
[20:51:30.886] Timer tick, asking Buildbucket for the build status
[20:51:31.029] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:31.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:23:0) after 1m0s
[20:52:31.100] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:23:0)
[20:52:31.100] Timer tick, asking Buildbucket for the build status
[20:52:31.217] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:31.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:24:0) after 1m0s
[20:53:31.289] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:24:0)
[20:53:31.289] Timer tick, asking Buildbucket for the build status
[20:53:31.436] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:31.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:25:0) after 1m0s
[20:54:31.469] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:25:0)
[20:54:31.469] Timer tick, asking Buildbucket for the build status
[20:54:31.893] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:31.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:26:0) after 1m0s
[20:55:31.909] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:26:0)
[20:55:31.909] Timer tick, asking Buildbucket for the build status
[20:55:32.188] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:32.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:27:0) after 1m0s
[20:56:32.204] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:27:0)
[20:56:32.204] Timer tick, asking Buildbucket for the build status
[20:56:32.485] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:32.485] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:28:0) after 1m0s
[20:57:32.501] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:28:0)
[20:57:32.501] Timer tick, asking Buildbucket for the build status
[20:57:32.994] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:32.994] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:29:0) after 1m0s
[20:58:33.010] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:29:0)
[20:58:33.010] Timer tick, asking Buildbucket for the build status
[20:58:33.117] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:33.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:30:0) after 1m0s
[20:59:33.136] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:30:0)
[20:59:33.136] Timer tick, asking Buildbucket for the build status
[20:59:33.260] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:33.260] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:31:0) after 1m0s
[21:00:33.317] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:31:0)
[21:00:33.317] Timer tick, asking Buildbucket for the build status
[21:00:33.427] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:33.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:32:0) after 1m0s
[21:01:33.462] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:32:0)
[21:01:33.462] Timer tick, asking Buildbucket for the build status
[21:01:33.549] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:33.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:33:0) after 1m0s
[21:02:33.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:33:0)
[21:02:33.577] Timer tick, asking Buildbucket for the build status
[21:02:33.652] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:33.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:34:0) after 1m0s
[21:03:33.666] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:34:0)
[21:03:33.666] Timer tick, asking Buildbucket for the build status
[21:03:33.767] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:33.767] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:35:0) after 1m0s
[21:04:33.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:35:0)
[21:04:33.787] Timer tick, asking Buildbucket for the build status
[21:04:33.852] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:33.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:36:0) after 1m0s
[21:05:33.867] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:36:0)
[21:05:33.867] Timer tick, asking Buildbucket for the build status
[21:05:33.916] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:33.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:37:0) after 1m0s
[21:06:33.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:37:0)
[21:06:33.932] Timer tick, asking Buildbucket for the build status
[21:06:34.092] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:34.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:38:0) after 1m0s
[21:07:34.108] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:38:0)
[21:07:34.108] Timer tick, asking Buildbucket for the build status
[21:07:34.151] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:34.151] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:39:0) after 1m0s
[21:08:34.223] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:39:0)
[21:08:34.223] Timer tick, asking Buildbucket for the build status
[21:08:34.275] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:34.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:40:0) after 1m0s
[21:09:34.296] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:40:0)
[21:09:34.296] Timer tick, asking Buildbucket for the build status
[21:09:34.660] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:34.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:41:0) after 1m0s
[21:10:34.678] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:41:0)
[21:10:34.678] Timer tick, asking Buildbucket for the build status
[21:10:34.903] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:34.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:42:0) after 1m0s
[21:11:34.942] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:42:0)
[21:11:34.942] Timer tick, asking Buildbucket for the build status
[21:11:35.226] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:35.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:43:0) after 1m0s
[21:12:35.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:43:0)
[21:12:35.300] Timer tick, asking Buildbucket for the build status
[21:12:35.370] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:35.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:44:0) after 1m0s
[21:13:35.453] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:44:0)
[21:13:35.453] Timer tick, asking Buildbucket for the build status
[21:13:35.519] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:35.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:45:0) after 1m0s
[21:14:35.558] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:45:0)
[21:14:35.558] Timer tick, asking Buildbucket for the build status
[21:14:35.718] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:35.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:46:0) after 1m0s
[21:15:35.744] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:46:0)
[21:15:35.744] Timer tick, asking Buildbucket for the build status
[21:15:35.838] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:35.838] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:47:0) after 1m0s
[21:16:35.857] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:47:0)
[21:16:35.857] Timer tick, asking Buildbucket for the build status
[21:16:36.081] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:36.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:48:0) after 1m0s
[21:17:36.098] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:48:0)
[21:17:36.098] Timer tick, asking Buildbucket for the build status
[21:17:36.445] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:36.445] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:49:0) after 1m0s
[21:18:36.465] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:49:0)
[21:18:36.465] Timer tick, asking Buildbucket for the build status
[21:18:37.019] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:37.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:50:0) after 1m0s
[21:19:37.055] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:50:0)
[21:19:37.055] Timer tick, asking Buildbucket for the build status
[21:19:37.202] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:37.202] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:51:0) after 1m0s
[21:20:37.225] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:51:0)
[21:20:37.225] Timer tick, asking Buildbucket for the build status
[21:20:37.472] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:37.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:52:0) after 1m0s
[21:21:37.490] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:52:0)
[21:21:37.490] Timer tick, asking Buildbucket for the build status
[21:21:37.951] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:37.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:53:0) after 1m0s
[21:22:37.994] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:53:0)
[21:22:37.994] Timer tick, asking Buildbucket for the build status
[21:22:38.495] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:38.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:54:0) after 1m0s
[21:23:38.516] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:54:0)
[21:23:38.516] Timer tick, asking Buildbucket for the build status
[21:23:38.719] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:38.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:55:0) after 1m0s
[21:24:38.736] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:55:0)
[21:24:38.736] Timer tick, asking Buildbucket for the build status
[21:24:40.369] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:40.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:56:0) after 1m0s
[21:25:40.387] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:56:0)
[21:25:40.387] Timer tick, asking Buildbucket for the build status
[21:25:41.360] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:41.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:57:0) after 1m0s
[21:26:41.386] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:57:0)
[21:26:41.386] Timer tick, asking Buildbucket for the build status
[21:26:41.708] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:41.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:58:0) after 1m0s
[21:27:41.727] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:58:0)
[21:27:41.727] Timer tick, asking Buildbucket for the build status
[21:27:42.198] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:42.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:59:0) after 1m0s
[21:28:42.230] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:59:0)
[21:28:42.230] Timer tick, asking Buildbucket for the build status
[21:28:43.421] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:43.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:60:0) after 1m0s
[21:29:43.440] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:60:0)
[21:29:43.440] Timer tick, asking Buildbucket for the build status
[21:29:43.739] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:43.739] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:61:0) after 1m0s
[21:30:43.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:61:0)
[21:30:43.755] Timer tick, asking Buildbucket for the build status
[21:30:44.586] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:44.586] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:62:0) after 1m0s
[21:31:44.605] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:62:0)
[21:31:44.605] Timer tick, asking Buildbucket for the build status
[21:31:45.485] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:45.485] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:63:0) after 1m0s
[21:32:45.504] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:63:0)
[21:32:45.504] Timer tick, asking Buildbucket for the build status
[21:32:45.755] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:45.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:64:0) after 1m0s
[21:33:45.775] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:64:0)
[21:33:45.775] Timer tick, asking Buildbucket for the build status
[21:33:47.630] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:47.630] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:65:0) after 1m0s
[21:34:47.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:65:0)
[21:34:47.660] Timer tick, asking Buildbucket for the build status
[21:34:47.901] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:47.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:66:0) after 1m0s
[21:35:47.920] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:66:0)
[21:35:47.920] Timer tick, asking Buildbucket for the build status
[21:35:48.193] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:48.193] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:67:0) after 1m0s
[21:36:48.212] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:67:0)
[21:36:48.212] Timer tick, asking Buildbucket for the build status
[21:36:49.158] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:49.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:68:0) after 1m0s
[21:37:49.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:68:0)
[21:37:49.177] Timer tick, asking Buildbucket for the build status
[21:37:49.980] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:49.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:69:0) after 1m0s
[21:38:50.015] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:69:0)
[21:38:50.015] Timer tick, asking Buildbucket for the build status
[21:38:50.344] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:50.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:70:0) after 1m0s
[21:39:50.387] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:70:0)
[21:39:50.387] Timer tick, asking Buildbucket for the build status
[21:39:50.798] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:50.798] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:71:0) after 1m0s
[21:40:50.920] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:71:0)
[21:40:50.920] Timer tick, asking Buildbucket for the build status
[21:40:51.247] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:51.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:72:0) after 1m0s
[21:41:51.288] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:72:0)
[21:41:51.288] Timer tick, asking Buildbucket for the build status
[21:41:51.447] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:51.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:73:0) after 1m0s
[21:42:51.463] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:73:0)
[21:42:51.463] Timer tick, asking Buildbucket for the build status
[21:42:51.943] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:51.943] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:74:0) after 1m0s
[21:43:51.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:74:0)
[21:43:51.962] Timer tick, asking Buildbucket for the build status
[21:43:52.462] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:52.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:75:0) after 1m0s
[21:44:52.523] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:75:0)
[21:44:52.523] Timer tick, asking Buildbucket for the build status
[21:44:53.012] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:53.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:76:0) after 1m0s
[21:45:53.033] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:76:0)
[21:45:53.033] Timer tick, asking Buildbucket for the build status
[21:45:53.335] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:53.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:77:0) after 1m0s
[21:46:53.359] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:77:0)
[21:46:53.359] Timer tick, asking Buildbucket for the build status
[21:46:53.789] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:53.789] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:78:0) after 1m0s
[21:47:53.809] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:78:0)
[21:47:53.810] Timer tick, asking Buildbucket for the build status
[21:47:54.530] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:54.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:79:0) after 1m0s
[21:48:54.550] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:79:0)
[21:48:54.550] Timer tick, asking Buildbucket for the build status
[21:48:55.142] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:55.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:80:0) after 1m0s
[21:49:55.163] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:80:0)
[21:49:55.163] Timer tick, asking Buildbucket for the build status
[21:49:55.243] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:55.243] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:81:0) after 1m0s
[21:50:55.263] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:81:0)
[21:50:55.263] Timer tick, asking Buildbucket for the build status
[21:50:55.796] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:55.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:82:0) after 1m0s
[21:51:55.834] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:82:0)
[21:51:55.834] Timer tick, asking Buildbucket for the build status
[21:51:56.315] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:56.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:83:0) after 1m0s
[21:52:56.336] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:83:0)
[21:52:56.336] Timer tick, asking Buildbucket for the build status
[21:52:56.715] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:56.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:84:0) after 1m0s
[21:53:56.733] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:84:0)
[21:53:56.733] Timer tick, asking Buildbucket for the build status
[21:53:56.904] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:56.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:85:0) after 1m0s
[21:54:56.920] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:85:0)
[21:54:56.920] Timer tick, asking Buildbucket for the build status
[21:54:57.010] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:57.010] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:86:0) after 1m0s
[21:55:57.026] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:86:0)
[21:55:57.026] Timer tick, asking Buildbucket for the build status
[21:55:57.103] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:57.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:87:0) after 1m0s
[21:56:57.129] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:87:0)
[21:56:57.129] Timer tick, asking Buildbucket for the build status
[21:56:57.320] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:57.320] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:88:0) after 1m0s
[21:57:57.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:88:0)
[21:57:57.344] Timer tick, asking Buildbucket for the build status
[21:57:58.012] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:58.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:89:0) after 1m0s
[21:58:58.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:89:0)
[21:58:58.032] Timer tick, asking Buildbucket for the build status
[21:58:58.301] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:58.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:90:0) after 1m0s
[21:59:58.326] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:90:0)
[21:59:58.326] Timer tick, asking Buildbucket for the build status
[21:59:58.632] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:58.632] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:91:0) after 1m0s
[22:00:58.659] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:91:0)
[22:00:58.659] Timer tick, asking Buildbucket for the build status
[22:00:58.757] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:58.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:92:0) after 1m0s
[22:01:58.783] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:92:0)
[22:01:58.783] Timer tick, asking Buildbucket for the build status
[22:01:59.166] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:59.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:93:0) after 1m0s
[22:02:59.294] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:93:0)
[22:02:59.294] Timer tick, asking Buildbucket for the build status
[22:03:00.059] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:00.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:94:0) after 1m0s
[22:04:00.080] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:94:0)
[22:04:00.080] Timer tick, asking Buildbucket for the build status
[22:04:00.365] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:00.365] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:95:0) after 1m0s
[22:05:00.384] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:95:0)
[22:05:00.384] Timer tick, asking Buildbucket for the build status
[22:05:00.868] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:00.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:96:0) after 1m0s
[22:06:00.889] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:96:0)
[22:06:00.889] Timer tick, asking Buildbucket for the build status
[22:06:00.982] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:00.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:97:0) after 1m0s
[22:07:01.002] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:97:0)
[22:07:01.002] Timer tick, asking Buildbucket for the build status
[22:07:02.069] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:02.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:98:0) after 1m0s
[22:08:02.092] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:98:0)
[22:08:02.092] Timer tick, asking Buildbucket for the build status
[22:08:02.179] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:02.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:99:0) after 1m0s
[22:09:02.198] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:99:0)
[22:09:02.198] Timer tick, asking Buildbucket for the build status
[22:09:02.564] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:02.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:100:0) after 1m0s
[22:10:02.586] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:100:0)
[22:10:02.586] Timer tick, asking Buildbucket for the build status
[22:10:02.715] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:02.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:101:0) after 1m0s
[22:11:02.733] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:101:0)
[22:11:02.733] Timer tick, asking Buildbucket for the build status
[22:11:03.334] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:03.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:102:0) after 1m0s
[22:12:03.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:102:0)
[22:12:03.354] Timer tick, asking Buildbucket for the build status
[22:12:04.091] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:04.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:103:0) after 1m0s
[22:13:04.116] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:103:0)
[22:13:04.116] Timer tick, asking Buildbucket for the build status
[22:13:04.285] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:04.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:104:0) after 1m0s
[22:14:04.312] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:104:0)
[22:14:04.312] Timer tick, asking Buildbucket for the build status
[22:14:04.763] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:04.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:105:0) after 1m0s
[22:15:04.788] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:105:0)
[22:15:04.788] Timer tick, asking Buildbucket for the build status
[22:15:05.186] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:05.186] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:106:0) after 1m0s
[22:16:05.208] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:106:0)
[22:16:05.208] Timer tick, asking Buildbucket for the build status
[22:16:05.310] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:05.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:107:0) after 1m0s
[22:17:05.332] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:107:0)
[22:17:05.332] Timer tick, asking Buildbucket for the build status
[22:17:06.772] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:06.772] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:108:0) after 1m0s
[22:18:06.807] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:108:0)
[22:18:06.807] Timer tick, asking Buildbucket for the build status
[22:18:07.256] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:07.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:109:0) after 1m0s
[22:19:07.307] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:109:0)
[22:19:07.307] Timer tick, asking Buildbucket for the build status
[22:19:07.675] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:07.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:110:0) after 1m0s
[22:20:07.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:110:0)
[22:20:07.721] Timer tick, asking Buildbucket for the build status
[22:20:07.876] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:07.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:111:0) after 1m0s
[22:21:07.934] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:111:0)
[22:21:07.934] Timer tick, asking Buildbucket for the build status
[22:21:07.999] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:07.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:112:0) after 1m0s
[22:22:08.196] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:112:0)
[22:22:08.196] Timer tick, asking Buildbucket for the build status
[22:22:08.279] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:08.279] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:113:0) after 1m0s
[22:23:08.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:113:0)
[22:23:08.354] Timer tick, asking Buildbucket for the build status
[22:23:08.396] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:08.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:114:0) after 1m0s
[22:24:08.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:114:0)
[22:24:08.455] Timer tick, asking Buildbucket for the build status
[22:24:08.502] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:08.502] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:115:0) after 1m0s
[22:25:08.700] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:115:0)
[22:25:08.700] Timer tick, asking Buildbucket for the build status
[22:25:09.419] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:09.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:116:0) after 1m0s
[22:26:09.623] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:116:0)
[22:26:09.623] Timer tick, asking Buildbucket for the build status
[22:26:09.780] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:09.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:117:0) after 1m0s
[22:27:09.813] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:117:0)
[22:27:09.813] Timer tick, asking Buildbucket for the build status
[22:27:09.912] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:09.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:118:0) after 1m0s
[22:28:09.955] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:118:0)
[22:28:09.955] Timer tick, asking Buildbucket for the build status
[22:28:10.147] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:10.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:119:0) after 1m0s
[22:29:10.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:119:0)
[22:29:10.207] Timer tick, asking Buildbucket for the build status
[22:29:10.249] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:10.249] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:120:0) after 1m0s
[22:30:10.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:120:0)
[22:30:10.354] Timer tick, asking Buildbucket for the build status
[22:30:10.563] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:10.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:121:0) after 1m0s
[22:31:10.583] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:121:0)
[22:31:10.583] Timer tick, asking Buildbucket for the build status
[22:31:10.692] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:10.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:122:0) after 1m0s
[22:32:10.711] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:122:0)
[22:32:10.711] Timer tick, asking Buildbucket for the build status
[22:32:10.749] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:10.749] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:123:0) after 1m0s
[22:33:10.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:123:0)
[22:33:10.773] Timer tick, asking Buildbucket for the build status
[22:33:10.810] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:10.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:124:0) after 1m0s
[22:34:10.827] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:124:0)
[22:34:10.827] Timer tick, asking Buildbucket for the build status
[22:34:10.866] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:10.866] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:125:0) after 1m0s
[22:35:10.927] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:125:0)
[22:35:10.927] Timer tick, asking Buildbucket for the build status
[22:35:10.965] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:10.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:126:0) after 1m0s
[22:36:11.017] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:126:0)
[22:36:11.017] Timer tick, asking Buildbucket for the build status
[22:36:11.308] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:11.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:127:0) after 1m0s
[22:37:11.333] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:127:0)
[22:37:11.333] Timer tick, asking Buildbucket for the build status
[22:37:11.396] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:11.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:128:0) after 1m0s
[22:38:11.425] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:128:0)
[22:38:11.425] Timer tick, asking Buildbucket for the build status
[22:38:11.584] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:11.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:129:0) after 1m0s
[22:39:11.670] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:129:0)
[22:39:11.670] Timer tick, asking Buildbucket for the build status
[22:39:11.708] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:11.708] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:130:0) after 1m0s
[22:40:11.747] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:130:0)
[22:40:11.747] Timer tick, asking Buildbucket for the build status
[22:40:12.304] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:12.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:131:0) after 1m0s
[22:41:12.337] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:131:0)
[22:41:12.337] Timer tick, asking Buildbucket for the build status
[22:41:12.382] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:12.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:132:0) after 1m0s
[22:42:12.428] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:132:0)
[22:42:12.428] Timer tick, asking Buildbucket for the build status
[22:42:12.491] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:12.491] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:133:0) after 1m0s
[22:43:12.515] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:133:0)
[22:43:12.515] Timer tick, asking Buildbucket for the build status
[22:43:12.664] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:12.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:134:0) after 1m0s
[22:44:12.682] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:134:0)
[22:44:12.682] Timer tick, asking Buildbucket for the build status
[22:44:12.865] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:12.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:135:0) after 1m0s
[22:45:12.883] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:135:0)
[22:45:12.883] Timer tick, asking Buildbucket for the build status
[22:45:12.930] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:12.930] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:136:0) after 1m0s
[22:46:12.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:136:0)
[22:46:12.950] Timer tick, asking Buildbucket for the build status
[22:46:13.006] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:13.006] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:137:0) after 1m0s
[22:47:13.023] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:137:0)
[22:47:13.023] Timer tick, asking Buildbucket for the build status
[22:47:13.208] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:13.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:138:0) after 1m0s
[22:48:13.238] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:138:0)
[22:48:13.238] Timer tick, asking Buildbucket for the build status
[22:48:13.283] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:13.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:139:0) after 1m0s
[22:49:13.303] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:139:0)
[22:49:13.303] Timer tick, asking Buildbucket for the build status
[22:49:13.352] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:13.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:140:0) after 1m0s
[22:50:13.370] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:140:0)
[22:50:13.370] Timer tick, asking Buildbucket for the build status
[22:50:13.470] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:13.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:141:0) after 1m0s
[22:51:13.490] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:141:0)
[22:51:13.491] Timer tick, asking Buildbucket for the build status
[22:51:13.532] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:13.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:142:0) after 1m0s
[22:52:13.550] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:142:0)
[22:52:13.550] Timer tick, asking Buildbucket for the build status
[22:52:13.592] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:13.592] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:143:0) after 1m0s
[22:53:13.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:143:0)
[22:53:13.616] Timer tick, asking Buildbucket for the build status
[22:53:13.659] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:13.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:144:0) after 1m0s
[22:54:13.680] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:144:0)
[22:54:13.680] Timer tick, asking Buildbucket for the build status
[22:54:13.752] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:13.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:145:0) after 1m0s
[22:55:13.815] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:145:0)
[22:55:13.815] Timer tick, asking Buildbucket for the build status
[22:55:13.879] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:13.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:146:0) after 1m0s
[22:56:13.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:146:0)
[22:56:13.899] Timer tick, asking Buildbucket for the build status
[22:56:13.942] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:13.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:147:0) after 1m0s
[22:57:13.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:147:0)
[22:57:13.963] Timer tick, asking Buildbucket for the build status
[22:57:14.190] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:14.190] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:148:0) after 1m0s
[22:58:14.214] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:148:0)
[22:58:14.214] Timer tick, asking Buildbucket for the build status
[22:58:14.357] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:14.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:149:0) after 1m0s
[22:59:14.379] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:149:0)
[22:59:14.379] Timer tick, asking Buildbucket for the build status
[22:59:14.416] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:14.416] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:150:0) after 1m0s
[23:00:14.437] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:150:0)
[23:00:14.437] Timer tick, asking Buildbucket for the build status
[23:00:14.493] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:14.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:151:0) after 1m0s
[23:01:14.514] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:151:0)
[23:01:14.514] Timer tick, asking Buildbucket for the build status
[23:01:14.562] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:14.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:152:0) after 1m0s
[23:02:14.588] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:152:0)
[23:02:14.588] Timer tick, asking Buildbucket for the build status
[23:02:14.636] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:14.636] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:153:0) after 1m0s
[23:03:14.668] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:153:0)
[23:03:14.668] Timer tick, asking Buildbucket for the build status
[23:03:14.717] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:14.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:154:0) after 1m0s
[23:04:14.739] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:154:0)
[23:04:14.739] Timer tick, asking Buildbucket for the build status
[23:04:14.861] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:14.861] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:155:0) after 1m0s
[23:05:14.946] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:155:0)
[23:05:14.946] Timer tick, asking Buildbucket for the build status
[23:05:15.065] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:15.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:156:0) after 1m0s
[23:06:15.093] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:156:0)
[23:06:15.093] Timer tick, asking Buildbucket for the build status
[23:06:15.147] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:15.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:157:0) after 1m0s
[23:07:15.167] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:157:0)
[23:07:15.167] Timer tick, asking Buildbucket for the build status
[23:07:15.231] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:15.231] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:158:0) after 1m0s
[23:08:15.250] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:158:0)
[23:08:15.250] Timer tick, asking Buildbucket for the build status
[23:08:15.287] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:15.287] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:159:0) after 1m0s
[23:09:15.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:159:0)
[23:09:15.325] Timer tick, asking Buildbucket for the build status
[23:09:15.455] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:15.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:160:0) after 1m0s
[23:10:15.474] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:160:0)
[23:10:15.474] Timer tick, asking Buildbucket for the build status
[23:10:15.518] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:15.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:161:0) after 1m0s
[23:11:15.539] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:161:0)
[23:11:15.539] Timer tick, asking Buildbucket for the build status
[23:11:15.651] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:15.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:162:0) after 1m0s
[23:12:15.761] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:162:0)
[23:12:15.761] Timer tick, asking Buildbucket for the build status
[23:12:15.818] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:15.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:163:0) after 1m0s
[23:13:15.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:163:0)
[23:13:15.844] Timer tick, asking Buildbucket for the build status
[23:13:15.973] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:15.973] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:164:0) after 1m0s
[23:14:16.000] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:164:0)
[23:14:16.000] Timer tick, asking Buildbucket for the build status
[23:14:16.042] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:16.042] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:165:0) after 1m0s
[23:15:16.061] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:165:0)
[23:15:16.061] Timer tick, asking Buildbucket for the build status
[23:15:16.104] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:16.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:166:0) after 1m0s
[23:16:16.123] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:166:0)
[23:16:16.123] Timer tick, asking Buildbucket for the build status
[23:16:16.176] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:16.176] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:167:0) after 1m0s
[23:17:16.196] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:167:0)
[23:17:16.196] Timer tick, asking Buildbucket for the build status
[23:17:16.297] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:16.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:168:0) after 1m0s
[23:18:16.319] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:168:0)
[23:18:16.319] Timer tick, asking Buildbucket for the build status
[23:18:16.374] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:16.374] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:169:0) after 1m0s
[23:19:16.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:169:0)
[23:19:16.397] Timer tick, asking Buildbucket for the build status
[23:19:16.448] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:16.448] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:170:0) after 1m0s
[23:20:16.467] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:170:0)
[23:20:16.467] Timer tick, asking Buildbucket for the build status
[23:20:16.578] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:16.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:171:0) after 1m0s
[23:21:16.613] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:171:0)
[23:21:16.613] Timer tick, asking Buildbucket for the build status
[23:21:16.882] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:16.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:172:0) after 1m0s
[23:22:16.902] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:172:0)
[23:22:16.902] Timer tick, asking Buildbucket for the build status
[23:22:16.975] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:16.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:173:0) after 1m0s
[23:23:17.000] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:173:0)
[23:23:17.000] Timer tick, asking Buildbucket for the build status
[23:23:17.150] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:17.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:174:0) after 1m0s
[23:24:17.170] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:174:0)
[23:24:17.170] Timer tick, asking Buildbucket for the build status
[23:24:17.225] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:17.225] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:175:0) after 1m0s
[23:25:17.249] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:175:0)
[23:25:17.249] Timer tick, asking Buildbucket for the build status
[23:25:17.292] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:17.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:176:0) after 1m0s
[23:26:17.310] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:176:0)
[23:26:17.310] Timer tick, asking Buildbucket for the build status
[23:26:17.360] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:17.360] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:177:0) after 1m0s
[23:27:17.381] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:177:0)
[23:27:17.381] Timer tick, asking Buildbucket for the build status
[23:27:17.685] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:17.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:178:0) after 1m0s
[23:28:17.706] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:178:0)
[23:28:17.706] Timer tick, asking Buildbucket for the build status
[23:28:17.803] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:17.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:179:0) after 1m0s
[23:29:17.828] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:179:0)
[23:29:17.828] Timer tick, asking Buildbucket for the build status
[23:29:17.870] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:17.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:180:0) after 1m0s
[23:30:17.892] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:180:0)
[23:30:17.892] Timer tick, asking Buildbucket for the build status
[23:30:17.927] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:17.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:181:0) after 1m0s
[23:31:17.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:181:0)
[23:31:17.950] Timer tick, asking Buildbucket for the build status
[23:31:18.057] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:18.057] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:182:0) after 1m0s
[23:32:18.081] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:182:0)
[23:32:18.081] Timer tick, asking Buildbucket for the build status
[23:32:18.199] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:18.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:183:0) after 1m0s
[23:33:18.220] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:183:0)
[23:33:18.220] Timer tick, asking Buildbucket for the build status
[23:33:18.261] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:18.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:184:0) after 1m0s
[23:34:18.281] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:184:0)
[23:34:18.281] Timer tick, asking Buildbucket for the build status
[23:34:18.334] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:18.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:185:0) after 1m0s
[23:35:18.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:185:0)
[23:35:18.354] Timer tick, asking Buildbucket for the build status
[23:35:18.399] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:18.399] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:186:0) after 1m0s
[23:36:18.419] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:186:0)
[23:36:18.419] Timer tick, asking Buildbucket for the build status
[23:36:18.478] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:18.478] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:187:0) after 1m0s
[23:37:18.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:187:0)
[23:37:18.536] Timer tick, asking Buildbucket for the build status
[23:37:18.595] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:18.595] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:188:0) after 1m0s
[23:38:18.617] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:188:0)
[23:38:18.617] Timer tick, asking Buildbucket for the build status
[23:38:18.660] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:18.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:189:0) after 1m0s
[23:39:18.681] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:189:0)
[23:39:18.681] Timer tick, asking Buildbucket for the build status
[23:39:18.787] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:18.787] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:190:0) after 1m0s
[23:40:18.812] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:190:0)
[23:40:18.812] Timer tick, asking Buildbucket for the build status
[23:40:18.856] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:18.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:191:0) after 1m0s
[23:41:18.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:191:0)
[23:41:18.878] Timer tick, asking Buildbucket for the build status
[23:41:18.998] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:18.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:192:0) after 1m0s
[23:42:19.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:192:0)
[23:42:19.025] Timer tick, asking Buildbucket for the build status
[23:42:19.191] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:19.191] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:193:0) after 1m0s
[23:43:19.215] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:193:0)
[23:43:19.215] Timer tick, asking Buildbucket for the build status
[23:43:19.612] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:19.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:194:0) after 1m0s
[23:44:19.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:194:0)
[23:44:19.652] Timer tick, asking Buildbucket for the build status
[23:44:19.702] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:19.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:195:0) after 1m0s
[23:45:19.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:195:0)
[23:45:19.721] Timer tick, asking Buildbucket for the build status
[23:45:19.760] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:19.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:196:0) after 1m0s
[23:46:19.782] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:196:0)
[23:46:19.782] Timer tick, asking Buildbucket for the build status
[23:46:19.993] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:19.993] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:197:0) after 1m0s
[23:47:20.016] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:197:0)
[23:47:20.016] Timer tick, asking Buildbucket for the build status
[23:47:20.081] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:20.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:198:0) after 1m0s
[23:48:20.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:198:0)
[23:48:20.127] Timer tick, asking Buildbucket for the build status
[23:48:20.270] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:20.270] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:199:0) after 1m0s
[23:49:20.293] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:199:0)
[23:49:20.293] Timer tick, asking Buildbucket for the build status
[23:49:20.331] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:20.331] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:200:0) after 1m0s
[23:50:20.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:200:0)
[23:50:20.354] Timer tick, asking Buildbucket for the build status
[23:50:20.406] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:20.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:201:0) after 1m0s
[23:51:20.427] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:201:0)
[23:51:20.427] Timer tick, asking Buildbucket for the build status
[23:51:20.481] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:20.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:202:0) after 1m0s
[23:52:20.545] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:202:0)
[23:52:20.545] Timer tick, asking Buildbucket for the build status
[23:52:20.640] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:20.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:203:0) after 1m0s
[23:53:20.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:203:0)
[23:53:20.663] Timer tick, asking Buildbucket for the build status
[23:53:20.721] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:20.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:204:0) after 1m0s
[23:54:20.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:204:0)
[23:54:20.749] Timer tick, asking Buildbucket for the build status
[23:54:20.793] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:20.793] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:205:0) after 1m0s
[23:55:20.816] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:205:0)
[23:55:20.816] Timer tick, asking Buildbucket for the build status
[23:55:20.981] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:20.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:206:0) after 1m0s
[23:56:21.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:206:0)
[23:56:21.001] Timer tick, asking Buildbucket for the build status
[23:56:21.041] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:21.041] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:207:0) after 1m0s
[23:57:21.062] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:207:0)
[23:57:21.062] Timer tick, asking Buildbucket for the build status
[23:57:21.146] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:21.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:208:0) after 1m0s
[23:58:21.168] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:208:0)
[23:58:21.168] Timer tick, asking Buildbucket for the build status
[23:58:21.216] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:21.216] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:209:0) after 1m0s
[23:59:21.237] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:209:0)
[23:59:21.237] Timer tick, asking Buildbucket for the build status
[23:59:21.275] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:21.275] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:210:0) after 1m0s
[00:00:21.342] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:210:0)
[00:00:21.342] Timer tick, asking Buildbucket for the build status
[00:00:21.447] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:21.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:211:0) after 1m0s
[00:01:21.485] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:211:0)
[00:01:21.485] Timer tick, asking Buildbucket for the build status
[00:01:21.526] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:21.526] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:212:0) after 1m0s
[00:02:21.566] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:212:0)
[00:02:21.566] Timer tick, asking Buildbucket for the build status
[00:02:21.616] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:21.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:213:0) after 1m0s
[00:03:21.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:213:0)
[00:03:21.652] Timer tick, asking Buildbucket for the build status
[00:03:21.769] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:21.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:214:0) after 1m0s
[00:04:21.794] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:214:0)
[00:04:21.794] Timer tick, asking Buildbucket for the build status
[00:04:21.833] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:21.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:215:0) after 1m0s
[00:05:21.856] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:215:0)
[00:05:21.856] Timer tick, asking Buildbucket for the build status
[00:05:22.033] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:22.033] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:216:0) after 1m0s
[00:06:22.065] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:216:0)
[00:06:22.065] Timer tick, asking Buildbucket for the build status
[00:06:22.127] Build 8921516067033525632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:22.127] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9086946129230809104:217:0) after 1m0s
[00:06:42.730] Received PubSub notification, asking Buildbucket for the build status
[00:06:42.767] Build 8921516067033525632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:06:42.767] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1550189201576429",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1550176285672749",
    "id": "8921516067033525632",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"15362ac60573769f6606ab1d1c11668052e411a7\"}}",
    "project": "nacl",
    "result": "SUCCESS",
    "result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"4098-34330fc\"], \"machine_type\": [\"n1-standard-16\"], \"gpu\": [\"none\"], \"cores\": [\"16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-16-145e5bab-us-west1-c-d756\"], \"pool\": [\"luci.nacl.toolchain\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"Failure LLVM Regression\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 7027, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"linux-pnacl-x86_64\", \"key\": \"builder\"}, {\"value\": \"commit/git/15362ac60573769f6606ab1d1c11668052e411a7\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/15362ac60573769f6606ab1d1c11668052e411a7\", \"key\": \"buildset\"}, {\"value\": \"9086946129230809104\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"nacl/linux-pnacl-x86_64\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"nacl\", \"builder\": \"linux-pnacl-x86_64\", \"bucket\": \"toolchain\"}, \"number\": 7027, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"85e01437f26ff37dc358ef303d841313756fe1f8\"}, \"recipe\": {\"name\": \"nacl\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"id\": \"8921516067033525632\", \"input\": {\"gitilesCommit\": {\"project\": \"native_client/src/native_client\", \"host\": \"chromium.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"15362ac60573769f6606ab1d1c11668052e411a7\"}}, \"createTime\": \"2019-02-14T20:31:25.672749Z\"}}, \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"buildername\": \"linux-pnacl-x86_64\", \"got_revision\": \"15362ac60573769f6606ab1d1c11668052e411a7\", \"recipe\": \"nacl\", \"mastername\": \"client.nacl.toolchain\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1550176285672749, \"tags\": [\"build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7027\", \"builder:linux-pnacl-x86_64\", \"buildset:commit/git/15362ac60573769f6606ab1d1c11668052e411a7\", \"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/15362ac60573769f6606ab1d1c11668052e411a7\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9086946129230809104\", \"scheduler_job_id:nacl/linux-pnacl-x86_64\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.nacl.toolchain\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"nacl\", \"id\": \"8921516067033525632\"}}, \"slavetype\": \"BuilderTester\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"15362ac60573769f6606ab1d1c11668052e411a7\", \"bot_id\": \"gce-trusty-16-145e5bab-us-west1-c-d756\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1550176302252641",
    "status": "COMPLETED",
    "status_changed_ts": "1550189202331882",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7027",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/15362ac60573769f6606ab1d1c11668052e411a7",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/15362ac60573769f6606ab1d1c11668052e411a7",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9086946129230809104",
      "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/8921516067033525632/+/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:4306867ec8a35310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1550189202333681",
    "url": "https://ci.chromium.org/b/8921516067033525632",
    "utcnow_ts": "1550189202758054"
  }
}
[00:06:42.767] Invocation finished in 3h35m18.574304448s with status SUCCEEDED