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

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

99673869a3cd8731d924bd32fa486feebfdc6c4f (6 years ago)

Incoming properties

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

Incoming tags

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

Debug log (UTC)

[23:17:43.269] New invocation is queued and will start shortly
[23:17:44.619] Starting the invocation (attempt 1)
[23:17:44.667] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:17:44.668] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:17:44.668] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9097897898363383392",
  "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\":\"99673869a3cd8731d924bd32fa486feebfdc6c4f\"}}",
  "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:9097897898363383392",
    "scheduler_job_id:nacl/linux-pnacl-x86_64",
    "user_agent:luci-scheduler",
    "buildset:commit/git/99673869a3cd8731d924bd32fa486feebfdc6c4f",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/99673869a3cd8731d924bd32fa486feebfdc6c4f",
    "gitiles_ref:refs/heads/master"
  ]
}
[23:17:45.808] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1539731864782855",
    "experimental": true,
    "id": "8932467836112943136",
    "lease_expiration_ts": "1539850665489804",
    "lease_key": "336014114",
    "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\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1539731865699919",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/8",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/99673869a3cd8731d924bd32fa486feebfdc6c4f",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/99673869a3cd8731d924bd32fa486feebfdc6c4f",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9097897898363383392",
      "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/8",
      "swarming_tag:buildbucket_bucket:luci.nacl.toolchain",
      "swarming_tag:buildbucket_build_id:8932467836112943136",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
      "swarming_tag:builder:linux-pnacl-x86_64",
      "swarming_tag:buildset:commit/git/99673869a3cd8731d924bd32fa486feebfdc6c4f",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/99673869a3cd8731d924bd32fa486feebfdc6c4f",
      "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/8932467836112943136/+/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:9097897898363383392",
      "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:82431e273d2f347205266ff4363205d6de25e0ad",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4097fd46afd82b10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1539731865700004",
    "url": "https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64/8",
    "utcnow_ts": "1539731865780063"
  }
}
[23:17:45.808] Task URL: https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64/8
[23:17:45.808] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:2:0) after 1m0s
[23:18:45.842] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:2:0)
[23:18:45.842] Timer tick, asking Buildbucket for the build status
[23:18:46.057] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:46.057] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:3:0) after 1m0s
[23:19:46.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:3:0)
[23:19:46.207] Timer tick, asking Buildbucket for the build status
[23:19:46.270] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:46.270] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:4:0) after 1m0s
[23:20:46.304] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:4:0)
[23:20:46.304] Timer tick, asking Buildbucket for the build status
[23:20:46.407] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:46.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:5:0) after 1m0s
[23:21:46.424] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:5:0)
[23:21:46.424] Timer tick, asking Buildbucket for the build status
[23:21:46.550] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:46.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:6:0) after 1m0s
[23:22:46.564] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:6:0)
[23:22:46.564] Timer tick, asking Buildbucket for the build status
[23:22:46.609] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:46.609] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:7:0) after 1m0s
[23:23:46.631] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:7:0)
[23:23:46.631] Timer tick, asking Buildbucket for the build status
[23:23:46.698] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:46.698] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:8:0) after 1m0s
[23:24:46.714] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:8:0)
[23:24:46.715] Timer tick, asking Buildbucket for the build status
[23:24:46.745] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:46.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:9:0) after 1m0s
[23:25:46.780] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:9:0)
[23:25:46.780] Timer tick, asking Buildbucket for the build status
[23:25:47.054] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:47.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:10:0) after 1m0s
[23:26:47.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:10:0)
[23:26:47.071] Timer tick, asking Buildbucket for the build status
[23:26:47.117] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:47.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:11:0) after 1m0s
[23:27:47.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:11:0)
[23:27:47.149] Timer tick, asking Buildbucket for the build status
[23:27:47.206] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:47.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:12:0) after 1m0s
[23:28:47.255] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:12:0)
[23:28:47.255] Timer tick, asking Buildbucket for the build status
[23:28:47.342] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:47.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:13:0) after 1m0s
[23:29:47.360] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:13:0)
[23:29:47.360] Timer tick, asking Buildbucket for the build status
[23:29:47.513] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:47.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:14:0) after 1m0s
[23:30:47.529] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:14:0)
[23:30:47.529] Timer tick, asking Buildbucket for the build status
[23:30:47.569] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:47.569] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:15:0) after 1m0s
[23:31:47.589] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:15:0)
[23:31:47.589] Timer tick, asking Buildbucket for the build status
[23:31:47.633] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:47.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:16:0) after 1m0s
[23:32:47.651] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:16:0)
[23:32:47.651] Timer tick, asking Buildbucket for the build status
[23:32:47.714] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:47.714] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:17:0) after 1m0s
[23:33:47.751] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:17:0)
[23:33:47.751] Timer tick, asking Buildbucket for the build status
[23:33:47.904] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:47.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:18:0) after 1m0s
[23:34:47.924] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:18:0)
[23:34:47.924] Timer tick, asking Buildbucket for the build status
[23:34:48.033] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:48.033] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:19:0) after 1m0s
[23:35:48.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:19:0)
[23:35:48.072] Timer tick, asking Buildbucket for the build status
[23:35:48.152] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:48.152] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:20:0) after 1m0s
[23:36:48.176] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:20:0)
[23:36:48.176] Timer tick, asking Buildbucket for the build status
[23:36:48.302] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:48.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:21:0) after 1m0s
[23:37:48.324] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:21:0)
[23:37:48.324] Timer tick, asking Buildbucket for the build status
[23:37:48.385] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:48.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:22:0) after 1m0s
[23:38:48.401] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:22:0)
[23:38:48.401] Timer tick, asking Buildbucket for the build status
[23:38:48.521] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:48.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:23:0) after 1m0s
[23:39:48.560] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:23:0)
[23:39:48.560] Timer tick, asking Buildbucket for the build status
[23:39:48.620] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:48.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:24:0) after 1m0s
[23:40:48.636] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:24:0)
[23:40:48.636] Timer tick, asking Buildbucket for the build status
[23:40:48.673] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:48.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:25:0) after 1m0s
[23:41:48.737] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:25:0)
[23:41:48.737] Timer tick, asking Buildbucket for the build status
[23:41:48.773] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:48.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:26:0) after 1m0s
[23:42:48.790] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:26:0)
[23:42:48.790] Timer tick, asking Buildbucket for the build status
[23:42:48.857] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:48.857] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:27:0) after 1m0s
[23:43:48.948] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:27:0)
[23:43:48.948] Timer tick, asking Buildbucket for the build status
[23:43:49.008] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:49.008] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:28:0) after 1m0s
[23:44:49.030] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:28:0)
[23:44:49.030] Timer tick, asking Buildbucket for the build status
[23:44:49.072] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:49.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:29:0) after 1m0s
[23:45:49.106] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:29:0)
[23:45:49.106] Timer tick, asking Buildbucket for the build status
[23:45:49.205] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:49.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:30:0) after 1m0s
[23:46:49.221] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:30:0)
[23:46:49.221] Timer tick, asking Buildbucket for the build status
[23:46:49.361] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:49.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:31:0) after 1m0s
[23:47:49.382] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:31:0)
[23:47:49.382] Timer tick, asking Buildbucket for the build status
[23:47:49.425] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:49.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:32:0) after 1m0s
[23:48:49.443] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:32:0)
[23:48:49.443] Timer tick, asking Buildbucket for the build status
[23:48:49.483] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:49.483] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:33:0) after 1m0s
[23:49:49.510] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:33:0)
[23:49:49.510] Timer tick, asking Buildbucket for the build status
[23:49:49.717] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:49.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:34:0) after 1m0s
[23:50:49.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:34:0)
[23:50:49.735] Timer tick, asking Buildbucket for the build status
[23:50:49.918] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:49.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:35:0) after 1m0s
[23:51:49.936] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:35:0)
[23:51:49.936] Timer tick, asking Buildbucket for the build status
[23:51:50.003] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:50.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:36:0) after 1m0s
[23:52:50.045] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:36:0)
[23:52:50.045] Timer tick, asking Buildbucket for the build status
[23:52:50.105] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:50.105] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:37:0) after 1m0s
[23:53:50.172] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:37:0)
[23:53:50.172] Timer tick, asking Buildbucket for the build status
[23:53:50.218] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:50.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:38:0) after 1m0s
[23:54:50.257] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:38:0)
[23:54:50.257] Timer tick, asking Buildbucket for the build status
[23:54:50.365] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:50.365] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:39:0) after 1m0s
[23:55:50.381] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:39:0)
[23:55:50.381] Timer tick, asking Buildbucket for the build status
[23:55:50.494] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:50.494] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:40:0) after 1m0s
[23:56:50.512] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:40:0)
[23:56:50.512] Timer tick, asking Buildbucket for the build status
[23:56:50.620] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:50.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:41:0) after 1m0s
[23:57:50.644] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:41:0)
[23:57:50.644] Timer tick, asking Buildbucket for the build status
[23:57:50.801] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:50.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:42:0) after 1m0s
[23:58:50.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:42:0)
[23:58:50.871] Timer tick, asking Buildbucket for the build status
[23:58:50.956] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:50.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:43:0) after 1m0s
[23:59:50.977] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:43:0)
[23:59:50.977] Timer tick, asking Buildbucket for the build status
[23:59:51.117] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:51.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:44:0) after 1m0s
[00:00:51.137] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:44:0)
[00:00:51.137] Timer tick, asking Buildbucket for the build status
[00:00:51.177] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:51.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:45:0) after 1m0s
[00:01:51.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:45:0)
[00:01:51.202] Timer tick, asking Buildbucket for the build status
[00:01:51.277] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:51.277] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:46:0) after 1m0s
[00:02:51.297] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:46:0)
[00:02:51.297] Timer tick, asking Buildbucket for the build status
[00:02:51.427] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:51.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:47:0) after 1m0s
[00:03:51.453] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:47:0)
[00:03:51.453] Timer tick, asking Buildbucket for the build status
[00:03:51.628] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:51.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:48:0) after 1m0s
[00:04:51.658] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:48:0)
[00:04:51.658] Timer tick, asking Buildbucket for the build status
[00:04:51.868] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:51.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:49:0) after 1m0s
[00:05:51.961] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:49:0)
[00:05:51.961] Timer tick, asking Buildbucket for the build status
[00:05:52.029] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:52.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:50:0) after 1m0s
[00:06:52.071] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:50:0)
[00:06:52.071] Timer tick, asking Buildbucket for the build status
[00:06:52.187] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:52.187] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:51:0) after 1m0s
[00:07:52.208] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:51:0)
[00:07:52.208] Timer tick, asking Buildbucket for the build status
[00:07:52.358] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:52.358] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:52:0) after 1m0s
[00:08:52.446] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:52:0)
[00:08:52.446] Timer tick, asking Buildbucket for the build status
[00:08:52.554] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:52.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:53:0) after 1m0s
[00:09:52.582] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:53:0)
[00:09:52.582] Timer tick, asking Buildbucket for the build status
[00:09:52.652] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:52.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:54:0) after 1m0s
[00:10:52.781] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:54:0)
[00:10:52.781] Timer tick, asking Buildbucket for the build status
[00:10:52.831] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:52.831] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:55:0) after 1m0s
[00:11:52.855] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:55:0)
[00:11:52.855] Timer tick, asking Buildbucket for the build status
[00:11:52.920] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:52.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:56:0) after 1m0s
[00:12:52.941] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:56:0)
[00:12:52.941] Timer tick, asking Buildbucket for the build status
[00:12:53.014] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:53.014] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:57:0) after 1m0s
[00:13:53.050] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:57:0)
[00:13:53.050] Timer tick, asking Buildbucket for the build status
[00:13:53.129] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:53.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:58:0) after 1m0s
[00:14:53.149] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:58:0)
[00:14:53.149] Timer tick, asking Buildbucket for the build status
[00:14:53.213] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:53.213] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:59:0) after 1m0s
[00:15:53.235] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:59:0)
[00:15:53.235] Timer tick, asking Buildbucket for the build status
[00:15:53.336] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:53.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:60:0) after 1m0s
[00:16:53.515] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:60:0)
[00:16:53.515] Timer tick, asking Buildbucket for the build status
[00:16:53.584] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:53.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:61:0) after 1m0s
[00:17:53.604] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:61:0)
[00:17:53.604] Timer tick, asking Buildbucket for the build status
[00:17:53.673] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:53.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:62:0) after 1m0s
[00:18:53.752] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:62:0)
[00:18:53.752] Timer tick, asking Buildbucket for the build status
[00:18:53.872] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:53.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:63:0) after 1m0s
[00:19:53.890] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:63:0)
[00:19:53.890] Timer tick, asking Buildbucket for the build status
[00:19:54.075] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:54.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:64:0) after 1m0s
[00:20:54.095] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:64:0)
[00:20:54.095] Timer tick, asking Buildbucket for the build status
[00:20:54.327] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:54.327] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:65:0) after 1m0s
[00:21:54.350] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:65:0)
[00:21:54.350] Timer tick, asking Buildbucket for the build status
[00:21:54.624] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:54.625] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:66:0) after 1m0s
[00:22:54.643] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:66:0)
[00:22:54.643] Timer tick, asking Buildbucket for the build status
[00:22:54.721] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:54.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:67:0) after 1m0s
[00:23:54.831] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:67:0)
[00:23:54.831] Timer tick, asking Buildbucket for the build status
[00:23:54.992] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:54.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:68:0) after 1m0s
[00:24:55.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:68:0)
[00:24:55.018] Timer tick, asking Buildbucket for the build status
[00:24:56.619] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:56.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:69:0) after 1m0s
[00:25:56.638] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:69:0)
[00:25:56.638] Timer tick, asking Buildbucket for the build status
[00:25:56.710] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:56.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:70:0) after 1m0s
[00:26:56.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:70:0)
[00:26:56.735] Timer tick, asking Buildbucket for the build status
[00:26:56.771] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:56.771] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:71:0) after 1m0s
[00:27:56.875] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:71:0)
[00:27:56.875] Timer tick, asking Buildbucket for the build status
[00:27:56.989] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:56.989] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:72:0) after 1m0s
[00:28:57.007] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:72:0)
[00:28:57.007] Timer tick, asking Buildbucket for the build status
[00:28:57.126] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:57.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:73:0) after 1m0s
[00:29:57.146] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:73:0)
[00:29:57.146] Timer tick, asking Buildbucket for the build status
[00:29:57.224] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:57.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:74:0) after 1m0s
[00:30:57.243] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:74:0)
[00:30:57.243] Timer tick, asking Buildbucket for the build status
[00:30:57.307] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:57.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:75:0) after 1m0s
[00:31:57.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:75:0)
[00:31:57.414] Timer tick, asking Buildbucket for the build status
[00:31:57.459] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:57.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:76:0) after 1m0s
[00:32:57.489] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:76:0)
[00:32:57.489] Timer tick, asking Buildbucket for the build status
[00:32:57.595] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:57.596] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:77:0) after 1m0s
[00:33:57.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:77:0)
[00:33:57.616] Timer tick, asking Buildbucket for the build status
[00:33:57.709] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:57.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:78:0) after 1m0s
[00:34:57.759] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:78:0)
[00:34:57.759] Timer tick, asking Buildbucket for the build status
[00:34:57.847] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:57.847] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:79:0) after 1m0s
[00:35:57.866] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:79:0)
[00:35:57.866] Timer tick, asking Buildbucket for the build status
[00:35:57.945] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:57.945] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:80:0) after 1m0s
[00:36:57.964] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:80:0)
[00:36:57.964] Timer tick, asking Buildbucket for the build status
[00:36:58.000] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:58.000] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:81:0) after 1m0s
[00:37:58.030] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:81:0)
[00:37:58.030] Timer tick, asking Buildbucket for the build status
[00:37:58.160] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:58.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:82:0) after 1m0s
[00:38:58.252] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:82:0)
[00:38:58.252] Timer tick, asking Buildbucket for the build status
[00:38:58.294] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:58.294] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:83:0) after 1m0s
[00:39:58.346] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:83:0)
[00:39:58.346] Timer tick, asking Buildbucket for the build status
[00:39:58.382] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:58.382] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:84:0) after 1m0s
[00:40:58.461] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:84:0)
[00:40:58.461] Timer tick, asking Buildbucket for the build status
[00:40:58.529] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:58.529] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:85:0) after 1m0s
[00:41:58.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:85:0)
[00:41:58.553] Timer tick, asking Buildbucket for the build status
[00:41:58.619] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:58.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:86:0) after 1m0s
[00:42:58.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:86:0)
[00:42:58.722] Timer tick, asking Buildbucket for the build status
[00:42:58.831] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:58.831] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:87:0) after 1m0s
[00:43:58.864] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:87:0)
[00:43:58.864] Timer tick, asking Buildbucket for the build status
[00:43:58.922] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:58.922] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:88:0) after 1m0s
[00:44:58.955] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:88:0)
[00:44:58.955] Timer tick, asking Buildbucket for the build status
[00:44:59.041] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:59.041] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:89:0) after 1m0s
[00:45:59.064] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:89:0)
[00:45:59.064] Timer tick, asking Buildbucket for the build status
[00:45:59.153] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:59.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:90:0) after 1m0s
[00:46:59.269] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:90:0)
[00:46:59.269] Timer tick, asking Buildbucket for the build status
[00:46:59.307] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:59.307] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:91:0) after 1m0s
[00:47:59.332] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:91:0)
[00:47:59.332] Timer tick, asking Buildbucket for the build status
[00:47:59.522] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:59.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:92:0) after 1m0s
[00:48:59.627] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:92:0)
[00:48:59.627] Timer tick, asking Buildbucket for the build status
[00:48:59.705] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:59.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:93:0) after 1m0s
[00:49:59.734] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:93:0)
[00:49:59.734] Timer tick, asking Buildbucket for the build status
[00:49:59.897] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:59.897] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:94:0) after 1m0s
[00:50:59.916] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:94:0)
[00:50:59.916] Timer tick, asking Buildbucket for the build status
[00:51:00.030] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:00.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:95:0) after 1m0s
[00:52:00.073] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:95:0)
[00:52:00.073] Timer tick, asking Buildbucket for the build status
[00:52:00.166] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:00.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:96:0) after 1m0s
[00:53:00.215] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:96:0)
[00:53:00.215] Timer tick, asking Buildbucket for the build status
[00:53:00.304] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:00.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:97:0) after 1m0s
[00:54:00.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:97:0)
[00:54:00.325] Timer tick, asking Buildbucket for the build status
[00:54:00.396] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:00.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:98:0) after 1m0s
[00:55:00.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:98:0)
[00:55:00.414] Timer tick, asking Buildbucket for the build status
[00:55:00.468] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:00.468] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:99:0) after 1m0s
[00:56:00.495] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:99:0)
[00:56:00.495] Timer tick, asking Buildbucket for the build status
[00:56:00.637] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:00.637] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:100:0) after 1m0s
[00:57:00.657] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:100:0)
[00:57:00.657] Timer tick, asking Buildbucket for the build status
[00:57:00.833] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:00.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:101:0) after 1m0s
[00:58:00.854] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:101:0)
[00:58:00.854] Timer tick, asking Buildbucket for the build status
[00:58:00.918] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:00.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:102:0) after 1m0s
[00:59:00.936] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:102:0)
[00:59:00.936] Timer tick, asking Buildbucket for the build status
[00:59:01.068] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:01.068] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:103:0) after 1m0s
[01:00:01.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:103:0)
[01:00:01.127] Timer tick, asking Buildbucket for the build status
[01:00:01.195] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:01.195] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:104:0) after 1m0s
[01:01:01.226] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:104:0)
[01:01:01.226] Timer tick, asking Buildbucket for the build status
[01:01:01.322] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:01.322] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:105:0) after 1m0s
[01:02:01.375] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:105:0)
[01:02:01.375] Timer tick, asking Buildbucket for the build status
[01:02:01.615] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:01.615] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:106:0) after 1m0s
[01:03:01.644] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:106:0)
[01:03:01.644] Timer tick, asking Buildbucket for the build status
[01:03:01.795] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:01.795] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:107:0) after 1m0s
[01:04:01.820] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:107:0)
[01:04:01.820] Timer tick, asking Buildbucket for the build status
[01:04:01.946] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:01.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:108:0) after 1m0s
[01:05:01.966] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:108:0)
[01:05:01.966] Timer tick, asking Buildbucket for the build status
[01:05:02.072] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:02.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:109:0) after 1m0s
[01:06:02.096] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:109:0)
[01:06:02.097] Timer tick, asking Buildbucket for the build status
[01:06:02.290] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:02.290] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:110:0) after 1m0s
[01:07:02.315] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:110:0)
[01:07:02.315] Timer tick, asking Buildbucket for the build status
[01:07:02.718] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:02.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:111:0) after 1m0s
[01:08:02.739] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:111:0)
[01:08:02.739] Timer tick, asking Buildbucket for the build status
[01:08:02.859] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:02.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:112:0) after 1m0s
[01:09:02.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:112:0)
[01:09:02.878] Timer tick, asking Buildbucket for the build status
[01:09:02.959] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:02.959] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:113:0) after 1m0s
[01:10:02.977] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:113:0)
[01:10:02.977] Timer tick, asking Buildbucket for the build status
[01:10:03.120] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:03.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:114:0) after 1m0s
[01:11:03.150] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:114:0)
[01:11:03.150] Timer tick, asking Buildbucket for the build status
[01:11:03.244] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:03.244] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:115:0) after 1m0s
[01:12:03.264] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:115:0)
[01:12:03.264] Timer tick, asking Buildbucket for the build status
[01:12:03.357] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:03.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:116:0) after 1m0s
[01:13:03.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:116:0)
[01:13:03.396] Timer tick, asking Buildbucket for the build status
[01:13:03.463] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:03.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:117:0) after 1m0s
[01:14:03.511] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:117:0)
[01:14:03.511] Timer tick, asking Buildbucket for the build status
[01:14:03.618] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:03.618] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:118:0) after 1m0s
[01:15:03.673] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:118:0)
[01:15:03.673] Timer tick, asking Buildbucket for the build status
[01:15:03.810] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:03.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:119:0) after 1m0s
[01:16:03.836] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:119:0)
[01:16:03.836] Timer tick, asking Buildbucket for the build status
[01:16:03.951] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:03.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:120:0) after 1m0s
[01:17:04.063] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:120:0)
[01:17:04.063] Timer tick, asking Buildbucket for the build status
[01:17:04.151] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:04.151] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:121:0) after 1m0s
[01:18:04.175] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:121:0)
[01:18:04.175] Timer tick, asking Buildbucket for the build status
[01:18:04.271] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:04.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:122:0) after 1m0s
[01:19:04.301] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:122:0)
[01:19:04.301] Timer tick, asking Buildbucket for the build status
[01:19:04.377] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:04.377] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:123:0) after 1m0s
[01:20:04.856] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:123:0)
[01:20:04.856] Timer tick, asking Buildbucket for the build status
[01:20:04.951] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:04.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:124:0) after 1m0s
[01:21:04.977] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:124:0)
[01:21:04.977] Timer tick, asking Buildbucket for the build status
[01:21:05.034] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:05.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:125:0) after 1m0s
[01:22:05.082] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:125:0)
[01:22:05.082] Timer tick, asking Buildbucket for the build status
[01:22:05.181] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:05.181] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:126:0) after 1m0s
[01:23:05.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:126:0)
[01:23:05.202] Timer tick, asking Buildbucket for the build status
[01:23:05.243] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:05.243] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:127:0) after 1m0s
[01:24:05.262] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:127:0)
[01:24:05.262] Timer tick, asking Buildbucket for the build status
[01:24:05.317] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:05.317] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:128:0) after 1m0s
[01:25:05.338] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:128:0)
[01:25:05.338] Timer tick, asking Buildbucket for the build status
[01:25:05.417] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:05.417] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:129:0) after 1m0s
[01:26:05.438] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:129:0)
[01:26:05.438] Timer tick, asking Buildbucket for the build status
[01:26:05.509] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:05.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:130:0) after 1m0s
[01:27:05.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:130:0)
[01:27:05.535] Timer tick, asking Buildbucket for the build status
[01:27:05.623] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:05.623] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:131:0) after 1m0s
[01:28:05.647] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:131:0)
[01:28:05.647] Timer tick, asking Buildbucket for the build status
[01:28:05.715] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:05.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:132:0) after 1m0s
[01:29:05.736] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:132:0)
[01:29:05.736] Timer tick, asking Buildbucket for the build status
[01:29:05.852] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:05.852] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:133:0) after 1m0s
[01:30:05.878] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:133:0)
[01:30:05.878] Timer tick, asking Buildbucket for the build status
[01:30:05.972] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:05.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:134:0) after 1m0s
[01:31:05.992] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:134:0)
[01:31:05.992] Timer tick, asking Buildbucket for the build status
[01:31:06.159] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:06.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:135:0) after 1m0s
[01:32:06.197] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:135:0)
[01:32:06.197] Timer tick, asking Buildbucket for the build status
[01:32:06.239] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:06.239] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:136:0) after 1m0s
[01:33:06.267] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:136:0)
[01:33:06.267] Timer tick, asking Buildbucket for the build status
[01:33:06.331] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:06.331] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:137:0) after 1m0s
[01:34:06.374] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:137:0)
[01:34:06.374] Timer tick, asking Buildbucket for the build status
[01:34:06.504] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:06.504] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:138:0) after 1m0s
[01:35:06.528] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:138:0)
[01:35:06.528] Timer tick, asking Buildbucket for the build status
[01:35:06.597] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:06.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:139:0) after 1m0s
[01:36:06.619] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:139:0)
[01:36:06.619] Timer tick, asking Buildbucket for the build status
[01:36:06.737] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:06.737] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:140:0) after 1m0s
[01:37:06.758] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:140:0)
[01:37:06.758] Timer tick, asking Buildbucket for the build status
[01:37:06.813] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:06.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:141:0) after 1m0s
[01:38:06.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:141:0)
[01:38:06.843] Timer tick, asking Buildbucket for the build status
[01:38:06.981] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:06.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:142:0) after 1m0s
[01:39:07.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:142:0)
[01:39:07.006] Timer tick, asking Buildbucket for the build status
[01:39:07.248] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:07.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:143:0) after 1m0s
[01:40:07.272] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:143:0)
[01:40:07.272] Timer tick, asking Buildbucket for the build status
[01:40:07.344] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:07.344] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:144:0) after 1m0s
[01:41:07.364] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:144:0)
[01:41:07.364] Timer tick, asking Buildbucket for the build status
[01:41:07.449] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:07.449] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:145:0) after 1m0s
[01:42:07.561] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:145:0)
[01:42:07.561] Timer tick, asking Buildbucket for the build status
[01:42:07.619] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:07.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:146:0) after 1m0s
[01:43:07.648] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:146:0)
[01:43:07.649] Timer tick, asking Buildbucket for the build status
[01:43:07.736] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:07.736] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:147:0) after 1m0s
[01:44:07.766] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:147:0)
[01:44:07.766] Timer tick, asking Buildbucket for the build status
[01:44:07.886] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:07.886] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:148:0) after 1m0s
[01:45:07.924] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:148:0)
[01:45:07.924] Timer tick, asking Buildbucket for the build status
[01:45:08.054] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:08.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:149:0) after 1m0s
[01:46:08.150] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:149:0)
[01:46:08.150] Timer tick, asking Buildbucket for the build status
[01:46:08.205] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:08.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:150:0) after 1m0s
[01:47:08.235] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:150:0)
[01:47:08.235] Timer tick, asking Buildbucket for the build status
[01:47:08.309] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:08.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:151:0) after 1m0s
[01:48:08.332] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:151:0)
[01:48:08.332] Timer tick, asking Buildbucket for the build status
[01:48:08.407] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:08.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:152:0) after 1m0s
[01:49:08.449] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:152:0)
[01:49:08.449] Timer tick, asking Buildbucket for the build status
[01:49:08.583] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:08.583] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:153:0) after 1m0s
[01:50:08.623] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:153:0)
[01:50:08.623] Timer tick, asking Buildbucket for the build status
[01:50:08.764] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:08.764] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:154:0) after 1m0s
[01:51:08.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:154:0)
[01:51:08.787] Timer tick, asking Buildbucket for the build status
[01:51:08.842] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:08.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:155:0) after 1m0s
[01:52:08.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:155:0)
[01:52:08.871] Timer tick, asking Buildbucket for the build status
[01:52:08.933] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:08.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:156:0) after 1m0s
[01:53:08.959] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:156:0)
[01:53:08.959] Timer tick, asking Buildbucket for the build status
[01:53:09.065] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:09.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:157:0) after 1m0s
[01:54:09.087] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:157:0)
[01:54:09.087] Timer tick, asking Buildbucket for the build status
[01:54:09.169] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:09.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:158:0) after 1m0s
[01:55:09.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:158:0)
[01:55:09.202] Timer tick, asking Buildbucket for the build status
[01:55:09.251] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:09.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:159:0) after 1m0s
[01:56:09.277] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:159:0)
[01:56:09.277] Timer tick, asking Buildbucket for the build status
[01:56:09.332] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:09.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:160:0) after 1m0s
[01:57:09.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:160:0)
[01:57:09.394] Timer tick, asking Buildbucket for the build status
[01:57:09.453] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:09.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:161:0) after 1m0s
[01:58:09.488] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:161:0)
[01:58:09.488] Timer tick, asking Buildbucket for the build status
[01:58:09.649] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:09.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:162:0) after 1m0s
[01:59:09.686] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:162:0)
[01:59:09.686] Timer tick, asking Buildbucket for the build status
[01:59:09.746] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:09.746] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:163:0) after 1m0s
[02:00:09.806] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:163:0)
[02:00:09.806] Timer tick, asking Buildbucket for the build status
[02:00:09.937] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:09.937] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:164:0) after 1m0s
[02:01:09.993] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:164:0)
[02:01:09.993] Timer tick, asking Buildbucket for the build status
[02:01:10.137] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:10.137] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:165:0) after 1m0s
[02:02:10.227] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:165:0)
[02:02:10.227] Timer tick, asking Buildbucket for the build status
[02:02:10.574] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:10.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:166:0) after 1m0s
[02:03:10.618] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:166:0)
[02:03:10.618] Timer tick, asking Buildbucket for the build status
[02:03:10.687] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:10.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:167:0) after 1m0s
[02:04:10.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:167:0)
[02:04:10.715] Timer tick, asking Buildbucket for the build status
[02:04:10.757] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:10.757] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:168:0) after 1m0s
[02:05:10.796] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:168:0)
[02:05:10.796] Timer tick, asking Buildbucket for the build status
[02:05:10.963] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:10.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:169:0) after 1m0s
[02:06:10.990] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:169:0)
[02:06:10.990] Timer tick, asking Buildbucket for the build status
[02:06:11.125] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:11.125] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:170:0) after 1m0s
[02:07:11.148] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:170:0)
[02:07:11.148] Timer tick, asking Buildbucket for the build status
[02:07:11.272] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:11.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:171:0) after 1m0s
[02:08:11.317] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:171:0)
[02:08:11.317] Timer tick, asking Buildbucket for the build status
[02:08:11.410] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:11.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:172:0) after 1m0s
[02:09:11.523] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:172:0)
[02:09:11.523] Timer tick, asking Buildbucket for the build status
[02:09:11.634] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:11.634] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:173:0) after 1m0s
[02:10:11.662] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:173:0)
[02:10:11.662] Timer tick, asking Buildbucket for the build status
[02:10:11.732] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:11.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:174:0) after 1m0s
[02:11:11.805] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:174:0)
[02:11:11.805] Timer tick, asking Buildbucket for the build status
[02:11:11.846] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:11.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:175:0) after 1m0s
[02:12:11.888] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:175:0)
[02:12:11.888] Timer tick, asking Buildbucket for the build status
[02:12:11.977] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:11.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:176:0) after 1m0s
[02:13:12.019] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:176:0)
[02:13:12.019] Timer tick, asking Buildbucket for the build status
[02:13:12.179] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:12.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:177:0) after 1m0s
[02:14:12.254] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:177:0)
[02:14:12.254] Timer tick, asking Buildbucket for the build status
[02:14:12.324] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:12.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:178:0) after 1m0s
[02:15:12.392] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:178:0)
[02:15:12.392] Timer tick, asking Buildbucket for the build status
[02:15:12.485] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:12.485] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:179:0) after 1m0s
[02:16:12.507] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:179:0)
[02:16:12.507] Timer tick, asking Buildbucket for the build status
[02:16:12.620] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:12.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:180:0) after 1m0s
[02:17:12.691] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:180:0)
[02:17:12.691] Timer tick, asking Buildbucket for the build status
[02:17:12.792] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:12.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:181:0) after 1m0s
[02:18:12.910] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:181:0)
[02:18:12.910] Timer tick, asking Buildbucket for the build status
[02:18:13.011] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:13.012] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:182:0) after 1m0s
[02:19:13.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:182:0)
[02:19:13.217] Timer tick, asking Buildbucket for the build status
[02:19:13.404] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:13.404] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:183:0) after 1m0s
[02:20:13.439] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:183:0)
[02:20:13.439] Timer tick, asking Buildbucket for the build status
[02:20:13.481] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:13.481] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:184:0) after 1m0s
[02:21:13.527] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:184:0)
[02:21:13.527] Timer tick, asking Buildbucket for the build status
[02:21:13.691] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:13.691] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:185:0) after 1m0s
[02:22:13.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:185:0)
[02:22:13.721] Timer tick, asking Buildbucket for the build status
[02:22:13.861] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:13.862] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:186:0) after 1m0s
[02:23:13.885] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:186:0)
[02:23:13.885] Timer tick, asking Buildbucket for the build status
[02:23:14.019] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:14.019] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:187:0) after 1m0s
[02:24:14.041] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:187:0)
[02:24:14.041] Timer tick, asking Buildbucket for the build status
[02:24:14.145] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:14.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:188:0) after 1m0s
[02:25:14.173] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:188:0)
[02:25:14.173] Timer tick, asking Buildbucket for the build status
[02:25:14.251] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:14.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:189:0) after 1m0s
[02:26:14.358] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:189:0)
[02:26:14.358] Timer tick, asking Buildbucket for the build status
[02:26:14.444] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:14.444] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:190:0) after 1m0s
[02:27:14.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:190:0)
[02:27:14.473] Timer tick, asking Buildbucket for the build status
[02:27:14.544] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:14.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:191:0) after 1m0s
[02:28:14.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:191:0)
[02:28:14.569] Timer tick, asking Buildbucket for the build status
[02:28:14.698] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:14.698] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:192:0) after 1m0s
[02:29:14.743] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:192:0)
[02:29:14.743] Timer tick, asking Buildbucket for the build status
[02:29:14.818] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:14.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:193:0) after 1m0s
[02:30:14.842] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:193:0)
[02:30:14.842] Timer tick, asking Buildbucket for the build status
[02:30:15.001] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:15.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:194:0) after 1m0s
[02:31:15.026] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:194:0)
[02:31:15.026] Timer tick, asking Buildbucket for the build status
[02:31:15.156] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:15.156] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:195:0) after 1m0s
[02:32:15.414] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:195:0)
[02:32:15.414] Timer tick, asking Buildbucket for the build status
[02:32:15.470] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:15.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:196:0) after 1m0s
[02:33:15.512] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:196:0)
[02:33:15.512] Timer tick, asking Buildbucket for the build status
[02:33:15.599] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:15.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:197:0) after 1m0s
[02:34:15.626] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:197:0)
[02:34:15.626] Timer tick, asking Buildbucket for the build status
[02:34:15.732] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:15.732] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:198:0) after 1m0s
[02:35:15.754] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:198:0)
[02:35:15.754] Timer tick, asking Buildbucket for the build status
[02:35:15.931] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:15.931] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:199:0) after 1m0s
[02:36:15.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:199:0)
[02:36:15.969] Timer tick, asking Buildbucket for the build status
[02:36:16.009] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:16.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:200:0) after 1m0s
[02:37:16.033] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:200:0)
[02:37:16.033] Timer tick, asking Buildbucket for the build status
[02:37:16.077] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:16.077] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:201:0) after 1m0s
[02:38:16.228] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:201:0)
[02:38:16.228] Timer tick, asking Buildbucket for the build status
[02:38:16.429] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:16.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:202:0) after 1m0s
[02:39:16.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:202:0)
[02:39:16.459] Timer tick, asking Buildbucket for the build status
[02:39:16.554] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:16.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:203:0) after 1m0s
[02:40:16.585] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:203:0)
[02:40:16.585] Timer tick, asking Buildbucket for the build status
[02:40:16.690] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:16.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:204:0) after 1m0s
[02:41:16.747] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:204:0)
[02:41:16.747] Timer tick, asking Buildbucket for the build status
[02:41:16.890] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:16.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:205:0) after 1m0s
[02:42:16.913] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:205:0)
[02:42:16.913] Timer tick, asking Buildbucket for the build status
[02:42:16.978] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:16.979] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:206:0) after 1m0s
[02:43:17.015] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:206:0)
[02:43:17.015] Timer tick, asking Buildbucket for the build status
[02:43:17.211] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:17.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:207:0) after 1m0s
[02:44:17.232] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:207:0)
[02:44:17.232] Timer tick, asking Buildbucket for the build status
[02:44:17.285] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:17.285] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:208:0) after 1m0s
[02:45:17.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:208:0)
[02:45:17.318] Timer tick, asking Buildbucket for the build status
[02:45:17.429] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:17.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:209:0) after 1m0s
[02:46:17.517] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:209:0)
[02:46:17.517] Timer tick, asking Buildbucket for the build status
[02:46:17.588] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:17.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:210:0) after 1m0s
[02:47:17.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:210:0)
[02:47:17.660] Timer tick, asking Buildbucket for the build status
[02:47:17.746] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:17.747] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:211:0) after 1m0s
[02:48:17.769] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:211:0)
[02:48:17.769] Timer tick, asking Buildbucket for the build status
[02:48:17.987] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:17.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:212:0) after 1m0s
[02:49:18.008] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:212:0)
[02:49:18.008] Timer tick, asking Buildbucket for the build status
[02:49:18.095] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:18.095] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:213:0) after 1m0s
[02:50:18.129] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:213:0)
[02:50:18.129] Timer tick, asking Buildbucket for the build status
[02:50:18.320] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:18.320] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:214:0) after 1m0s
[02:51:18.362] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:214:0)
[02:51:18.362] Timer tick, asking Buildbucket for the build status
[02:51:18.571] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:18.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:215:0) after 1m0s
[02:52:18.617] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:215:0)
[02:52:18.617] Timer tick, asking Buildbucket for the build status
[02:52:18.696] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:18.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:216:0) after 1m0s
[02:53:18.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:216:0)
[02:53:18.735] Timer tick, asking Buildbucket for the build status
[02:53:18.835] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:18.835] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:217:0) after 1m0s
[02:54:18.895] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:217:0)
[02:54:18.895] Timer tick, asking Buildbucket for the build status
[02:54:18.971] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:18.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:218:0) after 1m0s
[02:55:19.003] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:218:0)
[02:55:19.003] Timer tick, asking Buildbucket for the build status
[02:55:19.096] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:19.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:219:0) after 1m0s
[02:56:19.123] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:219:0)
[02:56:19.123] Timer tick, asking Buildbucket for the build status
[02:56:19.203] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:19.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:220:0) after 1m0s
[02:57:19.229] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:220:0)
[02:57:19.229] Timer tick, asking Buildbucket for the build status
[02:57:19.298] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:19.298] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:221:0) after 1m0s
[02:58:19.321] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:221:0)
[02:58:19.321] Timer tick, asking Buildbucket for the build status
[02:58:19.470] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:19.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:222:0) after 1m0s
[02:59:19.517] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:222:0)
[02:59:19.517] Timer tick, asking Buildbucket for the build status
[02:59:19.645] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:19.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:223:0) after 1m0s
[03:00:19.705] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:223:0)
[03:00:19.705] Timer tick, asking Buildbucket for the build status
[03:00:19.881] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:19.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:224:0) after 1m0s
[03:01:19.909] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:224:0)
[03:01:19.909] Timer tick, asking Buildbucket for the build status
[03:01:20.013] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:20.013] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:225:0) after 1m0s
[03:02:20.039] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:225:0)
[03:02:20.039] Timer tick, asking Buildbucket for the build status
[03:02:20.129] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:20.129] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:226:0) after 1m0s
[03:03:20.172] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:226:0)
[03:03:20.172] Timer tick, asking Buildbucket for the build status
[03:03:20.240] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:20.240] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:227:0) after 1m0s
[03:04:20.266] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:227:0)
[03:04:20.266] Timer tick, asking Buildbucket for the build status
[03:04:20.342] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:20.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:228:0) after 1m0s
[03:05:20.447] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:228:0)
[03:05:20.447] Timer tick, asking Buildbucket for the build status
[03:05:20.513] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:20.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:229:0) after 1m0s
[03:06:20.539] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:229:0)
[03:06:20.539] Timer tick, asking Buildbucket for the build status
[03:06:20.651] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:20.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:230:0) after 1m0s
[03:07:20.689] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:230:0)
[03:07:20.689] Timer tick, asking Buildbucket for the build status
[03:07:20.754] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:20.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:231:0) after 1m0s
[03:08:20.782] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:231:0)
[03:08:20.782] Timer tick, asking Buildbucket for the build status
[03:08:20.868] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:20.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:232:0) after 1m0s
[03:09:20.893] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:232:0)
[03:09:20.893] Timer tick, asking Buildbucket for the build status
[03:09:20.941] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:20.941] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:233:0) after 1m0s
[03:10:20.966] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:233:0)
[03:10:20.966] Timer tick, asking Buildbucket for the build status
[03:10:21.113] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:10:21.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:234:0) after 1m0s
[03:11:21.150] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:234:0)
[03:11:21.150] Timer tick, asking Buildbucket for the build status
[03:11:21.237] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:21.237] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:235:0) after 1m0s
[03:12:21.262] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:235:0)
[03:12:21.262] Timer tick, asking Buildbucket for the build status
[03:12:21.336] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:21.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:236:0) after 1m0s
[03:13:21.433] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:236:0)
[03:13:21.433] Timer tick, asking Buildbucket for the build status
[03:13:21.697] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:21.697] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:237:0) after 1m0s
[03:14:21.733] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:237:0)
[03:14:21.733] Timer tick, asking Buildbucket for the build status
[03:14:21.836] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:21.836] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:238:0) after 1m0s
[03:15:21.904] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:238:0)
[03:15:21.904] Timer tick, asking Buildbucket for the build status
[03:15:21.966] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:21.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:239:0) after 1m0s
[03:16:22.011] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:239:0)
[03:16:22.011] Timer tick, asking Buildbucket for the build status
[03:16:22.080] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:22.080] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:240:0) after 1m0s
[03:17:22.136] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:240:0)
[03:17:22.136] Timer tick, asking Buildbucket for the build status
[03:17:22.272] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:22.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:241:0) after 1m0s
[03:18:22.309] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:241:0)
[03:18:22.309] Timer tick, asking Buildbucket for the build status
[03:18:22.434] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:22.434] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:242:0) after 1m0s
[03:19:22.462] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:242:0)
[03:19:22.462] Timer tick, asking Buildbucket for the build status
[03:19:22.544] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:22.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:243:0) after 1m0s
[03:20:22.672] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:243:0)
[03:20:22.672] Timer tick, asking Buildbucket for the build status
[03:20:22.788] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:22.788] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:244:0) after 1m0s
[03:21:22.838] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:244:0)
[03:21:22.838] Timer tick, asking Buildbucket for the build status
[03:21:22.918] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:22.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:245:0) after 1m0s
[03:22:23.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:245:0)
[03:22:23.001] Timer tick, asking Buildbucket for the build status
[03:22:23.081] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:23.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:246:0) after 1m0s
[03:23:23.110] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:246:0)
[03:23:23.110] Timer tick, asking Buildbucket for the build status
[03:23:23.231] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:23:23.231] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:247:0) after 1m0s
[03:24:23.258] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:247:0)
[03:24:23.258] Timer tick, asking Buildbucket for the build status
[03:24:23.377] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:24:23.377] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:248:0) after 1m0s
[03:25:23.404] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:248:0)
[03:25:23.404] Timer tick, asking Buildbucket for the build status
[03:25:23.512] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:23.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:249:0) after 1m0s
[03:26:23.586] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:249:0)
[03:26:23.586] Timer tick, asking Buildbucket for the build status
[03:26:23.662] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:23.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:250:0) after 1m0s
[03:27:23.694] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:250:0)
[03:27:23.694] Timer tick, asking Buildbucket for the build status
[03:27:23.741] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:27:23.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:251:0) after 1m0s
[03:28:23.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:251:0)
[03:28:23.773] Timer tick, asking Buildbucket for the build status
[03:28:23.853] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:28:23.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:252:0) after 1m0s
[03:29:23.894] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:252:0)
[03:29:23.894] Timer tick, asking Buildbucket for the build status
[03:29:23.948] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:23.948] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:253:0) after 1m0s
[03:30:24.010] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:253:0)
[03:30:24.010] Timer tick, asking Buildbucket for the build status
[03:30:24.090] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:24.090] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:254:0) after 1m0s
[03:31:24.190] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:254:0)
[03:31:24.190] Timer tick, asking Buildbucket for the build status
[03:31:24.273] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:24.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:255:0) after 1m0s
[03:32:24.379] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:255:0)
[03:32:24.379] Timer tick, asking Buildbucket for the build status
[03:32:24.427] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:24.427] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:256:0) after 1m0s
[03:33:24.468] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:256:0)
[03:33:24.468] Timer tick, asking Buildbucket for the build status
[03:33:24.538] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:33:24.538] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:257:0) after 1m0s
[03:34:24.579] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:257:0)
[03:34:24.579] Timer tick, asking Buildbucket for the build status
[03:34:24.858] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:24.858] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:258:0) after 1m0s
[03:35:24.911] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:258:0)
[03:35:24.911] Timer tick, asking Buildbucket for the build status
[03:35:25.036] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:25.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:259:0) after 1m0s
[03:36:25.078] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:259:0)
[03:36:25.078] Timer tick, asking Buildbucket for the build status
[03:36:25.188] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:25.188] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:260:0) after 1m0s
[03:37:25.236] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:260:0)
[03:37:25.236] Timer tick, asking Buildbucket for the build status
[03:37:25.351] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:25.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:261:0) after 1m0s
[03:38:25.444] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:261:0)
[03:38:25.444] Timer tick, asking Buildbucket for the build status
[03:38:25.508] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:25.508] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:262:0) after 1m0s
[03:39:25.566] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:262:0)
[03:39:25.566] Timer tick, asking Buildbucket for the build status
[03:39:25.628] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:25.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:263:0) after 1m0s
[03:40:25.682] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:263:0)
[03:40:25.682] Timer tick, asking Buildbucket for the build status
[03:40:25.755] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:40:25.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:264:0) after 1m0s
[03:41:25.805] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:264:0)
[03:41:25.805] Timer tick, asking Buildbucket for the build status
[03:41:25.928] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:25.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:265:0) after 1m0s
[03:42:25.962] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:265:0)
[03:42:25.962] Timer tick, asking Buildbucket for the build status
[03:42:26.070] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:26.070] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:266:0) after 1m0s
[03:43:26.098] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:266:0)
[03:43:26.098] Timer tick, asking Buildbucket for the build status
[03:43:26.252] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:26.252] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:267:0) after 1m0s
[03:44:26.298] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:267:0)
[03:44:26.298] Timer tick, asking Buildbucket for the build status
[03:44:26.423] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:26.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:268:0) after 1m0s
[03:45:26.453] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:268:0)
[03:45:26.453] Timer tick, asking Buildbucket for the build status
[03:45:26.537] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:26.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:269:0) after 1m0s
[03:46:26.759] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:269:0)
[03:46:26.759] Timer tick, asking Buildbucket for the build status
[03:46:26.849] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:26.849] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:270:0) after 1m0s
[03:47:26.879] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:270:0)
[03:47:26.879] Timer tick, asking Buildbucket for the build status
[03:47:27.027] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:27.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:271:0) after 1m0s
[03:48:27.056] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:271:0)
[03:48:27.056] Timer tick, asking Buildbucket for the build status
[03:48:27.155] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:27.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:272:0) after 1m0s
[03:49:27.183] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:272:0)
[03:49:27.183] Timer tick, asking Buildbucket for the build status
[03:49:27.263] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:27.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:273:0) after 1m0s
[03:50:27.291] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:273:0)
[03:50:27.291] Timer tick, asking Buildbucket for the build status
[03:50:27.371] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:50:27.371] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:274:0) after 1m0s
[03:51:27.406] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:274:0)
[03:51:27.406] Timer tick, asking Buildbucket for the build status
[03:51:27.621] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:51:27.621] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:275:0) after 1m0s
[03:52:27.649] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:275:0)
[03:52:27.649] Timer tick, asking Buildbucket for the build status
[03:52:27.746] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:27.746] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:276:0) after 1m0s
[03:53:27.777] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:276:0)
[03:53:27.777] Timer tick, asking Buildbucket for the build status
[03:53:27.918] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:27.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:277:0) after 1m0s
[03:54:27.945] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:277:0)
[03:54:27.945] Timer tick, asking Buildbucket for the build status
[03:54:28.169] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:28.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:278:0) after 1m0s
[03:55:28.205] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:278:0)
[03:55:28.205] Timer tick, asking Buildbucket for the build status
[03:55:28.352] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:28.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:279:0) after 1m0s
[03:56:28.409] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:279:0)
[03:56:28.409] Timer tick, asking Buildbucket for the build status
[03:56:28.544] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:28.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:280:0) after 1m0s
[03:57:28.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:280:0)
[03:57:28.577] Timer tick, asking Buildbucket for the build status
[03:57:28.649] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:28.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:281:0) after 1m0s
[03:58:28.687] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:281:0)
[03:58:28.688] Timer tick, asking Buildbucket for the build status
[03:58:28.825] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:28.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:282:0) after 1m0s
[03:59:28.858] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:282:0)
[03:59:28.858] Timer tick, asking Buildbucket for the build status
[03:59:28.935] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:59:28.935] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:283:0) after 1m0s
[04:00:28.959] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:283:0)
[04:00:28.959] Timer tick, asking Buildbucket for the build status
[04:00:29.046] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:00:29.046] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:284:0) after 1m0s
[04:01:29.090] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:284:0)
[04:01:29.090] Timer tick, asking Buildbucket for the build status
[04:01:29.151] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:29.151] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:285:0) after 1m0s
[04:02:29.228] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:285:0)
[04:02:29.228] Timer tick, asking Buildbucket for the build status
[04:02:29.301] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:29.301] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:286:0) after 1m0s
[04:03:29.381] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:286:0)
[04:03:29.381] Timer tick, asking Buildbucket for the build status
[04:03:29.475] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:29.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:287:0) after 1m0s
[04:04:29.549] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:287:0)
[04:04:29.549] Timer tick, asking Buildbucket for the build status
[04:04:29.776] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:29.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:288:0) after 1m0s
[04:05:29.852] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:288:0)
[04:05:29.852] Timer tick, asking Buildbucket for the build status
[04:05:30.317] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:30.317] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:289:0) after 1m0s
[04:06:30.348] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:289:0)
[04:06:30.348] Timer tick, asking Buildbucket for the build status
[04:06:30.503] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:30.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:290:0) after 1m0s
[04:07:30.531] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:290:0)
[04:07:30.531] Timer tick, asking Buildbucket for the build status
[04:07:30.620] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:30.620] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:291:0) after 1m0s
[04:08:30.676] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:291:0)
[04:08:30.676] Timer tick, asking Buildbucket for the build status
[04:08:30.751] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:30.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:292:0) after 1m0s
[04:09:30.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:292:0)
[04:09:30.787] Timer tick, asking Buildbucket for the build status
[04:09:30.837] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:30.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:293:0) after 1m0s
[04:10:30.910] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:293:0)
[04:10:30.910] Timer tick, asking Buildbucket for the build status
[04:10:31.002] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:31.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:294:0) after 1m0s
[04:11:31.037] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:294:0)
[04:11:31.037] Timer tick, asking Buildbucket for the build status
[04:11:31.111] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:31.111] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:295:0) after 1m0s
[04:12:31.174] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:295:0)
[04:12:31.175] Timer tick, asking Buildbucket for the build status
[04:12:31.335] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:31.335] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:296:0) after 1m0s
[04:13:31.379] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:296:0)
[04:13:31.379] Timer tick, asking Buildbucket for the build status
[04:13:31.462] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:31.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:297:0) after 1m0s
[04:14:31.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:297:0)
[04:14:31.496] Timer tick, asking Buildbucket for the build status
[04:14:31.583] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:31.583] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:298:0) after 1m0s
[04:15:31.620] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:298:0)
[04:15:31.620] Timer tick, asking Buildbucket for the build status
[04:15:31.751] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:31.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:299:0) after 1m0s
[04:16:31.777] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:299:0)
[04:16:31.777] Timer tick, asking Buildbucket for the build status
[04:16:31.912] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:31.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:300:0) after 1m0s
[04:17:31.946] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:300:0)
[04:17:31.946] Timer tick, asking Buildbucket for the build status
[04:17:32.011] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:32.011] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:301:0) after 1m0s
[04:18:32.054] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:301:0)
[04:18:32.054] Timer tick, asking Buildbucket for the build status
[04:18:32.310] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:32.311] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:302:0) after 1m0s
[04:19:32.337] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:302:0)
[04:19:32.337] Timer tick, asking Buildbucket for the build status
[04:19:32.480] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:32.480] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:303:0) after 1m0s
[04:20:32.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:303:0)
[04:20:32.556] Timer tick, asking Buildbucket for the build status
[04:20:32.768] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:32.768] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:304:0) after 1m0s
[04:21:32.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:304:0)
[04:21:32.808] Timer tick, asking Buildbucket for the build status
[04:21:32.861] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:32.861] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:305:0) after 1m0s
[04:22:32.956] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:305:0)
[04:22:32.956] Timer tick, asking Buildbucket for the build status
[04:22:33.098] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:33.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:306:0) after 1m0s
[04:23:33.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:306:0)
[04:23:33.147] Timer tick, asking Buildbucket for the build status
[04:23:33.300] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:33.300] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:307:0) after 1m0s
[04:24:33.374] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:307:0)
[04:24:33.374] Timer tick, asking Buildbucket for the build status
[04:24:33.558] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:33.558] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:308:0) after 1m0s
[04:25:33.585] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:308:0)
[04:25:33.585] Timer tick, asking Buildbucket for the build status
[04:25:33.689] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:33.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:309:0) after 1m0s
[04:26:33.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:309:0)
[04:26:33.715] Timer tick, asking Buildbucket for the build status
[04:26:33.799] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:33.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:310:0) after 1m0s
[04:27:33.831] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:310:0)
[04:27:33.831] Timer tick, asking Buildbucket for the build status
[04:27:34.033] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:34.033] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:311:0) after 1m0s
[04:28:34.083] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:311:0)
[04:28:34.083] Timer tick, asking Buildbucket for the build status
[04:28:34.131] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:34.131] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:312:0) after 1m0s
[04:29:34.164] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:312:0)
[04:29:34.164] Timer tick, asking Buildbucket for the build status
[04:29:34.454] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:34.454] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:313:0) after 1m0s
[04:30:34.479] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:313:0)
[04:30:34.479] Timer tick, asking Buildbucket for the build status
[04:30:34.667] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:34.667] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:314:0) after 1m0s
[04:31:34.717] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:314:0)
[04:31:34.717] Timer tick, asking Buildbucket for the build status
[04:31:34.773] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:34.773] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:315:0) after 1m0s
[04:32:34.877] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:315:0)
[04:32:34.877] Timer tick, asking Buildbucket for the build status
[04:32:35.010] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:35.010] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:316:0) after 1m0s
[04:33:35.074] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:316:0)
[04:33:35.074] Timer tick, asking Buildbucket for the build status
[04:33:35.144] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:35.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:317:0) after 1m0s
[04:34:35.194] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:317:0)
[04:34:35.194] Timer tick, asking Buildbucket for the build status
[04:34:35.274] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:35.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:318:0) after 1m0s
[04:35:35.307] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:318:0)
[04:35:35.307] Timer tick, asking Buildbucket for the build status
[04:35:35.505] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:35.505] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:319:0) after 1m0s
[04:36:35.570] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:319:0)
[04:36:35.570] Timer tick, asking Buildbucket for the build status
[04:36:35.733] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:35.733] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:320:0) after 1m0s
[04:37:35.789] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:320:0)
[04:37:35.789] Timer tick, asking Buildbucket for the build status
[04:37:35.877] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:35.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:321:0) after 1m0s
[04:38:35.957] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:321:0)
[04:38:35.957] Timer tick, asking Buildbucket for the build status
[04:38:36.108] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:36.108] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:322:0) after 1m0s
[04:39:36.227] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:322:0)
[04:39:36.227] Timer tick, asking Buildbucket for the build status
[04:39:36.336] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:36.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:323:0) after 1m0s
[04:40:36.361] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:323:0)
[04:40:36.361] Timer tick, asking Buildbucket for the build status
[04:40:36.433] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:36.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:324:0) after 1m0s
[04:41:36.481] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:324:0)
[04:41:36.481] Timer tick, asking Buildbucket for the build status
[04:41:36.672] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:36.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:325:0) after 1m0s
[04:42:36.762] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:325:0)
[04:42:36.762] Timer tick, asking Buildbucket for the build status
[04:42:36.820] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:36.820] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:326:0) after 1m0s
[04:43:36.847] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:326:0)
[04:43:36.847] Timer tick, asking Buildbucket for the build status
[04:43:36.929] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:36.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:327:0) after 1m0s
[04:44:36.968] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:327:0)
[04:44:36.969] Timer tick, asking Buildbucket for the build status
[04:44:37.054] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:37.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:328:0) after 1m0s
[04:45:37.080] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:328:0)
[04:45:37.080] Timer tick, asking Buildbucket for the build status
[04:45:37.160] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:37.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:329:0) after 1m0s
[04:46:37.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:329:0)
[04:46:37.185] Timer tick, asking Buildbucket for the build status
[04:46:37.349] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:37.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:330:0) after 1m0s
[04:47:37.379] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:330:0)
[04:47:37.379] Timer tick, asking Buildbucket for the build status
[04:47:37.436] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:37.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:331:0) after 1m0s
[04:48:37.485] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:331:0)
[04:48:37.485] Timer tick, asking Buildbucket for the build status
[04:48:37.603] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:37.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:332:0) after 1m0s
[04:49:37.641] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:332:0)
[04:49:37.641] Timer tick, asking Buildbucket for the build status
[04:49:37.770] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:37.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:333:0) after 1m0s
[04:50:37.794] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:333:0)
[04:50:37.794] Timer tick, asking Buildbucket for the build status
[04:50:37.939] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:37.939] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:334:0) after 1m0s
[04:51:38.043] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:334:0)
[04:51:38.043] Timer tick, asking Buildbucket for the build status
[04:51:38.304] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:38.304] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:335:0) after 1m0s
[04:52:38.347] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:335:0)
[04:52:38.347] Timer tick, asking Buildbucket for the build status
[04:52:38.418] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:38.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:336:0) after 1m0s
[04:53:38.469] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:336:0)
[04:53:38.470] Timer tick, asking Buildbucket for the build status
[04:53:38.565] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:38.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:337:0) after 1m0s
[04:54:38.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:337:0)
[04:54:38.597] Timer tick, asking Buildbucket for the build status
[04:54:38.776] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:38.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:338:0) after 1m0s
[04:55:38.804] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:338:0)
[04:55:38.804] Timer tick, asking Buildbucket for the build status
[04:55:38.862] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:38.862] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:339:0) after 1m0s
[04:56:38.913] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:339:0)
[04:56:38.913] Timer tick, asking Buildbucket for the build status
[04:56:39.248] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:39.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:340:0) after 1m0s
[04:57:39.449] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:340:0)
[04:57:39.449] Timer tick, asking Buildbucket for the build status
[04:57:39.572] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:39.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:341:0) after 1m0s
[04:58:39.599] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:341:0)
[04:58:39.599] Timer tick, asking Buildbucket for the build status
[04:58:39.656] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:39.656] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:342:0) after 1m0s
[04:59:39.691] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:342:0)
[04:59:39.691] Timer tick, asking Buildbucket for the build status
[04:59:39.762] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:39.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:343:0) after 1m0s
[05:00:39.806] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:343:0)
[05:00:39.806] Timer tick, asking Buildbucket for the build status
[05:00:40.055] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:40.055] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:344:0) after 1m0s
[05:01:40.145] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:344:0)
[05:01:40.145] Timer tick, asking Buildbucket for the build status
[05:01:40.259] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:40.260] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:345:0) after 1m0s
[05:02:40.415] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:345:0)
[05:02:40.415] Timer tick, asking Buildbucket for the build status
[05:02:40.580] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:40.580] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:346:0) after 1m0s
[05:03:40.645] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:346:0)
[05:03:40.645] Timer tick, asking Buildbucket for the build status
[05:03:40.727] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:40.727] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:347:0) after 1m0s
[05:04:40.758] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:347:0)
[05:04:40.758] Timer tick, asking Buildbucket for the build status
[05:04:40.907] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:40.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:348:0) after 1m0s
[05:05:41.044] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:348:0)
[05:05:41.044] Timer tick, asking Buildbucket for the build status
[05:05:41.256] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:41.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:349:0) after 1m0s
[05:06:41.287] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:349:0)
[05:06:41.287] Timer tick, asking Buildbucket for the build status
[05:06:41.361] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:41.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:350:0) after 1m0s
[05:07:41.419] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:350:0)
[05:07:41.419] Timer tick, asking Buildbucket for the build status
[05:07:41.486] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:41.486] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:351:0) after 1m0s
[05:08:41.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:351:0)
[05:08:41.535] Timer tick, asking Buildbucket for the build status
[05:08:41.614] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:41.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:352:0) after 1m0s
[05:09:41.645] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:352:0)
[05:09:41.645] Timer tick, asking Buildbucket for the build status
[05:09:41.685] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:41.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:353:0) after 1m0s
[05:10:41.856] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:353:0)
[05:10:41.856] Timer tick, asking Buildbucket for the build status
[05:10:41.914] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:41.914] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:354:0) after 1m0s
[05:11:41.950] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:354:0)
[05:11:41.950] Timer tick, asking Buildbucket for the build status
[05:11:42.066] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:42.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:355:0) after 1m0s
[05:12:42.105] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:355:0)
[05:12:42.106] Timer tick, asking Buildbucket for the build status
[05:12:42.149] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:42.149] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:356:0) after 1m0s
[05:13:42.192] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:356:0)
[05:13:42.192] Timer tick, asking Buildbucket for the build status
[05:13:42.560] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:42.560] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:357:0) after 1m0s
[05:14:42.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:357:0)
[05:14:42.616] Timer tick, asking Buildbucket for the build status
[05:14:42.688] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:42.688] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:358:0) after 1m0s
[05:15:42.762] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:358:0)
[05:15:42.762] Timer tick, asking Buildbucket for the build status
[05:15:43.008] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:43.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:359:0) after 1m0s
[05:16:43.051] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:359:0)
[05:16:43.051] Timer tick, asking Buildbucket for the build status
[05:16:43.102] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:43.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:360:0) after 1m0s
[05:17:43.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:360:0)
[05:17:43.233] Timer tick, asking Buildbucket for the build status
[05:17:43.323] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:43.323] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:361:0) after 1m0s
[05:18:43.384] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:361:0)
[05:18:43.384] Timer tick, asking Buildbucket for the build status
[05:18:43.466] Build 8932467836112943136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:18:43.466] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64:9097897898363383392:362:0) after 1m0s
[05:18:57.528] Received PubSub notification, asking Buildbucket for the build status
[05:18:57.567] Build 8932467836112943136: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[05:18:57.567] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "cancelation_reason": "TIMEOUT",
    "completed_ts": "1539753484684390",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1539731864782855",
    "experimental": true,
    "id": "8932467836112943136",
    "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\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\"}}",
    "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": "1539753533092573",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64/8",
      "builder:linux-pnacl-x86_64",
      "buildset:commit/git/99673869a3cd8731d924bd32fa486feebfdc6c4f",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/99673869a3cd8731d924bd32fa486feebfdc6c4f",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9097897898363383392",
      "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/8",
      "swarming_tag:buildbucket_bucket:luci.nacl.toolchain",
      "swarming_tag:buildbucket_build_id:8932467836112943136",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
      "swarming_tag:builder:linux-pnacl-x86_64",
      "swarming_tag:buildset:commit/git/99673869a3cd8731d924bd32fa486feebfdc6c4f",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/99673869a3cd8731d924bd32fa486feebfdc6c4f",
      "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/8932467836112943136/+/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:9097897898363383392",
      "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:82431e273d2f347205266ff4363205d6de25e0ad",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:4097fd46afd82b10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1539753533093867",
    "url": "https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64/8",
    "utcnow_ts": "1539753537557322"
  }
}
[05:18:57.567] Invocation finished in 6h1m14.315311973s with status FAILED