Status: FAILED
Triggered by: -
Duration: 6 hours
Actions:

Definition (rev 1c82d86159c2071b02a7ddf08ffd2ae0bff92186)

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

Incoming triggers

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[22:36:51.193] New invocation is queued and will start shortly
[22:36:52.817] Starting the invocation (attempt 1)
[22:36:52.851] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:36:52.852] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:36:52.852] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9100980766408657232",
  "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\":\"32b6deb45d5fbc77c5f65d35db45c48cae3c06bc\"}}",
  "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:9100980766408657232",
    "scheduler_job_id:nacl/linux-pnacl-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
    "gitiles_ref:refs/heads/master"
  ]
}
[22:36:54.855] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1536791812966658",
    "experimental": true,
    "id": "8935550703885801520",
    "lease_expiration_ts": "1536910614433810",
    "lease_key": "1296330566",
    "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\": \"32b6deb45d5fbc77c5f65d35db45c48cae3c06bc\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1536791814737347",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/3",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9100980766408657232",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_dimension:caches:builder_c4fb8a21f9264ee89d0c9acaafd50c7c6d9e2973bab8e8b102bc138e7852d256_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/3",
      "swarming_tag:buildbucket_bucket:luci.nacl.toolchain",
      "swarming_tag:buildbucket_build_id:8935550703885801520",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
      "swarming_tag:builder:linux-pnacl-x86_64",
      "swarming_tag:buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "swarming_tag:caches:builder_c4fb8a21f9264ee89d0c9acaafd50c7c6d9e2973bab8e8b102bc138e7852d256_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/8935550703885801520/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:60",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9100980766408657232",
      "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:ccd94b661aaeb4cc141585f6f7be3f211386159f",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3fe8bfa747f93a10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1536791814737456",
    "url": "https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64/3",
    "utcnow_ts": "1536791814836335"
  }
}
[22:36:54.856] Task URL: https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64/3
[22:36:54.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:2:0) after 1m0s
[22:37:54.870] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:2:0)
[22:37:54.870] Timer tick, asking Buildbucket for the build status
[22:37:54.933] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:54.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:3:0) after 1m0s
[22:38:54.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:3:0)
[22:38:54.950] Timer tick, asking Buildbucket for the build status
[22:38:55.089] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:55.089] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:4:0) after 1m0s
[22:39:55.106] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:4:0)
[22:39:55.106] Timer tick, asking Buildbucket for the build status
[22:39:55.163] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:55.163] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:5:0) after 1m0s
[22:40:55.184] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:5:0)
[22:40:55.184] Timer tick, asking Buildbucket for the build status
[22:40:55.354] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:55.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:6:0) after 1m0s
[22:41:55.372] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:6:0)
[22:41:55.372] Timer tick, asking Buildbucket for the build status
[22:41:55.439] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:55.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:7:0) after 1m0s
[22:42:55.456] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:7:0)
[22:42:55.456] Timer tick, asking Buildbucket for the build status
[22:42:55.513] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:55.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:8:0) after 1m0s
[22:43:55.529] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:8:0)
[22:43:55.529] Timer tick, asking Buildbucket for the build status
[22:43:55.660] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:55.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:9:0) after 1m0s
[22:44:55.675] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:9:0)
[22:44:55.675] Timer tick, asking Buildbucket for the build status
[22:44:55.732] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:55.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:10:0) after 1m0s
[22:45:55.791] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:10:0)
[22:45:55.791] Timer tick, asking Buildbucket for the build status
[22:45:55.850] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:55.850] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:11:0) after 1m0s
[22:46:55.866] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:11:0)
[22:46:55.866] Timer tick, asking Buildbucket for the build status
[22:46:56.058] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:56.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:12:0) after 1m0s
[22:47:56.075] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:12:0)
[22:47:56.075] Timer tick, asking Buildbucket for the build status
[22:47:56.266] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:56.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:13:0) after 1m0s
[22:48:56.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:13:0)
[22:48:56.280] Timer tick, asking Buildbucket for the build status
[22:48:56.393] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:56.393] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:14:0) after 1m0s
[22:49:56.408] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:14:0)
[22:49:56.408] Timer tick, asking Buildbucket for the build status
[22:49:56.657] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:56.657] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:15:0) after 1m0s
[22:50:56.675] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:15:0)
[22:50:56.675] Timer tick, asking Buildbucket for the build status
[22:50:56.911] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:56.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:16:0) after 1m0s
[22:51:56.930] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:16:0)
[22:51:56.930] Timer tick, asking Buildbucket for the build status
[22:51:57.051] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:57.051] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:17:0) after 1m0s
[22:52:57.075] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:17:0)
[22:52:57.075] Timer tick, asking Buildbucket for the build status
[22:52:57.218] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:57.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:18:0) after 1m0s
[22:53:57.263] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:18:0)
[22:53:57.263] Timer tick, asking Buildbucket for the build status
[22:53:57.503] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:57.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:19:0) after 1m0s
[22:54:57.544] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:19:0)
[22:54:57.544] Timer tick, asking Buildbucket for the build status
[22:54:57.655] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:57.655] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:20:0) after 1m0s
[22:55:57.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:20:0)
[22:55:57.735] Timer tick, asking Buildbucket for the build status
[22:55:57.814] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:57.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:21:0) after 1m0s
[22:56:57.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:21:0)
[22:56:57.832] Timer tick, asking Buildbucket for the build status
[22:56:58.455] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:58.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:22:0) after 1m0s
[22:57:58.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:22:0)
[22:57:58.473] Timer tick, asking Buildbucket for the build status
[22:57:58.579] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:58.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:23:0) after 1m0s
[22:58:58.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:23:0)
[22:58:58.608] Timer tick, asking Buildbucket for the build status
[22:58:58.677] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:58.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:24:0) after 1m0s
[22:59:58.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:24:0)
[22:59:58.749] Timer tick, asking Buildbucket for the build status
[22:59:58.889] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:58.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:25:0) after 1m0s
[23:00:58.943] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:25:0)
[23:00:58.943] Timer tick, asking Buildbucket for the build status
[23:00:59.016] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:59.016] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:26:0) after 1m0s
[23:01:59.043] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:26:0)
[23:01:59.043] Timer tick, asking Buildbucket for the build status
[23:01:59.117] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:59.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:27:0) after 1m0s
[23:02:59.183] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:27:0)
[23:02:59.183] Timer tick, asking Buildbucket for the build status
[23:02:59.285] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:59.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:28:0) after 1m0s
[23:03:59.327] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:28:0)
[23:03:59.327] Timer tick, asking Buildbucket for the build status
[23:03:59.373] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:59.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:29:0) after 1m0s
[23:04:59.402] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:29:0)
[23:04:59.402] Timer tick, asking Buildbucket for the build status
[23:04:59.531] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:59.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:30:0) after 1m0s
[23:05:59.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:30:0)
[23:05:59.553] Timer tick, asking Buildbucket for the build status
[23:05:59.705] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:59.706] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:31:0) after 1m0s
[23:06:59.769] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:31:0)
[23:06:59.769] Timer tick, asking Buildbucket for the build status
[23:06:59.832] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:59.832] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:32:0) after 1m0s
[23:07:59.855] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:32:0)
[23:07:59.855] Timer tick, asking Buildbucket for the build status
[23:07:59.996] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:59.996] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:33:0) after 1m0s
[23:09:00.016] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:33:0)
[23:09:00.016] Timer tick, asking Buildbucket for the build status
[23:09:00.063] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:00.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:34:0) after 1m0s
[23:10:00.085] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:34:0)
[23:10:00.085] Timer tick, asking Buildbucket for the build status
[23:10:00.182] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:00.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:35:0) after 1m0s
[23:11:00.200] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:35:0)
[23:11:00.200] Timer tick, asking Buildbucket for the build status
[23:11:00.258] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:00.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:36:0) after 1m0s
[23:12:00.314] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:36:0)
[23:12:00.314] Timer tick, asking Buildbucket for the build status
[23:12:00.409] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:00.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:37:0) after 1m0s
[23:13:00.431] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:37:0)
[23:13:00.431] Timer tick, asking Buildbucket for the build status
[23:13:00.512] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:00.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:38:0) after 1m0s
[23:14:00.532] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:38:0)
[23:14:00.532] Timer tick, asking Buildbucket for the build status
[23:14:00.638] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:00.638] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:39:0) after 1m0s
[23:15:00.657] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:39:0)
[23:15:00.657] Timer tick, asking Buildbucket for the build status
[23:15:01.010] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:01.010] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:40:0) after 1m0s
[23:16:01.026] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:40:0)
[23:16:01.026] Timer tick, asking Buildbucket for the build status
[23:16:01.271] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:01.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:41:0) after 1m0s
[23:17:01.299] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:41:0)
[23:17:01.299] Timer tick, asking Buildbucket for the build status
[23:17:01.363] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:01.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:42:0) after 1m0s
[23:18:01.386] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:42:0)
[23:18:01.386] Timer tick, asking Buildbucket for the build status
[23:18:01.762] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:01.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:43:0) after 1m0s
[23:19:01.780] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:43:0)
[23:19:01.780] Timer tick, asking Buildbucket for the build status
[23:19:01.927] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:01.927] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:44:0) after 1m0s
[23:20:02.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:44:0)
[23:20:02.018] Timer tick, asking Buildbucket for the build status
[23:20:02.215] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:02.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:45:0) after 1m0s
[23:21:02.236] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:45:0)
[23:21:02.236] Timer tick, asking Buildbucket for the build status
[23:21:02.268] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:02.268] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:46:0) after 1m0s
[23:22:02.296] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:46:0)
[23:22:02.296] Timer tick, asking Buildbucket for the build status
[23:22:02.421] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:02.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:47:0) after 1m0s
[23:23:02.442] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:47:0)
[23:23:02.442] Timer tick, asking Buildbucket for the build status
[23:23:02.495] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:02.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:48:0) after 1m0s
[23:24:02.528] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:48:0)
[23:24:02.528] Timer tick, asking Buildbucket for the build status
[23:24:02.593] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:02.593] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:49:0) after 1m0s
[23:25:02.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:49:0)
[23:25:02.616] Timer tick, asking Buildbucket for the build status
[23:25:02.722] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:02.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:50:0) after 1m0s
[23:26:02.743] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:50:0)
[23:26:02.743] Timer tick, asking Buildbucket for the build status
[23:26:02.988] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:02.988] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:51:0) after 1m0s
[23:27:03.011] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:51:0)
[23:27:03.011] Timer tick, asking Buildbucket for the build status
[23:27:03.290] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:03.290] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:52:0) after 1m0s
[23:28:03.315] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:52:0)
[23:28:03.315] Timer tick, asking Buildbucket for the build status
[23:28:03.465] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:03.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:53:0) after 1m0s
[23:29:03.485] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:53:0)
[23:29:03.485] Timer tick, asking Buildbucket for the build status
[23:29:03.671] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:03.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:54:0) after 1m0s
[23:30:03.775] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:54:0)
[23:30:03.775] Timer tick, asking Buildbucket for the build status
[23:30:03.877] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:03.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:55:0) after 1m0s
[23:31:03.901] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:55:0)
[23:31:03.901] Timer tick, asking Buildbucket for the build status
[23:31:03.996] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:03.996] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:56:0) after 1m0s
[23:32:04.015] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:56:0)
[23:32:04.015] Timer tick, asking Buildbucket for the build status
[23:32:04.164] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:04.164] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:57:0) after 1m0s
[23:33:04.187] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:57:0)
[23:33:04.187] Timer tick, asking Buildbucket for the build status
[23:33:05.355] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:05.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:58:0) after 1m0s
[23:34:05.377] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:58:0)
[23:34:05.377] Timer tick, asking Buildbucket for the build status
[23:34:05.449] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:05.449] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:59:0) after 1m0s
[23:35:05.489] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:59:0)
[23:35:05.489] Timer tick, asking Buildbucket for the build status
[23:35:05.861] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:05.861] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:60:0) after 1m0s
[23:36:05.896] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:60:0)
[23:36:05.896] Timer tick, asking Buildbucket for the build status
[23:36:06.184] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:06.184] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:61:0) after 1m0s
[23:37:06.215] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:61:0)
[23:37:06.215] Timer tick, asking Buildbucket for the build status
[23:37:06.264] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:06.264] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:62:0) after 1m0s
[23:38:06.282] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:62:0)
[23:38:06.282] Timer tick, asking Buildbucket for the build status
[23:38:06.388] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:06.388] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:63:0) after 1m0s
[23:39:06.432] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:63:0)
[23:39:06.432] Timer tick, asking Buildbucket for the build status
[23:39:06.476] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:06.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:64:0) after 1m0s
[23:40:06.494] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:64:0)
[23:40:06.494] Timer tick, asking Buildbucket for the build status
[23:40:06.610] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:06.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:65:0) after 1m0s
[23:41:06.636] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:65:0)
[23:41:06.636] Timer tick, asking Buildbucket for the build status
[23:41:06.692] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:06.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:66:0) after 1m0s
[23:42:06.714] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:66:0)
[23:42:06.714] Timer tick, asking Buildbucket for the build status
[23:42:06.777] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:06.777] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:67:0) after 1m0s
[23:43:06.825] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:67:0)
[23:43:06.825] Timer tick, asking Buildbucket for the build status
[23:43:06.974] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:06.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:68:0) after 1m0s
[23:44:06.998] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:68:0)
[23:44:06.998] Timer tick, asking Buildbucket for the build status
[23:44:07.059] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:07.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:69:0) after 1m0s
[23:45:07.081] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:69:0)
[23:45:07.081] Timer tick, asking Buildbucket for the build status
[23:45:07.419] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:07.419] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:70:0) after 1m0s
[23:46:07.443] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:70:0)
[23:46:07.443] Timer tick, asking Buildbucket for the build status
[23:46:07.476] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:07.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:71:0) after 1m0s
[23:47:07.625] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:71:0)
[23:47:07.625] Timer tick, asking Buildbucket for the build status
[23:47:07.677] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:07.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:72:0) after 1m0s
[23:48:07.828] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:72:0)
[23:48:07.828] Timer tick, asking Buildbucket for the build status
[23:48:07.885] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:07.885] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:73:0) after 1m0s
[23:49:07.917] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:73:0)
[23:49:07.917] Timer tick, asking Buildbucket for the build status
[23:49:07.991] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:07.991] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:74:0) after 1m0s
[23:50:08.009] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:74:0)
[23:50:08.009] Timer tick, asking Buildbucket for the build status
[23:50:08.130] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:08.130] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:75:0) after 1m0s
[23:51:08.152] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:75:0)
[23:51:08.152] Timer tick, asking Buildbucket for the build status
[23:51:08.214] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:08.214] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:76:0) after 1m0s
[23:52:08.322] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:76:0)
[23:52:08.322] Timer tick, asking Buildbucket for the build status
[23:52:08.424] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:08.424] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:77:0) after 1m0s
[23:53:08.446] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:77:0)
[23:53:08.446] Timer tick, asking Buildbucket for the build status
[23:53:10.880] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:10.880] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:78:0) after 1m0s
[23:54:10.914] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:78:0)
[23:54:10.914] Timer tick, asking Buildbucket for the build status
[23:54:10.955] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:10.955] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:79:0) after 1m0s
[23:55:10.976] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:79:0)
[23:55:10.976] Timer tick, asking Buildbucket for the build status
[23:55:11.162] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:11.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:80:0) after 1m0s
[23:56:11.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:80:0)
[23:56:11.185] Timer tick, asking Buildbucket for the build status
[23:56:11.263] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:11.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:81:0) after 1m0s
[23:57:11.283] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:81:0)
[23:57:11.283] Timer tick, asking Buildbucket for the build status
[23:57:11.501] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:11.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:82:0) after 1m0s
[23:58:11.526] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:82:0)
[23:58:11.526] Timer tick, asking Buildbucket for the build status
[23:58:11.584] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:11.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:83:0) after 1m0s
[23:59:11.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:83:0)
[23:59:11.663] Timer tick, asking Buildbucket for the build status
[23:59:11.701] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:11.701] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:84:0) after 1m0s
[00:00:11.725] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:84:0)
[00:00:11.725] Timer tick, asking Buildbucket for the build status
[00:00:11.880] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:11.880] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:85:0) after 1m0s
[00:01:11.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:85:0)
[00:01:11.900] Timer tick, asking Buildbucket for the build status
[00:01:11.950] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:11.950] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:86:0) after 1m0s
[00:02:11.970] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:86:0)
[00:02:11.971] Timer tick, asking Buildbucket for the build status
[00:02:12.115] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:12.115] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:87:0) after 1m0s
[00:03:12.209] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:87:0)
[00:03:12.209] Timer tick, asking Buildbucket for the build status
[00:03:12.282] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:12.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:88:0) after 1m0s
[00:04:12.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:88:0)
[00:04:12.325] Timer tick, asking Buildbucket for the build status
[00:04:12.386] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:12.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:89:0) after 1m0s
[00:05:12.454] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:89:0)
[00:05:12.454] Timer tick, asking Buildbucket for the build status
[00:05:12.572] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:12.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:90:0) after 1m0s
[00:06:12.593] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:90:0)
[00:06:12.593] Timer tick, asking Buildbucket for the build status
[00:06:12.646] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:12.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:91:0) after 1m0s
[00:07:12.678] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:91:0)
[00:07:12.678] Timer tick, asking Buildbucket for the build status
[00:07:12.941] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:12.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:92:0) after 1m0s
[00:08:12.975] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:92:0)
[00:08:12.975] Timer tick, asking Buildbucket for the build status
[00:08:13.034] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:13.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:93:0) after 1m0s
[00:09:13.062] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:93:0)
[00:09:13.062] Timer tick, asking Buildbucket for the build status
[00:09:13.118] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:13.118] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:94:0) after 1m0s
[00:10:13.137] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:94:0)
[00:10:13.137] Timer tick, asking Buildbucket for the build status
[00:10:13.201] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:13.201] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:95:0) after 1m0s
[00:11:13.222] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:95:0)
[00:11:13.222] Timer tick, asking Buildbucket for the build status
[00:11:13.465] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:13.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:96:0) after 1m0s
[00:12:13.522] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:96:0)
[00:12:13.522] Timer tick, asking Buildbucket for the build status
[00:12:13.567] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:13.567] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:97:0) after 1m0s
[00:13:13.636] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:97:0)
[00:13:13.636] Timer tick, asking Buildbucket for the build status
[00:13:13.763] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:13.763] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:98:0) after 1m0s
[00:14:13.792] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:98:0)
[00:14:13.792] Timer tick, asking Buildbucket for the build status
[00:14:13.911] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:13.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:99:0) after 1m0s
[00:15:13.935] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:99:0)
[00:15:13.935] Timer tick, asking Buildbucket for the build status
[00:15:14.113] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:14.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:100:0) after 1m0s
[00:16:14.133] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:100:0)
[00:16:14.133] Timer tick, asking Buildbucket for the build status
[00:16:14.224] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:14.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:101:0) after 1m0s
[00:17:14.327] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:101:0)
[00:17:14.327] Timer tick, asking Buildbucket for the build status
[00:17:14.405] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:14.405] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:102:0) after 1m0s
[00:18:14.426] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:102:0)
[00:18:14.426] Timer tick, asking Buildbucket for the build status
[00:18:14.553] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:14.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:103:0) after 1m0s
[00:19:14.578] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:103:0)
[00:19:14.578] Timer tick, asking Buildbucket for the build status
[00:19:14.640] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:14.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:104:0) after 1m0s
[00:20:14.712] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:104:0)
[00:20:14.712] Timer tick, asking Buildbucket for the build status
[00:20:14.761] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:14.761] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:105:0) after 1m0s
[00:21:14.826] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:105:0)
[00:21:14.826] Timer tick, asking Buildbucket for the build status
[00:21:14.985] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:14.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:106:0) after 1m0s
[00:22:15.005] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:106:0)
[00:22:15.005] Timer tick, asking Buildbucket for the build status
[00:22:15.071] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:15.071] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:107:0) after 1m0s
[00:23:15.092] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:107:0)
[00:23:15.092] Timer tick, asking Buildbucket for the build status
[00:23:15.147] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:15.147] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:108:0) after 1m0s
[00:24:15.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:108:0)
[00:24:15.177] Timer tick, asking Buildbucket for the build status
[00:24:15.240] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:15.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:109:0) after 1m0s
[00:25:15.265] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:109:0)
[00:25:15.265] Timer tick, asking Buildbucket for the build status
[00:25:15.407] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:15.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:110:0) after 1m0s
[00:26:15.426] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:110:0)
[00:26:15.426] Timer tick, asking Buildbucket for the build status
[00:26:15.464] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:15.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:111:0) after 1m0s
[00:27:15.488] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:111:0)
[00:27:15.488] Timer tick, asking Buildbucket for the build status
[00:27:15.582] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:15.582] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:112:0) after 1m0s
[00:28:15.602] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:112:0)
[00:28:15.602] Timer tick, asking Buildbucket for the build status
[00:28:15.669] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:15.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:113:0) after 1m0s
[00:29:15.690] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:113:0)
[00:29:15.690] Timer tick, asking Buildbucket for the build status
[00:29:15.719] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:15.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:114:0) after 1m0s
[00:30:15.739] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:114:0)
[00:30:15.740] Timer tick, asking Buildbucket for the build status
[00:30:15.876] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:15.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:115:0) after 1m0s
[00:31:15.898] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:115:0)
[00:31:15.898] Timer tick, asking Buildbucket for the build status
[00:31:15.973] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:15.973] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:116:0) after 1m0s
[00:32:15.993] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:116:0)
[00:32:15.993] Timer tick, asking Buildbucket for the build status
[00:32:16.152] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:16.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:117:0) after 1m0s
[00:33:16.180] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:117:0)
[00:33:16.180] Timer tick, asking Buildbucket for the build status
[00:33:16.256] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:16.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:118:0) after 1m0s
[00:34:16.282] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:118:0)
[00:34:16.282] Timer tick, asking Buildbucket for the build status
[00:34:16.383] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:16.383] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:119:0) after 1m0s
[00:35:16.413] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:119:0)
[00:35:16.413] Timer tick, asking Buildbucket for the build status
[00:35:16.553] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:16.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:120:0) after 1m0s
[00:36:16.582] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:120:0)
[00:36:16.582] Timer tick, asking Buildbucket for the build status
[00:36:16.639] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:16.639] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:121:0) after 1m0s
[00:37:16.661] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:121:0)
[00:37:16.661] Timer tick, asking Buildbucket for the build status
[00:37:16.739] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:16.739] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:122:0) after 1m0s
[00:38:16.768] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:122:0)
[00:38:16.768] Timer tick, asking Buildbucket for the build status
[00:38:16.900] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:16.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:123:0) after 1m0s
[00:39:16.922] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:123:0)
[00:39:16.922] Timer tick, asking Buildbucket for the build status
[00:39:16.993] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:16.993] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:124:0) after 1m0s
[00:40:17.028] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:124:0)
[00:40:17.028] Timer tick, asking Buildbucket for the build status
[00:40:17.097] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:17.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:125:0) after 1m0s
[00:41:17.122] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:125:0)
[00:41:17.122] Timer tick, asking Buildbucket for the build status
[00:41:17.260] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:17.260] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:126:0) after 1m0s
[00:42:17.283] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:126:0)
[00:42:17.283] Timer tick, asking Buildbucket for the build status
[00:42:17.345] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:17.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:127:0) after 1m0s
[00:43:17.369] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:127:0)
[00:43:17.369] Timer tick, asking Buildbucket for the build status
[00:43:17.469] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:17.469] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:128:0) after 1m0s
[00:44:17.500] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:128:0)
[00:44:17.500] Timer tick, asking Buildbucket for the build status
[00:44:17.558] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:17.558] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:129:0) after 1m0s
[00:45:17.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:129:0)
[00:45:17.652] Timer tick, asking Buildbucket for the build status
[00:45:17.790] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:17.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:130:0) after 1m0s
[00:46:17.813] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:130:0)
[00:46:17.813] Timer tick, asking Buildbucket for the build status
[00:46:17.886] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:17.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:131:0) after 1m0s
[00:47:17.908] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:131:0)
[00:47:17.908] Timer tick, asking Buildbucket for the build status
[00:47:17.998] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:17.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:132:0) after 1m0s
[00:48:18.027] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:132:0)
[00:48:18.027] Timer tick, asking Buildbucket for the build status
[00:48:18.237] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:18.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:133:0) after 1m0s
[00:49:18.371] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:133:0)
[00:49:18.371] Timer tick, asking Buildbucket for the build status
[00:49:18.507] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:18.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:134:0) after 1m0s
[00:50:18.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:134:0)
[00:50:18.536] Timer tick, asking Buildbucket for the build status
[00:50:18.599] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:18.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:135:0) after 1m0s
[00:51:18.623] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:135:0)
[00:51:18.623] Timer tick, asking Buildbucket for the build status
[00:51:18.691] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:18.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:136:0) after 1m0s
[00:52:18.797] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:136:0)
[00:52:18.797] Timer tick, asking Buildbucket for the build status
[00:52:19.001] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:19.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:137:0) after 1m0s
[00:53:19.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:137:0)
[00:53:19.032] Timer tick, asking Buildbucket for the build status
[00:53:19.151] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:19.151] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:138:0) after 1m0s
[00:54:19.254] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:138:0)
[00:54:19.254] Timer tick, asking Buildbucket for the build status
[00:54:19.585] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:19.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:139:0) after 1m0s
[00:55:19.611] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:139:0)
[00:55:19.611] Timer tick, asking Buildbucket for the build status
[00:55:19.799] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:19.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:140:0) after 1m0s
[00:56:19.822] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:140:0)
[00:56:19.822] Timer tick, asking Buildbucket for the build status
[00:56:19.882] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:19.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:141:0) after 1m0s
[00:57:19.947] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:141:0)
[00:57:19.947] Timer tick, asking Buildbucket for the build status
[00:57:19.980] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:19.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:142:0) after 1m0s
[00:58:20.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:142:0)
[00:58:20.006] Timer tick, asking Buildbucket for the build status
[00:58:20.062] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:20.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:143:0) after 1m0s
[00:59:20.090] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:143:0)
[00:59:20.090] Timer tick, asking Buildbucket for the build status
[00:59:20.208] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:20.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:144:0) after 1m0s
[01:00:20.249] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:144:0)
[01:00:20.249] Timer tick, asking Buildbucket for the build status
[01:00:20.308] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:20.308] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:145:0) after 1m0s
[01:01:20.341] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:145:0)
[01:01:20.341] Timer tick, asking Buildbucket for the build status
[01:01:20.469] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:20.469] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:146:0) after 1m0s
[01:02:20.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:146:0)
[01:02:20.497] Timer tick, asking Buildbucket for the build status
[01:02:20.572] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:20.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:147:0) after 1m0s
[01:03:20.626] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:147:0)
[01:03:20.627] Timer tick, asking Buildbucket for the build status
[01:03:20.675] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:20.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:148:0) after 1m0s
[01:04:20.697] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:148:0)
[01:04:20.697] Timer tick, asking Buildbucket for the build status
[01:04:20.803] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:20.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:149:0) after 1m0s
[01:05:20.827] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:149:0)
[01:05:20.827] Timer tick, asking Buildbucket for the build status
[01:05:20.924] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:20.924] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:150:0) after 1m0s
[01:06:21.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:150:0)
[01:06:21.025] Timer tick, asking Buildbucket for the build status
[01:06:21.105] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:21.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:151:0) after 1m0s
[01:07:21.166] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:151:0)
[01:07:21.166] Timer tick, asking Buildbucket for the build status
[01:07:21.266] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:21.266] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:152:0) after 1m0s
[01:08:21.289] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:152:0)
[01:08:21.289] Timer tick, asking Buildbucket for the build status
[01:08:21.493] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:21.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:153:0) after 1m0s
[01:09:21.544] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:153:0)
[01:09:21.544] Timer tick, asking Buildbucket for the build status
[01:09:21.606] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:21.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:154:0) after 1m0s
[01:10:21.649] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:154:0)
[01:10:21.649] Timer tick, asking Buildbucket for the build status
[01:10:21.728] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:21.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:155:0) after 1m0s
[01:11:21.748] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:155:0)
[01:11:21.748] Timer tick, asking Buildbucket for the build status
[01:11:21.815] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:21.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:156:0) after 1m0s
[01:12:21.837] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:156:0)
[01:12:21.837] Timer tick, asking Buildbucket for the build status
[01:12:21.887] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:21.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:157:0) after 1m0s
[01:13:21.910] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:157:0)
[01:13:21.910] Timer tick, asking Buildbucket for the build status
[01:13:21.977] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:21.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:158:0) after 1m0s
[01:14:22.002] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:158:0)
[01:14:22.002] Timer tick, asking Buildbucket for the build status
[01:14:22.122] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:22.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:159:0) after 1m0s
[01:15:22.146] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:159:0)
[01:15:22.146] Timer tick, asking Buildbucket for the build status
[01:15:22.327] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:22.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:160:0) after 1m0s
[01:16:22.359] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:160:0)
[01:16:22.359] Timer tick, asking Buildbucket for the build status
[01:16:22.423] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:22.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:161:0) after 1m0s
[01:17:22.444] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:161:0)
[01:17:22.444] Timer tick, asking Buildbucket for the build status
[01:17:22.553] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:22.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:162:0) after 1m0s
[01:18:22.586] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:162:0)
[01:18:22.586] Timer tick, asking Buildbucket for the build status
[01:18:22.668] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:22.668] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:163:0) after 1m0s
[01:19:22.691] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:163:0)
[01:19:22.691] Timer tick, asking Buildbucket for the build status
[01:19:22.760] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:22.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:164:0) after 1m0s
[01:20:22.781] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:164:0)
[01:20:22.781] Timer tick, asking Buildbucket for the build status
[01:20:22.825] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:22.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:165:0) after 1m0s
[01:21:22.848] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:165:0)
[01:21:22.848] Timer tick, asking Buildbucket for the build status
[01:21:22.946] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:22.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:166:0) after 1m0s
[01:22:22.977] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:166:0)
[01:22:22.977] Timer tick, asking Buildbucket for the build status
[01:22:23.113] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:23.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:167:0) after 1m0s
[01:23:23.135] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:167:0)
[01:23:23.135] Timer tick, asking Buildbucket for the build status
[01:23:23.198] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:23.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:168:0) after 1m0s
[01:24:23.222] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:168:0)
[01:24:23.222] Timer tick, asking Buildbucket for the build status
[01:24:23.297] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:23.297] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:169:0) after 1m0s
[01:25:23.326] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:169:0)
[01:25:23.326] Timer tick, asking Buildbucket for the build status
[01:25:23.397] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:23.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:170:0) after 1m0s
[01:26:23.423] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:170:0)
[01:26:23.423] Timer tick, asking Buildbucket for the build status
[01:26:23.488] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:23.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:171:0) after 1m0s
[01:27:23.512] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:171:0)
[01:27:23.512] Timer tick, asking Buildbucket for the build status
[01:27:23.581] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:23.581] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:172:0) after 1m0s
[01:28:23.618] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:172:0)
[01:28:23.618] Timer tick, asking Buildbucket for the build status
[01:28:23.719] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:23.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:173:0) after 1m0s
[01:29:23.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:173:0)
[01:29:23.755] Timer tick, asking Buildbucket for the build status
[01:29:23.879] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:23.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:174:0) after 1m0s
[01:30:23.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:174:0)
[01:30:23.899] Timer tick, asking Buildbucket for the build status
[01:30:23.956] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:23.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:175:0) after 1m0s
[01:31:23.978] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:175:0)
[01:31:23.978] Timer tick, asking Buildbucket for the build status
[01:31:24.064] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:24.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:176:0) after 1m0s
[01:32:24.084] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:176:0)
[01:32:24.084] Timer tick, asking Buildbucket for the build status
[01:32:24.333] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:24.333] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:177:0) after 1m0s
[01:33:24.353] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:177:0)
[01:33:24.353] Timer tick, asking Buildbucket for the build status
[01:33:24.430] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:24.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:178:0) after 1m0s
[01:34:24.452] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:178:0)
[01:34:24.452] Timer tick, asking Buildbucket for the build status
[01:34:24.584] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:24.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:179:0) after 1m0s
[01:35:24.607] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:179:0)
[01:35:24.607] Timer tick, asking Buildbucket for the build status
[01:35:24.678] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:24.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:180:0) after 1m0s
[01:36:24.759] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:180:0)
[01:36:24.759] Timer tick, asking Buildbucket for the build status
[01:36:24.829] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:24.829] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:181:0) after 1m0s
[01:37:24.851] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:181:0)
[01:37:24.851] Timer tick, asking Buildbucket for the build status
[01:37:24.906] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:24.906] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:182:0) after 1m0s
[01:38:24.984] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:182:0)
[01:38:24.984] Timer tick, asking Buildbucket for the build status
[01:38:25.043] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:25.043] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:183:0) after 1m0s
[01:39:25.066] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:183:0)
[01:39:25.066] Timer tick, asking Buildbucket for the build status
[01:39:25.124] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:25.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:184:0) after 1m0s
[01:40:25.156] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:184:0)
[01:40:25.156] Timer tick, asking Buildbucket for the build status
[01:40:25.286] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:25.286] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:185:0) after 1m0s
[01:41:25.357] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:185:0)
[01:41:25.357] Timer tick, asking Buildbucket for the build status
[01:41:25.464] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:25.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:186:0) after 1m0s
[01:42:25.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:186:0)
[01:42:25.491] Timer tick, asking Buildbucket for the build status
[01:42:25.704] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:25.704] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:187:0) after 1m0s
[01:43:25.730] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:187:0)
[01:43:25.730] Timer tick, asking Buildbucket for the build status
[01:43:25.806] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:25.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:188:0) after 1m0s
[01:44:25.829] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:188:0)
[01:44:25.829] Timer tick, asking Buildbucket for the build status
[01:44:26.062] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:26.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:189:0) after 1m0s
[01:45:26.083] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:189:0)
[01:45:26.083] Timer tick, asking Buildbucket for the build status
[01:45:26.157] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:26.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:190:0) after 1m0s
[01:46:26.193] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:190:0)
[01:46:26.193] Timer tick, asking Buildbucket for the build status
[01:46:26.246] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:26.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:191:0) after 1m0s
[01:47:26.266] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:191:0)
[01:47:26.266] Timer tick, asking Buildbucket for the build status
[01:47:26.351] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:26.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:192:0) after 1m0s
[01:48:26.374] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:192:0)
[01:48:26.374] Timer tick, asking Buildbucket for the build status
[01:48:26.436] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:26.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:193:0) after 1m0s
[01:49:26.460] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:193:0)
[01:49:26.460] Timer tick, asking Buildbucket for the build status
[01:49:26.596] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:26.596] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:194:0) after 1m0s
[01:50:26.618] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:194:0)
[01:50:26.618] Timer tick, asking Buildbucket for the build status
[01:50:26.827] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:26.827] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:195:0) after 1m0s
[01:51:26.850] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:195:0)
[01:51:26.850] Timer tick, asking Buildbucket for the build status
[01:51:26.921] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:26.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:196:0) after 1m0s
[01:52:26.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:196:0)
[01:52:26.962] Timer tick, asking Buildbucket for the build status
[01:52:27.036] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:27.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:197:0) after 1m0s
[01:53:27.110] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:197:0)
[01:53:27.110] Timer tick, asking Buildbucket for the build status
[01:53:27.185] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:27.185] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:198:0) after 1m0s
[01:54:27.212] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:198:0)
[01:54:27.212] Timer tick, asking Buildbucket for the build status
[01:54:27.263] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:27.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:199:0) after 1m0s
[01:55:27.290] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:199:0)
[01:55:27.290] Timer tick, asking Buildbucket for the build status
[01:55:27.386] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:27.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:200:0) after 1m0s
[01:56:27.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:200:0)
[01:56:27.497] Timer tick, asking Buildbucket for the build status
[01:56:27.555] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:27.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:201:0) after 1m0s
[01:57:27.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:201:0)
[01:57:27.577] Timer tick, asking Buildbucket for the build status
[01:57:27.614] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:27.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:202:0) after 1m0s
[01:58:27.647] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:202:0)
[01:58:27.647] Timer tick, asking Buildbucket for the build status
[01:58:27.721] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:27.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:203:0) after 1m0s
[01:59:27.742] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:203:0)
[01:59:27.742] Timer tick, asking Buildbucket for the build status
[01:59:27.819] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:27.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:204:0) after 1m0s
[02:00:27.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:204:0)
[02:00:27.843] Timer tick, asking Buildbucket for the build status
[02:00:28.006] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:28.006] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:205:0) after 1m0s
[02:01:28.062] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:205:0)
[02:01:28.062] Timer tick, asking Buildbucket for the build status
[02:01:28.192] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:28.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:206:0) after 1m0s
[02:02:28.269] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:206:0)
[02:02:28.269] Timer tick, asking Buildbucket for the build status
[02:02:28.367] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:28.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:207:0) after 1m0s
[02:03:28.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:207:0)
[02:03:28.394] Timer tick, asking Buildbucket for the build status
[02:03:28.477] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:28.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:208:0) after 1m0s
[02:04:28.500] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:208:0)
[02:04:28.500] Timer tick, asking Buildbucket for the build status
[02:04:28.605] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:28.605] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:209:0) after 1m0s
[02:05:28.628] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:209:0)
[02:05:28.628] Timer tick, asking Buildbucket for the build status
[02:05:28.691] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:28.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:210:0) after 1m0s
[02:06:28.713] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:210:0)
[02:06:28.713] Timer tick, asking Buildbucket for the build status
[02:06:28.816] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:28.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:211:0) after 1m0s
[02:07:28.839] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:211:0)
[02:07:28.839] Timer tick, asking Buildbucket for the build status
[02:07:28.929] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:28.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:212:0) after 1m0s
[02:08:28.953] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:212:0)
[02:08:28.953] Timer tick, asking Buildbucket for the build status
[02:08:28.987] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:28.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:213:0) after 1m0s
[02:09:29.015] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:213:0)
[02:09:29.015] Timer tick, asking Buildbucket for the build status
[02:09:29.088] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:29.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:214:0) after 1m0s
[02:10:29.111] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:214:0)
[02:10:29.111] Timer tick, asking Buildbucket for the build status
[02:10:29.245] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:29.245] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:215:0) after 1m0s
[02:11:29.297] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:215:0)
[02:11:29.297] Timer tick, asking Buildbucket for the build status
[02:11:29.371] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:29.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:216:0) after 1m0s
[02:12:29.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:216:0)
[02:12:29.397] Timer tick, asking Buildbucket for the build status
[02:12:29.456] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:29.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:217:0) after 1m0s
[02:13:29.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:217:0)
[02:13:29.498] Timer tick, asking Buildbucket for the build status
[02:13:29.555] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:29.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:218:0) after 1m0s
[02:14:29.580] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:218:0)
[02:14:29.580] Timer tick, asking Buildbucket for the build status
[02:14:29.775] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:29.775] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:219:0) after 1m0s
[02:15:29.802] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:219:0)
[02:15:29.802] Timer tick, asking Buildbucket for the build status
[02:15:29.891] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:29.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:220:0) after 1m0s
[02:16:29.920] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:220:0)
[02:16:29.920] Timer tick, asking Buildbucket for the build status
[02:16:29.958] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:29.958] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:221:0) after 1m0s
[02:17:29.985] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:221:0)
[02:17:29.985] Timer tick, asking Buildbucket for the build status
[02:17:31.600] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:31.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:222:0) after 1m0s
[02:18:31.624] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:222:0)
[02:18:31.624] Timer tick, asking Buildbucket for the build status
[02:18:31.694] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:31.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:223:0) after 1m0s
[02:19:31.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:223:0)
[02:19:31.721] Timer tick, asking Buildbucket for the build status
[02:19:31.901] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:31.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:224:0) after 1m0s
[02:20:31.924] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:224:0)
[02:20:31.924] Timer tick, asking Buildbucket for the build status
[02:20:32.107] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:32.107] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:225:0) after 1m0s
[02:21:32.130] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:225:0)
[02:21:32.130] Timer tick, asking Buildbucket for the build status
[02:21:32.197] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:32.197] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:226:0) after 1m0s
[02:22:32.221] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:226:0)
[02:22:32.221] Timer tick, asking Buildbucket for the build status
[02:22:32.258] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:32.258] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:227:0) after 1m0s
[02:23:32.326] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:227:0)
[02:23:32.326] Timer tick, asking Buildbucket for the build status
[02:23:32.469] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:32.469] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:228:0) after 1m0s
[02:24:32.495] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:228:0)
[02:24:32.495] Timer tick, asking Buildbucket for the build status
[02:24:32.610] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:32.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:229:0) after 1m0s
[02:25:32.668] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:229:0)
[02:25:32.668] Timer tick, asking Buildbucket for the build status
[02:25:32.727] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:32.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:230:0) after 1m0s
[02:26:32.756] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:230:0)
[02:26:32.756] Timer tick, asking Buildbucket for the build status
[02:26:32.828] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:32.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:231:0) after 1m0s
[02:27:32.857] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:231:0)
[02:27:32.857] Timer tick, asking Buildbucket for the build status
[02:27:33.077] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:33.077] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:232:0) after 1m0s
[02:28:33.110] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:232:0)
[02:28:33.110] Timer tick, asking Buildbucket for the build status
[02:28:33.240] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:33.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:233:0) after 1m0s
[02:29:33.276] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:233:0)
[02:29:33.276] Timer tick, asking Buildbucket for the build status
[02:29:33.364] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:33.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:234:0) after 1m0s
[02:30:33.391] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:234:0)
[02:30:33.391] Timer tick, asking Buildbucket for the build status
[02:30:33.435] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:33.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:235:0) after 1m0s
[02:31:33.468] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:235:0)
[02:31:33.468] Timer tick, asking Buildbucket for the build status
[02:31:33.573] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:33.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:236:0) after 1m0s
[02:32:33.610] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:236:0)
[02:32:33.610] Timer tick, asking Buildbucket for the build status
[02:32:33.710] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:33.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:237:0) after 1m0s
[02:33:33.748] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:237:0)
[02:33:33.748] Timer tick, asking Buildbucket for the build status
[02:33:33.881] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:33.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:238:0) after 1m0s
[02:34:33.980] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:238:0)
[02:34:33.980] Timer tick, asking Buildbucket for the build status
[02:34:34.085] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:34.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:239:0) after 1m0s
[02:35:34.144] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:239:0)
[02:35:34.144] Timer tick, asking Buildbucket for the build status
[02:35:34.293] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:34.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:240:0) after 1m0s
[02:36:34.319] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:240:0)
[02:36:34.319] Timer tick, asking Buildbucket for the build status
[02:36:34.372] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:34.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:241:0) after 1m0s
[02:37:34.415] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:241:0)
[02:37:34.415] Timer tick, asking Buildbucket for the build status
[02:37:34.466] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:34.466] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:242:0) after 1m0s
[02:38:34.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:242:0)
[02:38:34.496] Timer tick, asking Buildbucket for the build status
[02:38:34.554] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:34.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:243:0) after 1m0s
[02:39:34.581] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:243:0)
[02:39:34.581] Timer tick, asking Buildbucket for the build status
[02:39:34.654] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:34.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:244:0) after 1m0s
[02:40:34.693] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:244:0)
[02:40:34.693] Timer tick, asking Buildbucket for the build status
[02:40:34.733] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:34.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:245:0) after 1m0s
[02:41:34.760] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:245:0)
[02:41:34.760] Timer tick, asking Buildbucket for the build status
[02:41:34.803] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:34.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:246:0) after 1m0s
[02:42:34.831] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:246:0)
[02:42:34.831] Timer tick, asking Buildbucket for the build status
[02:42:34.891] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:34.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:247:0) after 1m0s
[02:43:34.942] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:247:0)
[02:43:34.942] Timer tick, asking Buildbucket for the build status
[02:43:35.177] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:35.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:248:0) after 1m0s
[02:44:35.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:248:0)
[02:44:35.203] Timer tick, asking Buildbucket for the build status
[02:44:35.466] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:35.466] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:249:0) after 1m0s
[02:45:35.498] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:249:0)
[02:45:35.498] Timer tick, asking Buildbucket for the build status
[02:45:35.567] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:35.567] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:250:0) after 1m0s
[02:46:35.595] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:250:0)
[02:46:35.595] Timer tick, asking Buildbucket for the build status
[02:46:35.664] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:35.664] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:251:0) after 1m0s
[02:47:35.716] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:251:0)
[02:47:35.716] Timer tick, asking Buildbucket for the build status
[02:47:35.796] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:35.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:252:0) after 1m0s
[02:48:35.833] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:252:0)
[02:48:35.833] Timer tick, asking Buildbucket for the build status
[02:48:35.892] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:35.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:253:0) after 1m0s
[02:49:35.919] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:253:0)
[02:49:35.919] Timer tick, asking Buildbucket for the build status
[02:49:35.995] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:35.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:254:0) after 1m0s
[02:50:36.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:254:0)
[02:50:36.025] Timer tick, asking Buildbucket for the build status
[02:50:36.097] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:36.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:255:0) after 1m0s
[02:51:36.124] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:255:0)
[02:51:36.124] Timer tick, asking Buildbucket for the build status
[02:51:36.167] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:36.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:256:0) after 1m0s
[02:52:36.213] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:256:0)
[02:52:36.213] Timer tick, asking Buildbucket for the build status
[02:52:36.490] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:36.490] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:257:0) after 1m0s
[02:53:36.517] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:257:0)
[02:53:36.517] Timer tick, asking Buildbucket for the build status
[02:53:36.671] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:36.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:258:0) after 1m0s
[02:54:36.699] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:258:0)
[02:54:36.699] Timer tick, asking Buildbucket for the build status
[02:54:36.758] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:36.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:259:0) after 1m0s
[02:55:36.783] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:259:0)
[02:55:36.783] Timer tick, asking Buildbucket for the build status
[02:55:37.029] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:37.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:260:0) after 1m0s
[02:56:37.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:260:0)
[02:56:37.071] Timer tick, asking Buildbucket for the build status
[02:56:37.203] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:37.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:261:0) after 1m0s
[02:57:37.242] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:261:0)
[02:57:37.242] Timer tick, asking Buildbucket for the build status
[02:57:37.373] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:37.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:262:0) after 1m0s
[02:58:37.404] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:262:0)
[02:58:37.404] Timer tick, asking Buildbucket for the build status
[02:58:37.468] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:37.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:263:0) after 1m0s
[02:59:37.526] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:263:0)
[02:59:37.526] Timer tick, asking Buildbucket for the build status
[02:59:37.604] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:37.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:264:0) after 1m0s
[03:00:37.811] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:264:0)
[03:00:37.811] Timer tick, asking Buildbucket for the build status
[03:00:37.980] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:37.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:265:0) after 1m0s
[03:01:38.047] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:265:0)
[03:01:38.047] Timer tick, asking Buildbucket for the build status
[03:01:38.112] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:38.112] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:266:0) after 1m0s
[03:02:38.156] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:266:0)
[03:02:38.156] Timer tick, asking Buildbucket for the build status
[03:02:38.295] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:38.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:267:0) after 1m0s
[03:03:38.333] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:267:0)
[03:03:38.333] Timer tick, asking Buildbucket for the build status
[03:03:38.398] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:38.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:268:0) after 1m0s
[03:04:38.428] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:268:0)
[03:04:38.428] Timer tick, asking Buildbucket for the build status
[03:04:38.550] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:38.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:269:0) after 1m0s
[03:05:38.661] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:269:0)
[03:05:38.661] Timer tick, asking Buildbucket for the build status
[03:05:38.710] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:38.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:270:0) after 1m0s
[03:06:38.747] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:270:0)
[03:06:38.747] Timer tick, asking Buildbucket for the build status
[03:06:39.126] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:39.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:271:0) after 1m0s
[03:07:39.173] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:271:0)
[03:07:39.173] Timer tick, asking Buildbucket for the build status
[03:07:39.315] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:39.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:272:0) after 1m0s
[03:08:39.342] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:272:0)
[03:08:39.342] Timer tick, asking Buildbucket for the build status
[03:08:39.407] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:39.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:273:0) after 1m0s
[03:09:39.445] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:273:0)
[03:09:39.445] Timer tick, asking Buildbucket for the build status
[03:09:39.576] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:39.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:274:0) after 1m0s
[03:10:39.604] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:274:0)
[03:10:39.604] Timer tick, asking Buildbucket for the build status
[03:10:39.783] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:10:39.783] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:275:0) after 1m0s
[03:11:39.813] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:275:0)
[03:11:39.813] Timer tick, asking Buildbucket for the build status
[03:11:39.878] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:39.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:276:0) after 1m0s
[03:12:39.927] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:276:0)
[03:12:39.927] Timer tick, asking Buildbucket for the build status
[03:12:39.964] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:39.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:277:0) after 1m0s
[03:13:40.000] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:277:0)
[03:13:40.000] Timer tick, asking Buildbucket for the build status
[03:13:40.063] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:40.063] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:278:0) after 1m0s
[03:14:40.094] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:278:0)
[03:14:40.094] Timer tick, asking Buildbucket for the build status
[03:14:40.235] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:40.235] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:279:0) after 1m0s
[03:15:40.264] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:279:0)
[03:15:40.264] Timer tick, asking Buildbucket for the build status
[03:15:40.309] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:40.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:280:0) after 1m0s
[03:16:40.338] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:280:0)
[03:16:40.338] Timer tick, asking Buildbucket for the build status
[03:16:40.476] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:40.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:281:0) after 1m0s
[03:17:40.519] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:281:0)
[03:17:40.519] Timer tick, asking Buildbucket for the build status
[03:17:40.776] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:40.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:282:0) after 1m0s
[03:18:40.815] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:282:0)
[03:18:40.815] Timer tick, asking Buildbucket for the build status
[03:18:40.879] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:40.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:283:0) after 1m0s
[03:19:40.946] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:283:0)
[03:19:40.946] Timer tick, asking Buildbucket for the build status
[03:19:41.254] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:41.254] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:284:0) after 1m0s
[03:20:41.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:284:0)
[03:20:41.280] Timer tick, asking Buildbucket for the build status
[03:20:41.347] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:41.347] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:285:0) after 1m0s
[03:21:41.382] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:285:0)
[03:21:41.382] Timer tick, asking Buildbucket for the build status
[03:21:41.459] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:41.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:286:0) after 1m0s
[03:22:41.492] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:286:0)
[03:22:41.492] Timer tick, asking Buildbucket for the build status
[03:22:41.618] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:41.618] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:287:0) after 1m0s
[03:23:41.644] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:287:0)
[03:23:41.644] Timer tick, asking Buildbucket for the build status
[03:23:41.735] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:23:41.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:288:0) after 1m0s
[03:24:41.768] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:288:0)
[03:24:41.768] Timer tick, asking Buildbucket for the build status
[03:24:41.883] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:24:41.883] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:289:0) after 1m0s
[03:25:41.914] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:289:0)
[03:25:41.914] Timer tick, asking Buildbucket for the build status
[03:25:41.966] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:41.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:290:0) after 1m0s
[03:26:41.994] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:290:0)
[03:26:41.994] Timer tick, asking Buildbucket for the build status
[03:26:42.086] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:42.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:291:0) after 1m0s
[03:27:42.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:291:0)
[03:27:42.149] Timer tick, asking Buildbucket for the build status
[03:27:42.251] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:27:42.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:292:0) after 1m0s
[03:28:42.278] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:292:0)
[03:28:42.278] Timer tick, asking Buildbucket for the build status
[03:28:42.312] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:28:42.312] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:293:0) after 1m0s
[03:29:42.334] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:293:0)
[03:29:42.334] Timer tick, asking Buildbucket for the build status
[03:29:42.398] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:42.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:294:0) after 1m0s
[03:30:42.449] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:294:0)
[03:30:42.449] Timer tick, asking Buildbucket for the build status
[03:30:42.508] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:42.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:295:0) after 1m0s
[03:31:42.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:295:0)
[03:31:42.553] Timer tick, asking Buildbucket for the build status
[03:31:42.675] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:42.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:296:0) after 1m0s
[03:32:42.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:296:0)
[03:32:42.740] Timer tick, asking Buildbucket for the build status
[03:32:42.796] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:42.796] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:297:0) after 1m0s
[03:33:42.828] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:297:0)
[03:33:42.828] Timer tick, asking Buildbucket for the build status
[03:33:42.896] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:33:42.896] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:298:0) after 1m0s
[03:34:42.924] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:298:0)
[03:34:42.924] Timer tick, asking Buildbucket for the build status
[03:34:42.975] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:42.975] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:299:0) after 1m0s
[03:35:43.004] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:299:0)
[03:35:43.004] Timer tick, asking Buildbucket for the build status
[03:35:43.367] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:43.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:300:0) after 1m0s
[03:36:43.406] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:300:0)
[03:36:43.406] Timer tick, asking Buildbucket for the build status
[03:36:43.486] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:43.486] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:301:0) after 1m0s
[03:37:43.524] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:301:0)
[03:37:43.524] Timer tick, asking Buildbucket for the build status
[03:37:43.639] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:43.639] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:302:0) after 1m0s
[03:38:43.678] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:302:0)
[03:38:43.678] Timer tick, asking Buildbucket for the build status
[03:38:43.722] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:43.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:303:0) after 1m0s
[03:39:43.765] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:303:0)
[03:39:43.765] Timer tick, asking Buildbucket for the build status
[03:39:43.864] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:43.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:304:0) after 1m0s
[03:40:43.928] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:304:0)
[03:40:43.928] Timer tick, asking Buildbucket for the build status
[03:40:43.966] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:40:43.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:305:0) after 1m0s
[03:41:43.994] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:305:0)
[03:41:43.994] Timer tick, asking Buildbucket for the build status
[03:41:44.110] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:44.110] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:306:0) after 1m0s
[03:42:44.140] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:306:0)
[03:42:44.140] Timer tick, asking Buildbucket for the build status
[03:42:44.210] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:44.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:307:0) after 1m0s
[03:43:44.254] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:307:0)
[03:43:44.254] Timer tick, asking Buildbucket for the build status
[03:43:44.307] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:44.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:308:0) after 1m0s
[03:44:44.351] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:308:0)
[03:44:44.352] Timer tick, asking Buildbucket for the build status
[03:44:44.414] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:44.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:309:0) after 1m0s
[03:45:44.450] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:309:0)
[03:45:44.450] Timer tick, asking Buildbucket for the build status
[03:45:44.509] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:44.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:310:0) after 1m0s
[03:46:44.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:310:0)
[03:46:44.536] Timer tick, asking Buildbucket for the build status
[03:46:44.719] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:44.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:311:0) after 1m0s
[03:47:44.784] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:311:0)
[03:47:44.784] Timer tick, asking Buildbucket for the build status
[03:47:44.956] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:44.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:312:0) after 1m0s
[03:48:44.991] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:312:0)
[03:48:44.991] Timer tick, asking Buildbucket for the build status
[03:48:45.058] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:45.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:313:0) after 1m0s
[03:49:45.090] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:313:0)
[03:49:45.090] Timer tick, asking Buildbucket for the build status
[03:49:45.232] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:45.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:314:0) after 1m0s
[03:50:45.260] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:314:0)
[03:50:45.260] Timer tick, asking Buildbucket for the build status
[03:50:45.457] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:50:45.457] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:315:0) after 1m0s
[03:51:45.489] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:315:0)
[03:51:45.489] Timer tick, asking Buildbucket for the build status
[03:51:45.542] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:51:45.542] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:316:0) after 1m0s
[03:52:45.593] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:316:0)
[03:52:45.593] Timer tick, asking Buildbucket for the build status
[03:52:45.651] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:45.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:317:0) after 1m0s
[03:53:45.677] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:317:0)
[03:53:45.677] Timer tick, asking Buildbucket for the build status
[03:53:45.740] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:45.740] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:318:0) after 1m0s
[03:54:45.813] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:318:0)
[03:54:45.813] Timer tick, asking Buildbucket for the build status
[03:54:45.877] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:45.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:319:0) after 1m0s
[03:55:45.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:319:0)
[03:55:45.971] Timer tick, asking Buildbucket for the build status
[03:55:46.037] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:46.037] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:320:0) after 1m0s
[03:56:46.117] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:320:0)
[03:56:46.117] Timer tick, asking Buildbucket for the build status
[03:56:46.312] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:46.312] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:321:0) after 1m0s
[03:57:46.355] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:321:0)
[03:57:46.355] Timer tick, asking Buildbucket for the build status
[03:57:46.439] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:46.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:322:0) after 1m0s
[03:58:46.515] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:322:0)
[03:58:46.515] Timer tick, asking Buildbucket for the build status
[03:58:46.609] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:46.609] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:323:0) after 1m0s
[03:59:46.648] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:323:0)
[03:59:46.648] Timer tick, asking Buildbucket for the build status
[03:59:46.790] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:59:46.790] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:324:0) after 1m0s
[04:00:46.829] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:324:0)
[04:00:46.829] Timer tick, asking Buildbucket for the build status
[04:00:46.899] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:00:46.899] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:325:0) after 1m0s
[04:01:46.930] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:325:0)
[04:01:46.930] Timer tick, asking Buildbucket for the build status
[04:01:46.998] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:46.998] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:326:0) after 1m0s
[04:02:47.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:326:0)
[04:02:47.088] Timer tick, asking Buildbucket for the build status
[04:02:47.240] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:47.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:327:0) after 1m0s
[04:03:47.285] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:327:0)
[04:03:47.285] Timer tick, asking Buildbucket for the build status
[04:03:47.403] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:47.403] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:328:0) after 1m0s
[04:04:47.431] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:328:0)
[04:04:47.431] Timer tick, asking Buildbucket for the build status
[04:04:47.507] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:47.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:329:0) after 1m0s
[04:05:47.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:329:0)
[04:05:47.569] Timer tick, asking Buildbucket for the build status
[04:05:47.615] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:47.615] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:330:0) after 1m0s
[04:06:47.653] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:330:0)
[04:06:47.653] Timer tick, asking Buildbucket for the build status
[04:06:47.788] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:47.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:331:0) after 1m0s
[04:07:47.811] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:331:0)
[04:07:47.811] Timer tick, asking Buildbucket for the build status
[04:07:47.856] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:47.856] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:332:0) after 1m0s
[04:08:47.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:332:0)
[04:08:47.894] Timer tick, asking Buildbucket for the build status
[04:08:48.054] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:48.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:333:0) after 1m0s
[04:09:48.146] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:333:0)
[04:09:48.146] Timer tick, asking Buildbucket for the build status
[04:09:48.246] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:48.246] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:334:0) after 1m0s
[04:10:48.272] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:334:0)
[04:10:48.272] Timer tick, asking Buildbucket for the build status
[04:10:48.310] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:48.310] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:335:0) after 1m0s
[04:11:48.422] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:335:0)
[04:11:48.422] Timer tick, asking Buildbucket for the build status
[04:11:48.489] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:48.489] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:336:0) after 1m0s
[04:12:48.547] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:336:0)
[04:12:48.547] Timer tick, asking Buildbucket for the build status
[04:12:48.610] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:48.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:337:0) after 1m0s
[04:13:48.669] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:337:0)
[04:13:48.669] Timer tick, asking Buildbucket for the build status
[04:13:48.735] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:48.735] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:338:0) after 1m0s
[04:14:48.818] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:338:0)
[04:14:48.818] Timer tick, asking Buildbucket for the build status
[04:14:48.873] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:48.874] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:339:0) after 1m0s
[04:15:48.913] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:339:0)
[04:15:48.913] Timer tick, asking Buildbucket for the build status
[04:15:49.088] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:49.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:340:0) after 1m0s
[04:16:49.118] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:340:0)
[04:16:49.118] Timer tick, asking Buildbucket for the build status
[04:16:49.374] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:49.374] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:341:0) after 1m0s
[04:17:49.404] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:341:0)
[04:17:49.404] Timer tick, asking Buildbucket for the build status
[04:17:49.464] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:49.464] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:342:0) after 1m0s
[04:18:49.531] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:342:0)
[04:18:49.531] Timer tick, asking Buildbucket for the build status
[04:18:49.587] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:49.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:343:0) after 1m0s
[04:19:49.686] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:343:0)
[04:19:49.686] Timer tick, asking Buildbucket for the build status
[04:19:49.768] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:49.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:344:0) after 1m0s
[04:20:49.796] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:344:0)
[04:20:49.796] Timer tick, asking Buildbucket for the build status
[04:20:49.835] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:49.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:345:0) after 1m0s
[04:21:49.862] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:345:0)
[04:21:49.862] Timer tick, asking Buildbucket for the build status
[04:21:50.047] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:50.047] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:346:0) after 1m0s
[04:22:50.110] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:346:0)
[04:22:50.110] Timer tick, asking Buildbucket for the build status
[04:22:50.218] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:50.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:347:0) after 1m0s
[04:23:50.278] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:347:0)
[04:23:50.278] Timer tick, asking Buildbucket for the build status
[04:23:50.312] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:50.312] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:348:0) after 1m0s
[04:24:50.352] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:348:0)
[04:24:50.352] Timer tick, asking Buildbucket for the build status
[04:24:50.441] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:50.441] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:349:0) after 1m0s
[04:25:50.480] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:349:0)
[04:25:50.480] Timer tick, asking Buildbucket for the build status
[04:25:50.556] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:50.556] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:350:0) after 1m0s
[04:26:50.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:350:0)
[04:26:50.616] Timer tick, asking Buildbucket for the build status
[04:26:50.661] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:50.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:351:0) after 1m0s
[04:27:50.689] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:351:0)
[04:27:50.689] Timer tick, asking Buildbucket for the build status
[04:27:50.758] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:50.758] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:352:0) after 1m0s
[04:28:50.816] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:352:0)
[04:28:50.816] Timer tick, asking Buildbucket for the build status
[04:28:50.854] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:50.854] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:353:0) after 1m0s
[04:29:50.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:353:0)
[04:29:50.894] Timer tick, asking Buildbucket for the build status
[04:29:51.080] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:51.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:354:0) after 1m0s
[04:30:51.112] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:354:0)
[04:30:51.112] Timer tick, asking Buildbucket for the build status
[04:30:51.175] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:51.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:355:0) after 1m0s
[04:31:51.260] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:355:0)
[04:31:51.260] Timer tick, asking Buildbucket for the build status
[04:31:51.369] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:51.369] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:356:0) after 1m0s
[04:32:51.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:356:0)
[04:32:51.398] Timer tick, asking Buildbucket for the build status
[04:32:51.532] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:51.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:357:0) after 1m0s
[04:33:51.579] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:357:0)
[04:33:51.579] Timer tick, asking Buildbucket for the build status
[04:33:51.645] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:51.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:358:0) after 1m0s
[04:34:51.699] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:358:0)
[04:34:51.699] Timer tick, asking Buildbucket for the build status
[04:34:51.753] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:51.753] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:359:0) after 1m0s
[04:35:51.839] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:359:0)
[04:35:51.839] Timer tick, asking Buildbucket for the build status
[04:35:51.893] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:51.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:360:0) after 1m0s
[04:36:51.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:360:0)
[04:36:51.921] Timer tick, asking Buildbucket for the build status
[04:36:51.969] Build 8935550703885801520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:51.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9100980766408657232:361:0) after 1m0s
[04:37:07.147] Received PubSub notification, asking Buildbucket for the build status
[04:37:07.352] Build 8935550703885801520: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[04:37:07.352] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "cancelation_reason": "TIMEOUT",
    "completed_ts": "1536813425889607",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1536791812966658",
    "experimental": true,
    "id": "8935550703885801520",
    "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\": \"32b6deb45d5fbc77c5f65d35db45c48cae3c06bc\"}}",
    "project": "nacl",
    "result": "CANCELED",
    "result_details_json": "{\"swarming\": {\"bot_dimensions\": {}}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "COMPLETED",
    "status_changed_ts": "1536813426546146",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/3",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9100980766408657232",
      "scheduler_job_id:nacl/linux-pnacl-x86_64",
      "swarming_dimension:caches:builder_c4fb8a21f9264ee89d0c9acaafd50c7c6d9e2973bab8e8b102bc138e7852d256_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/3",
      "swarming_tag:buildbucket_bucket:luci.nacl.toolchain",
      "swarming_tag:buildbucket_build_id:8935550703885801520",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
      "swarming_tag:builder:linux-pnacl-x86_64",
      "swarming_tag:buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "swarming_tag:caches:builder_c4fb8a21f9264ee89d0c9acaafd50c7c6d9e2973bab8e8b102bc138e7852d256_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/8935550703885801520/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:pool:luci.nacl.toolchain",
      "swarming_tag:priority:60",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_tag:scheduler_invocation_id:9100980766408657232",
      "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:ccd94b661aaeb4cc141585f6f7be3f211386159f",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3fe8bfa747f93a10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1536813426549785",
    "url": "https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64/3",
    "utcnow_ts": "1536813427259858"
  }
}
[04:37:07.352] Invocation finished in 6h0m16.175801659s with status FAILED