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

• 17af1e818981ebf2c492a678d4d31c9e1ee37fc7 (6 years ago)

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

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

[18:49:20.150] New invocation is queued and will start shortly
[18:49:21.437] Starting the invocation (attempt 1)
[18:49:21.494] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:49:21.494] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:49:21.494] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9093384935386820976",
  "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\":\"17af1e818981ebf2c492a678d4d31c9e1ee37fc7\"}}",
  "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:9093384935386820976",
    "scheduler_job_id:nacl/linux-pnacl-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
    "gitiles_ref:refs/heads/master"
  ]
}
[18:49:22.916] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1544035761581289",
    "id": "8927954873222543744",
    "lease_expiration_ts": "1544154562400856",
    "lease_key": "1298978531",
    "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\": \"17af1e818981ebf2c492a678d4d31c9e1ee37fc7\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1544035762736497",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7003",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9093384935386820976",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_dimension:caches:builder_eacc41f1df5d043e03eef0198bc8ddecd24b0492a666afd70585f546f0146c16_v2",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7003",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8927954873222543744",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:2f19301aebbc779351dc95ab1dc03603fa761240",
      "swarming_tag:builder:linux-pnacl-x86_64",
      "swarming_tag:buildset:commit/git/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
      "swarming_tag:caches:builder_eacc41f1df5d043e03eef0198bc8ddecd24b0492a666afd70585f546f0146c16_v2",
      "swarming_tag:cores:8",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8927954873222543744/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9093384935386820976",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:7be98d3a655353173e6c69dca4a3f5562afcd673",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:41988587836a9b10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1544035762737485",
    "url": "https://ci.chromium.org/b/8927954873222543744",
    "utcnow_ts": "1544035762899004"
  }
}
[18:49:22.916] Task URL: https://ci.chromium.org/b/8927954873222543744
[18:49:22.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:2:0) after 1m0s
[18:50:05.007] Received PubSub notification, asking Buildbucket for the build status
[18:50:05.109] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:22.965] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:2:0)
[18:50:22.965] Timer tick, asking Buildbucket for the build status
[18:50:23.007] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:23.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:4:0) after 1m0s
[18:51:23.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:4:0)
[18:51:23.025] Timer tick, asking Buildbucket for the build status
[18:51:23.112] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:23.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:5:0) after 1m0s
[18:52:23.137] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:5:0)
[18:52:23.137] Timer tick, asking Buildbucket for the build status
[18:52:23.209] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:23.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:6:0) after 1m0s
[18:53:23.240] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:6:0)
[18:53:23.240] Timer tick, asking Buildbucket for the build status
[18:53:23.315] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:23.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:7:0) after 1m0s
[18:54:23.422] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:7:0)
[18:54:23.422] Timer tick, asking Buildbucket for the build status
[18:54:23.555] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:23.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:8:0) after 1m0s
[18:55:23.600] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:8:0)
[18:55:23.600] Timer tick, asking Buildbucket for the build status
[18:55:23.732] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:23.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:9:0) after 1m0s
[18:56:23.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:9:0)
[18:56:23.749] Timer tick, asking Buildbucket for the build status
[18:56:23.789] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:23.789] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:10:0) after 1m0s
[18:57:23.818] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:10:0)
[18:57:23.818] Timer tick, asking Buildbucket for the build status
[18:57:23.968] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:23.968] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:11:0) after 1m0s
[18:58:23.986] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:11:0)
[18:58:23.986] Timer tick, asking Buildbucket for the build status
[18:58:24.163] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:24.163] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:12:0) after 1m0s
[18:59:24.182] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:12:0)
[18:59:24.182] Timer tick, asking Buildbucket for the build status
[18:59:24.242] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:24.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:13:0) after 1m0s
[19:00:24.293] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:13:0)
[19:00:24.293] Timer tick, asking Buildbucket for the build status
[19:00:24.445] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:24.445] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:14:0) after 1m0s
[19:01:24.471] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:14:0)
[19:01:24.471] Timer tick, asking Buildbucket for the build status
[19:01:24.719] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:24.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:15:0) after 1m0s
[19:02:24.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:15:0)
[19:02:24.740] Timer tick, asking Buildbucket for the build status
[19:02:24.875] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:24.875] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:16:0) after 1m0s
[19:03:24.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:16:0)
[19:03:24.894] Timer tick, asking Buildbucket for the build status
[19:03:24.965] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:24.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:17:0) after 1m0s
[19:04:24.986] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:17:0)
[19:04:24.986] Timer tick, asking Buildbucket for the build status
[19:04:25.169] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:25.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:18:0) after 1m0s
[19:05:25.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:18:0)
[19:05:25.185] Timer tick, asking Buildbucket for the build status
[19:05:25.233] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:25.233] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:19:0) after 1m0s
[19:06:25.249] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:19:0)
[19:06:25.249] Timer tick, asking Buildbucket for the build status
[19:06:25.510] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:25.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:20:0) after 1m0s
[19:07:25.596] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:20:0)
[19:07:25.597] Timer tick, asking Buildbucket for the build status
[19:07:25.771] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:25.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:21:0) after 1m0s
[19:08:25.798] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:21:0)
[19:08:25.798] Timer tick, asking Buildbucket for the build status
[19:08:25.911] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:25.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:22:0) after 1m0s
[19:09:25.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:22:0)
[19:09:25.969] Timer tick, asking Buildbucket for the build status
[19:09:26.067] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:26.067] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:23:0) after 1m0s
[19:10:26.094] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:23:0)
[19:10:26.094] Timer tick, asking Buildbucket for the build status
[19:10:26.171] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:26.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:24:0) after 1m0s
[19:11:26.225] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:24:0)
[19:11:26.225] Timer tick, asking Buildbucket for the build status
[19:11:26.297] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:26.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:25:0) after 1m0s
[19:12:26.346] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:25:0)
[19:12:26.346] Timer tick, asking Buildbucket for the build status
[19:12:26.418] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:26.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:26:0) after 1m0s
[19:13:26.492] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:26:0)
[19:13:26.492] Timer tick, asking Buildbucket for the build status
[19:13:26.544] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:26.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:27:0) after 1m0s
[19:14:26.562] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:27:0)
[19:14:26.562] Timer tick, asking Buildbucket for the build status
[19:14:26.688] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:26.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:28:0) after 1m0s
[19:15:26.709] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:28:0)
[19:15:26.709] Timer tick, asking Buildbucket for the build status
[19:15:26.767] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:26.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:29:0) after 1m0s
[19:16:26.794] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:29:0)
[19:16:26.794] Timer tick, asking Buildbucket for the build status
[19:16:27.152] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:27.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:30:0) after 1m0s
[19:17:27.200] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:30:0)
[19:17:27.200] Timer tick, asking Buildbucket for the build status
[19:17:27.358] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:27.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:31:0) after 1m0s
[19:18:27.374] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:31:0)
[19:18:27.374] Timer tick, asking Buildbucket for the build status
[19:18:27.430] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:27.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:32:0) after 1m0s
[19:19:27.468] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:32:0)
[19:19:27.468] Timer tick, asking Buildbucket for the build status
[19:19:27.523] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:27.523] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:33:0) after 1m0s
[19:20:27.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:33:0)
[19:20:27.553] Timer tick, asking Buildbucket for the build status
[19:20:27.876] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:27.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:34:0) after 1m0s
[19:21:27.940] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:34:0)
[19:21:27.940] Timer tick, asking Buildbucket for the build status
[19:21:28.015] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:28.015] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:35:0) after 1m0s
[19:22:28.036] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:35:0)
[19:22:28.036] Timer tick, asking Buildbucket for the build status
[19:22:28.134] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:28.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:36:0) after 1m0s
[19:23:28.219] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:36:0)
[19:23:28.219] Timer tick, asking Buildbucket for the build status
[19:23:28.329] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:28.329] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:37:0) after 1m0s
[19:24:28.346] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:37:0)
[19:24:28.346] Timer tick, asking Buildbucket for the build status
[19:24:28.520] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:28.520] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:38:0) after 1m0s
[19:25:28.548] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:38:0)
[19:25:28.548] Timer tick, asking Buildbucket for the build status
[19:25:28.819] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:28.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:39:0) after 1m0s
[19:26:28.836] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:39:0)
[19:26:28.836] Timer tick, asking Buildbucket for the build status
[19:26:28.948] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:28.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:40:0) after 1m0s
[19:27:28.963] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:40:0)
[19:27:28.963] Timer tick, asking Buildbucket for the build status
[19:27:29.026] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:29.026] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:41:0) after 1m0s
[19:28:29.045] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:41:0)
[19:28:29.045] Timer tick, asking Buildbucket for the build status
[19:28:29.188] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:29.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:42:0) after 1m0s
[19:29:29.206] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:42:0)
[19:29:29.206] Timer tick, asking Buildbucket for the build status
[19:29:29.326] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:29.326] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:43:0) after 1m0s
[19:30:29.342] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:43:0)
[19:30:29.342] Timer tick, asking Buildbucket for the build status
[19:30:29.446] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:29.446] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:44:0) after 1m0s
[19:31:29.463] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:44:0)
[19:31:29.463] Timer tick, asking Buildbucket for the build status
[19:31:29.493] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:29.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:45:0) after 1m0s
[19:32:29.523] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:45:0)
[19:32:29.523] Timer tick, asking Buildbucket for the build status
[19:32:30.047] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:30.047] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:46:0) after 1m0s
[19:33:30.101] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:46:0)
[19:33:30.101] Timer tick, asking Buildbucket for the build status
[19:33:30.139] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:30.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:47:0) after 1m0s
[19:34:30.308] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:47:0)
[19:34:30.308] Timer tick, asking Buildbucket for the build status
[19:34:30.609] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:30.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:48:0) after 1m0s
[19:35:30.624] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:48:0)
[19:35:30.624] Timer tick, asking Buildbucket for the build status
[19:35:30.659] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:30.659] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:49:0) after 1m0s
[19:36:30.767] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:49:0)
[19:36:30.767] Timer tick, asking Buildbucket for the build status
[19:36:30.809] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:30.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:50:0) after 1m0s
[19:37:30.828] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:50:0)
[19:37:30.828] Timer tick, asking Buildbucket for the build status
[19:37:31.029] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:31.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:51:0) after 1m0s
[19:38:31.045] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:51:0)
[19:38:31.045] Timer tick, asking Buildbucket for the build status
[19:38:31.104] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:31.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:52:0) after 1m0s
[19:39:31.121] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:52:0)
[19:39:31.121] Timer tick, asking Buildbucket for the build status
[19:39:31.156] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:31.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:53:0) after 1m0s
[19:40:31.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:53:0)
[19:40:31.217] Timer tick, asking Buildbucket for the build status
[19:40:31.257] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:31.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:54:0) after 1m0s
[19:41:31.274] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:54:0)
[19:41:31.274] Timer tick, asking Buildbucket for the build status
[19:41:31.312] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:31.312] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:55:0) after 1m0s
[19:42:31.342] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:55:0)
[19:42:31.342] Timer tick, asking Buildbucket for the build status
[19:42:31.444] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:31.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:56:0) after 1m0s
[19:43:31.461] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:56:0)
[19:43:31.461] Timer tick, asking Buildbucket for the build status
[19:43:31.585] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:31.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:57:0) after 1m0s
[19:44:31.614] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:57:0)
[19:44:31.614] Timer tick, asking Buildbucket for the build status
[19:44:31.950] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:31.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:58:0) after 1m0s
[19:45:31.968] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:58:0)
[19:45:31.968] Timer tick, asking Buildbucket for the build status
[19:45:32.005] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:32.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:59:0) after 1m0s
[19:46:32.028] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:59:0)
[19:46:32.028] Timer tick, asking Buildbucket for the build status
[19:46:32.174] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:32.174] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:60:0) after 1m0s
[19:47:32.192] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:60:0)
[19:47:32.192] Timer tick, asking Buildbucket for the build status
[19:47:32.226] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:32.226] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:61:0) after 1m0s
[19:48:32.245] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:61:0)
[19:48:32.245] Timer tick, asking Buildbucket for the build status
[19:48:32.532] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:32.532] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:62:0) after 1m0s
[19:49:32.551] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:62:0)
[19:49:32.551] Timer tick, asking Buildbucket for the build status
[19:49:32.590] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:32.590] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:63:0) after 1m0s
[19:50:32.612] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:63:0)
[19:50:32.612] Timer tick, asking Buildbucket for the build status
[19:50:32.675] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:32.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:64:0) after 1m0s
[19:51:32.766] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:64:0)
[19:51:32.766] Timer tick, asking Buildbucket for the build status
[19:51:32.807] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:32.807] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:65:0) after 1m0s
[19:52:32.854] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:65:0)
[19:52:32.854] Timer tick, asking Buildbucket for the build status
[19:52:32.903] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:32.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:66:0) after 1m0s
[19:53:32.951] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:66:0)
[19:53:32.951] Timer tick, asking Buildbucket for the build status
[19:53:33.013] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:33.013] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:67:0) after 1m0s
[19:54:33.028] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:67:0)
[19:54:33.028] Timer tick, asking Buildbucket for the build status
[19:54:33.062] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:33.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:68:0) after 1m0s
[19:55:33.098] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:68:0)
[19:55:33.098] Timer tick, asking Buildbucket for the build status
[19:55:33.132] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:33.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:69:0) after 1m0s
[19:56:33.182] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:69:0)
[19:56:33.182] Timer tick, asking Buildbucket for the build status
[19:56:33.371] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:33.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:70:0) after 1m0s
[19:57:33.389] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:70:0)
[19:57:33.389] Timer tick, asking Buildbucket for the build status
[19:57:33.439] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:33.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:71:0) after 1m0s
[19:58:33.457] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:71:0)
[19:58:33.457] Timer tick, asking Buildbucket for the build status
[19:58:33.518] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:33.518] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:72:0) after 1m0s
[19:59:33.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:72:0)
[19:59:33.536] Timer tick, asking Buildbucket for the build status
[19:59:33.604] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:33.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:73:0) after 1m0s
[20:00:33.628] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:73:0)
[20:00:33.628] Timer tick, asking Buildbucket for the build status
[20:00:33.669] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:33.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:74:0) after 1m0s
[20:01:33.690] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:74:0)
[20:01:33.690] Timer tick, asking Buildbucket for the build status
[20:01:33.737] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:33.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:75:0) after 1m0s
[20:02:33.774] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:75:0)
[20:02:33.774] Timer tick, asking Buildbucket for the build status
[20:02:33.822] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:33.822] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:76:0) after 1m0s
[20:03:33.867] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:76:0)
[20:03:33.867] Timer tick, asking Buildbucket for the build status
[20:03:33.949] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:33.949] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:77:0) after 1m0s
[20:04:33.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:77:0)
[20:04:33.969] Timer tick, asking Buildbucket for the build status
[20:04:34.036] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:34.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:78:0) after 1m0s
[20:05:34.056] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:78:0)
[20:05:34.056] Timer tick, asking Buildbucket for the build status
[20:05:34.147] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:34.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:79:0) after 1m0s
[20:06:34.163] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:79:0)
[20:06:34.163] Timer tick, asking Buildbucket for the build status
[20:06:34.204] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:34.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:80:0) after 1m0s
[20:07:34.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:80:0)
[20:07:34.300] Timer tick, asking Buildbucket for the build status
[20:07:34.378] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:34.378] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:81:0) after 1m0s
[20:08:34.452] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:81:0)
[20:08:34.452] Timer tick, asking Buildbucket for the build status
[20:08:34.552] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:34.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:82:0) after 1m0s
[20:09:34.588] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:82:0)
[20:09:34.588] Timer tick, asking Buildbucket for the build status
[20:09:34.666] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:34.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:83:0) after 1m0s
[20:10:34.685] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:83:0)
[20:10:34.685] Timer tick, asking Buildbucket for the build status
[20:10:34.748] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:34.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:84:0) after 1m0s
[20:11:34.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:84:0)
[20:11:34.773] Timer tick, asking Buildbucket for the build status
[20:11:34.834] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:34.834] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:85:0) after 1m0s
[20:12:34.862] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:85:0)
[20:12:34.862] Timer tick, asking Buildbucket for the build status
[20:12:34.916] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:34.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:86:0) after 1m0s
[20:13:34.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:86:0)
[20:13:34.969] Timer tick, asking Buildbucket for the build status
[20:13:35.039] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:35.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:87:0) after 1m0s
[20:14:35.066] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:87:0)
[20:14:35.066] Timer tick, asking Buildbucket for the build status
[20:14:35.155] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:35.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:88:0) after 1m0s
[20:15:35.179] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:88:0)
[20:15:35.179] Timer tick, asking Buildbucket for the build status
[20:15:35.252] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:35.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:89:0) after 1m0s
[20:16:35.334] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:89:0)
[20:16:35.335] Timer tick, asking Buildbucket for the build status
[20:16:35.397] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:35.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:90:0) after 1m0s
[20:17:35.436] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:90:0)
[20:17:35.436] Timer tick, asking Buildbucket for the build status
[20:17:35.489] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:35.489] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:91:0) after 1m0s
[20:18:35.514] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:91:0)
[20:18:35.514] Timer tick, asking Buildbucket for the build status
[20:18:35.616] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:35.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:92:0) after 1m0s
[20:19:35.631] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:92:0)
[20:19:35.631] Timer tick, asking Buildbucket for the build status
[20:19:35.727] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:35.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:93:0) after 1m0s
[20:20:35.745] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:93:0)
[20:20:35.745] Timer tick, asking Buildbucket for the build status
[20:20:35.803] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:35.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:94:0) after 1m0s
[20:21:35.820] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:94:0)
[20:21:35.820] Timer tick, asking Buildbucket for the build status
[20:21:35.923] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:35.923] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:95:0) after 1m0s
[20:22:35.947] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:95:0)
[20:22:35.947] Timer tick, asking Buildbucket for the build status
[20:22:36.075] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:36.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:96:0) after 1m0s
[20:23:36.114] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:96:0)
[20:23:36.114] Timer tick, asking Buildbucket for the build status
[20:23:36.242] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:36.242] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:97:0) after 1m0s
[20:24:36.270] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:97:0)
[20:24:36.270] Timer tick, asking Buildbucket for the build status
[20:24:36.410] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:36.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:98:0) after 1m0s
[20:25:36.437] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:98:0)
[20:25:36.437] Timer tick, asking Buildbucket for the build status
[20:25:36.540] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:36.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:99:0) after 1m0s
[20:26:36.571] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:99:0)
[20:26:36.571] Timer tick, asking Buildbucket for the build status
[20:26:36.647] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:36.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:100:0) after 1m0s
[20:27:36.664] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:100:0)
[20:27:36.664] Timer tick, asking Buildbucket for the build status
[20:27:36.827] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:36.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:101:0) after 1m0s
[20:28:36.858] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:101:0)
[20:28:36.858] Timer tick, asking Buildbucket for the build status
[20:28:37.019] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:37.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:102:0) after 1m0s
[20:29:37.037] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:102:0)
[20:29:37.037] Timer tick, asking Buildbucket for the build status
[20:29:37.099] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:37.099] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:103:0) after 1m0s
[20:30:37.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:103:0)
[20:30:37.119] Timer tick, asking Buildbucket for the build status
[20:30:37.214] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:37.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:104:0) after 1m0s
[20:31:37.229] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:104:0)
[20:31:37.229] Timer tick, asking Buildbucket for the build status
[20:31:37.282] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:37.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:105:0) after 1m0s
[20:34:44.091] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:105:0)
[20:34:44.091] Timer tick, asking Buildbucket for the build status
[20:34:44.173] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:44.173] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:106:0) after 1m0s
[20:35:44.192] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:106:0)
[20:35:44.192] Timer tick, asking Buildbucket for the build status
[20:35:44.247] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:44.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:107:0) after 1m0s
[20:36:44.274] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:107:0)
[20:36:44.274] Timer tick, asking Buildbucket for the build status
[20:36:44.459] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:44.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:108:0) after 1m0s
[20:37:44.480] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:108:0)
[20:37:44.480] Timer tick, asking Buildbucket for the build status
[20:37:44.571] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:44.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:109:0) after 1m0s
[20:38:44.703] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:109:0)
[20:38:44.703] Timer tick, asking Buildbucket for the build status
[20:38:44.814] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:44.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:110:0) after 1m0s
[20:39:44.845] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:110:0)
[20:39:44.845] Timer tick, asking Buildbucket for the build status
[20:39:44.902] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:44.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:111:0) after 1m0s
[20:40:44.990] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:111:0)
[20:40:44.990] Timer tick, asking Buildbucket for the build status
[20:40:45.025] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:45.025] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:112:0) after 1m0s
[20:41:45.046] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:112:0)
[20:41:45.046] Timer tick, asking Buildbucket for the build status
[20:41:45.159] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:45.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:113:0) after 1m0s
[20:42:45.179] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:113:0)
[20:42:45.179] Timer tick, asking Buildbucket for the build status
[20:42:45.258] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:45.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:114:0) after 1m0s
[20:43:45.298] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:114:0)
[20:43:45.298] Timer tick, asking Buildbucket for the build status
[20:43:45.454] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:45.454] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:115:0) after 1m0s
[20:44:45.481] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:115:0)
[20:44:45.481] Timer tick, asking Buildbucket for the build status
[20:44:45.514] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:45.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:116:0) after 1m0s
[20:45:45.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:116:0)
[20:45:45.536] Timer tick, asking Buildbucket for the build status
[20:45:45.598] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:45.598] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:117:0) after 1m0s
[20:46:45.620] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:117:0)
[20:46:45.620] Timer tick, asking Buildbucket for the build status
[20:46:45.802] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:45.802] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:118:0) after 1m0s
[20:47:45.824] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:118:0)
[20:47:45.824] Timer tick, asking Buildbucket for the build status
[20:47:46.005] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:46.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:119:0) after 1m0s
[20:48:46.030] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:119:0)
[20:48:46.031] Timer tick, asking Buildbucket for the build status
[20:48:46.112] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:46.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:120:0) after 1m0s
[20:49:46.172] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:120:0)
[20:49:46.172] Timer tick, asking Buildbucket for the build status
[20:49:46.218] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:46.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:121:0) after 1m0s
[20:50:46.239] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:121:0)
[20:50:46.239] Timer tick, asking Buildbucket for the build status
[20:50:46.391] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:46.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:122:0) after 1m0s
[20:51:46.419] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:122:0)
[20:51:46.419] Timer tick, asking Buildbucket for the build status
[20:51:46.550] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:46.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:123:0) after 1m0s
[20:52:46.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:123:0)
[20:52:46.587] Timer tick, asking Buildbucket for the build status
[20:52:46.643] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:46.643] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:124:0) after 1m0s
[20:53:46.665] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:124:0)
[20:53:46.665] Timer tick, asking Buildbucket for the build status
[20:53:46.703] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:46.703] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:125:0) after 1m0s
[20:54:46.750] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:125:0)
[20:54:46.750] Timer tick, asking Buildbucket for the build status
[20:54:46.962] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:46.962] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:126:0) after 1m0s
[20:55:47.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:126:0)
[20:55:47.032] Timer tick, asking Buildbucket for the build status
[20:55:47.103] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:47.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:127:0) after 1m0s
[20:56:47.136] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:127:0)
[20:56:47.136] Timer tick, asking Buildbucket for the build status
[20:56:47.244] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:47.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:128:0) after 1m0s
[20:57:47.266] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:128:0)
[20:57:47.266] Timer tick, asking Buildbucket for the build status
[20:57:47.435] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:47.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:129:0) after 1m0s
[20:58:47.460] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:129:0)
[20:58:47.460] Timer tick, asking Buildbucket for the build status
[20:58:47.566] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:47.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:130:0) after 1m0s
[20:59:47.586] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:130:0)
[20:59:47.586] Timer tick, asking Buildbucket for the build status
[20:59:47.717] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:47.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:131:0) after 1m0s
[21:00:47.737] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:131:0)
[21:00:47.737] Timer tick, asking Buildbucket for the build status
[21:00:47.816] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:47.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:132:0) after 1m0s
[21:01:47.840] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:132:0)
[21:01:47.840] Timer tick, asking Buildbucket for the build status
[21:01:47.890] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:47.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:133:0) after 1m0s
[21:02:47.940] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:133:0)
[21:02:47.940] Timer tick, asking Buildbucket for the build status
[21:02:48.252] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:48.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:134:0) after 1m0s
[21:03:48.276] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:134:0)
[21:03:48.276] Timer tick, asking Buildbucket for the build status
[21:03:48.411] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:48.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:135:0) after 1m0s
[21:04:48.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:135:0)
[21:04:48.438] Timer tick, asking Buildbucket for the build status
[21:04:48.652] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:48.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:136:0) after 1m0s
[21:05:48.680] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:136:0)
[21:05:48.680] Timer tick, asking Buildbucket for the build status
[21:05:48.840] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:48.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:137:0) after 1m0s
[21:06:48.859] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:137:0)
[21:06:48.859] Timer tick, asking Buildbucket for the build status
[21:06:48.917] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:48.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:138:0) after 1m0s
[21:07:48.945] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:138:0)
[21:07:48.945] Timer tick, asking Buildbucket for the build status
[21:07:49.024] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:49.024] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:139:0) after 1m0s
[21:08:49.046] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:139:0)
[21:08:49.046] Timer tick, asking Buildbucket for the build status
[21:08:49.375] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:49.375] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:140:0) after 1m0s
[21:09:49.395] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:140:0)
[21:09:49.395] Timer tick, asking Buildbucket for the build status
[21:09:49.519] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:49.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:141:0) after 1m0s
[21:10:49.543] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:141:0)
[21:10:49.543] Timer tick, asking Buildbucket for the build status
[21:10:49.608] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:49.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:142:0) after 1m0s
[21:11:49.630] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:142:0)
[21:11:49.630] Timer tick, asking Buildbucket for the build status
[21:11:49.892] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:49.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:143:0) after 1m0s
[21:12:49.914] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:143:0)
[21:12:49.914] Timer tick, asking Buildbucket for the build status
[21:12:49.945] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:49.945] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:144:0) after 1m0s
[21:13:49.970] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:144:0)
[21:13:49.970] Timer tick, asking Buildbucket for the build status
[21:13:50.006] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:50.006] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:145:0) after 1m0s
[21:14:50.056] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:145:0)
[21:14:50.056] Timer tick, asking Buildbucket for the build status
[21:14:50.182] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:50.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:146:0) after 1m0s
[21:15:50.210] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:146:0)
[21:15:50.210] Timer tick, asking Buildbucket for the build status
[21:15:50.248] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:50.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:147:0) after 1m0s
[21:16:50.273] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:147:0)
[21:16:50.273] Timer tick, asking Buildbucket for the build status
[21:16:50.407] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:50.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:148:0) after 1m0s
[21:17:50.427] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:148:0)
[21:17:50.427] Timer tick, asking Buildbucket for the build status
[21:17:50.587] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:50.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:149:0) after 1m0s
[21:18:50.607] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:149:0)
[21:18:50.607] Timer tick, asking Buildbucket for the build status
[21:18:50.658] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:50.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:150:0) after 1m0s
[21:19:50.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:150:0)
[21:19:50.755] Timer tick, asking Buildbucket for the build status
[21:19:50.788] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:50.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:151:0) after 1m0s
[21:20:50.824] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:151:0)
[21:20:50.824] Timer tick, asking Buildbucket for the build status
[21:20:50.946] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:50.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:152:0) after 1m0s
[21:21:50.979] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:152:0)
[21:21:50.979] Timer tick, asking Buildbucket for the build status
[21:21:51.046] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:51.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:153:0) after 1m0s
[21:22:51.081] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:153:0)
[21:22:51.081] Timer tick, asking Buildbucket for the build status
[21:22:51.123] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:51.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:154:0) after 1m0s
[21:23:51.164] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:154:0)
[21:23:51.164] Timer tick, asking Buildbucket for the build status
[21:23:51.239] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:51.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:155:0) after 1m0s
[21:24:51.258] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:155:0)
[21:24:51.258] Timer tick, asking Buildbucket for the build status
[21:24:51.381] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:51.381] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:156:0) after 1m0s
[21:25:51.431] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:156:0)
[21:25:51.431] Timer tick, asking Buildbucket for the build status
[21:25:51.465] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:51.466] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:157:0) after 1m0s
[21:26:51.533] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:157:0)
[21:26:51.533] Timer tick, asking Buildbucket for the build status
[21:26:51.611] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:51.611] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:158:0) after 1m0s
[21:27:51.633] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:158:0)
[21:27:51.633] Timer tick, asking Buildbucket for the build status
[21:27:51.688] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:51.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:159:0) after 1m0s
[21:28:51.708] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:159:0)
[21:28:51.708] Timer tick, asking Buildbucket for the build status
[21:28:51.836] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:51.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:160:0) after 1m0s
[21:29:51.873] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:160:0)
[21:29:51.873] Timer tick, asking Buildbucket for the build status
[21:29:51.903] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:51.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:161:0) after 1m0s
[21:30:51.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:161:0)
[21:30:51.962] Timer tick, asking Buildbucket for the build status
[21:30:52.103] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:52.103] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:162:0) after 1m0s
[21:31:52.123] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:162:0)
[21:31:52.123] Timer tick, asking Buildbucket for the build status
[21:31:52.168] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:52.168] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:163:0) after 1m0s
[21:32:52.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:163:0)
[21:32:52.202] Timer tick, asking Buildbucket for the build status
[21:32:52.281] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:52.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:164:0) after 1m0s
[21:33:52.305] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:164:0)
[21:33:52.305] Timer tick, asking Buildbucket for the build status
[21:33:52.470] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:52.471] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:165:0) after 1m0s
[21:34:52.549] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:165:0)
[21:34:52.549] Timer tick, asking Buildbucket for the build status
[21:34:52.591] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:52.591] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:166:0) after 1m0s
[21:35:52.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:166:0)
[21:35:52.616] Timer tick, asking Buildbucket for the build status
[21:35:52.724] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:52.724] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:167:0) after 1m0s
[21:36:52.754] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:167:0)
[21:36:52.754] Timer tick, asking Buildbucket for the build status
[21:36:52.836] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:52.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:168:0) after 1m0s
[21:37:52.970] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:168:0)
[21:37:52.970] Timer tick, asking Buildbucket for the build status
[21:37:53.071] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:53.071] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:169:0) after 1m0s
[21:38:53.179] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:169:0)
[21:38:53.179] Timer tick, asking Buildbucket for the build status
[21:38:53.246] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:53.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:170:0) after 1m0s
[21:39:53.321] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:170:0)
[21:39:53.321] Timer tick, asking Buildbucket for the build status
[21:39:53.372] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:53.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:171:0) after 1m0s
[21:40:53.400] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:171:0)
[21:40:53.400] Timer tick, asking Buildbucket for the build status
[21:40:53.461] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:53.461] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:172:0) after 1m0s
[21:41:53.482] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:172:0)
[21:41:53.482] Timer tick, asking Buildbucket for the build status
[21:41:53.613] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:53.613] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:173:0) after 1m0s
[21:42:53.639] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:173:0)
[21:42:53.639] Timer tick, asking Buildbucket for the build status
[21:42:53.751] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:53.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:174:0) after 1m0s
[21:43:53.772] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:174:0)
[21:43:53.772] Timer tick, asking Buildbucket for the build status
[21:43:53.844] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:53.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:175:0) after 1m0s
[21:44:53.867] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:175:0)
[21:44:53.867] Timer tick, asking Buildbucket for the build status
[21:44:53.947] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:53.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:176:0) after 1m0s
[21:45:53.968] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:176:0)
[21:45:53.968] Timer tick, asking Buildbucket for the build status
[21:45:54.032] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:54.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:177:0) after 1m0s
[21:46:54.064] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:177:0)
[21:46:54.064] Timer tick, asking Buildbucket for the build status
[21:46:54.102] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:54.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:178:0) after 1m0s
[21:47:54.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:178:0)
[21:47:54.127] Timer tick, asking Buildbucket for the build status
[21:47:54.235] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:54.235] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:179:0) after 1m0s
[21:48:54.257] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:179:0)
[21:48:54.257] Timer tick, asking Buildbucket for the build status
[21:48:54.359] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:54.359] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:180:0) after 1m0s
[21:49:54.381] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:180:0)
[21:49:54.381] Timer tick, asking Buildbucket for the build status
[21:49:54.468] Build 8927954873222543744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:54.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9093384935386820976:181:0) after 1m0s
[21:50:22.461] Received PubSub notification, asking Buildbucket for the build status
[21:50:22.499] Build 8927954873222543744: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[21:50:22.499] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1544046621684523",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1544035761581289",
    "failure_reason": "INFRA_FAILURE",
    "id": "8927954873222543744",
    "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\": \"17af1e818981ebf2c492a678d4d31c9e1ee37fc7\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"], \"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\": [\"3910-a71d441\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-west1-b-1jxx\"], \"pool\": [\"luci.nacl.toolchain\"]}}, \"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1544035803525940",
    "status": "COMPLETED",
    "status_changed_ts": "1544046622193314",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7003",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9093384935386820976",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_dimension:caches:builder_eacc41f1df5d043e03eef0198bc8ddecd24b0492a666afd70585f546f0146c16_v2",
      "swarming_dimension:cores:8",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.nacl.toolchain",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:build_address:luci.nacl.toolchain/linux-pnacl-x86_64/7003",
      "swarming_tag:buildbucket_bucket:nacl/toolchain",
      "swarming_tag:buildbucket_build_id:8927954873222543744",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:2f19301aebbc779351dc95ab1dc03603fa761240",
      "swarming_tag:builder:linux-pnacl-x86_64",
      "swarming_tag:buildset:commit/git/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/17af1e818981ebf2c492a678d4d31c9e1ee37fc7",
      "swarming_tag:caches:builder_eacc41f1df5d043e03eef0198bc8ddecd24b0492a666afd70585f546f0146c16_v2",
      "swarming_tag:cores:8",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:gitiles_ref:refs/heads/master",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8927954873222543744/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9093384935386820976",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:7be98d3a655353173e6c69dca4a3f5562afcd673",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:41988587836a9b10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1544046622194304",
    "url": "https://ci.chromium.org/b/8927954873222543744",
    "utcnow_ts": "1544046622491255"
  }
}
[21:50:22.499] Invocation finished in 3h1m2.365418317s with status FAILED