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

• 32b6deb45d5fbc77c5f65d35db45c48cae3c06bc (6 years ago)

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

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

[22:36:51.479] New invocation is queued and will start shortly
[22:36:52.870] Starting the invocation (attempt 1)
[22:36:52.930] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:36:52.931] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:36:52.931] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9100980766110791488",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-x86_32\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"32b6deb45d5fbc77c5f65d35db45c48cae3c06bc\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-pnacl-x86_64-tests-x86_32",
    "scheduler_invocation_id:9100980766110791488",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
    "user_agent:luci-scheduler",
    "buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
    "gitiles_ref:refs/heads/master"
  ]
}
[22:36:54.584] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1536791813027813",
    "experimental": true,
    "id": "8935550703821937152",
    "lease_expiration_ts": "1536910614062714",
    "lease_key": "384295111",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_32\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"32b6deb45d5fbc77c5f65d35db45c48cae3c06bc\"}}",
    "project": "nacl",
    "result_details_json": "null",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1536791814475945",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/3",
      "builder:linux-pnacl-x86_64-tests-x86_32",
      "buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9100980766110791488",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_dimension:caches:builder_91fd20d3b70fcaa51af83cb3d5f4f5aac058c8ab0c404858b1894fb462151f3a_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-tests-x86_32/3",
      "swarming_tag:buildbucket_bucket:luci.nacl.toolchain",
      "swarming_tag:buildbucket_build_id:8935550703821937152",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-x86_32",
      "swarming_tag:buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "swarming_tag:caches:builder_91fd20d3b70fcaa51af83cb3d5f4f5aac058c8ab0c404858b1894fb462151f3a_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/8935550703821937152/+/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:9100980766110791488",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:ccd94b661aaeb4cc141585f6f7be3f211386159f",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3fe8bfa67e912b10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1536791814476044",
    "url": "https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/3",
    "utcnow_ts": "1536791814568508"
  }
}
[22:36:54.584] Task URL: https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/3
[22:36:54.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:2:0) after 1m0s
[22:37:54.611] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:2:0)
[22:37:54.611] Timer tick, asking Buildbucket for the build status
[22:37:54.744] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:54.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:3:0) after 1m0s
[22:38:54.764] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:3:0)
[22:38:54.764] Timer tick, asking Buildbucket for the build status
[22:38:54.884] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:54.884] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:4:0) after 1m0s
[22:39:54.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:4:0)
[22:39:54.899] Timer tick, asking Buildbucket for the build status
[22:39:55.007] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:55.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:5:0) after 1m0s
[22:40:55.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:5:0)
[22:40:55.025] Timer tick, asking Buildbucket for the build status
[22:40:55.101] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:55.101] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:6:0) after 1m0s
[22:41:55.118] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:6:0)
[22:41:55.118] Timer tick, asking Buildbucket for the build status
[22:41:55.171] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:55.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:7:0) after 1m0s
[22:42:55.215] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:7:0)
[22:42:55.215] Timer tick, asking Buildbucket for the build status
[22:42:55.332] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:55.332] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:8:0) after 1m0s
[22:43:55.366] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:8:0)
[22:43:55.366] Timer tick, asking Buildbucket for the build status
[22:43:55.422] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:55.422] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:9:0) after 1m0s
[22:44:55.440] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:9:0)
[22:44:55.440] Timer tick, asking Buildbucket for the build status
[22:44:55.552] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:55.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:10:0) after 1m0s
[22:45:55.571] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:10:0)
[22:45:55.571] Timer tick, asking Buildbucket for the build status
[22:45:55.676] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:55.676] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:11:0) after 1m0s
[22:46:55.699] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:11:0)
[22:46:55.699] Timer tick, asking Buildbucket for the build status
[22:46:55.739] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:55.739] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:12:0) after 1m0s
[22:47:55.763] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:12:0)
[22:47:55.763] Timer tick, asking Buildbucket for the build status
[22:47:55.890] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:55.890] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:13:0) after 1m0s
[22:48:55.906] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:13:0)
[22:48:55.906] Timer tick, asking Buildbucket for the build status
[22:48:55.980] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:55.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:14:0) after 1m0s
[22:49:55.997] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:14:0)
[22:49:55.997] Timer tick, asking Buildbucket for the build status
[22:49:56.125] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:56.126] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:15:0) after 1m0s
[22:50:56.144] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:15:0)
[22:50:56.144] Timer tick, asking Buildbucket for the build status
[22:50:56.208] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:56.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:16:0) after 1m0s
[22:51:56.259] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:16:0)
[22:51:56.259] Timer tick, asking Buildbucket for the build status
[22:51:56.407] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:56.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:17:0) after 1m0s
[22:52:56.424] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:17:0)
[22:52:56.424] Timer tick, asking Buildbucket for the build status
[22:52:56.496] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:56.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:18:0) after 1m0s
[22:53:56.514] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:18:0)
[22:53:56.514] Timer tick, asking Buildbucket for the build status
[22:53:56.583] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:56.583] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:19:0) after 1m0s
[22:54:56.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:19:0)
[22:54:56.608] Timer tick, asking Buildbucket for the build status
[22:54:56.865] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:56.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:20:0) after 1m0s
[22:55:56.888] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:20:0)
[22:55:56.888] Timer tick, asking Buildbucket for the build status
[22:55:57.157] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:57.157] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:21:0) after 1m0s
[22:56:57.180] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:21:0)
[22:56:57.181] Timer tick, asking Buildbucket for the build status
[22:56:57.248] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:57.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:22:0) after 1m0s
[22:57:57.270] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:22:0)
[22:57:57.270] Timer tick, asking Buildbucket for the build status
[22:57:57.485] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:57.485] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:23:0) after 1m0s
[22:58:57.505] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:23:0)
[22:58:57.505] Timer tick, asking Buildbucket for the build status
[22:58:58.043] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:58.043] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:24:0) after 1m0s
[22:59:58.073] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:24:0)
[22:59:58.073] Timer tick, asking Buildbucket for the build status
[22:59:58.146] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:58.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:25:0) after 1m0s
[23:00:58.210] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:25:0)
[23:00:58.210] Timer tick, asking Buildbucket for the build status
[23:00:58.342] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:58.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:26:0) after 1m0s
[23:01:58.359] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:26:0)
[23:01:58.359] Timer tick, asking Buildbucket for the build status
[23:01:58.797] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:58.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:27:0) after 1m0s
[23:02:58.816] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:27:0)
[23:02:58.816] Timer tick, asking Buildbucket for the build status
[23:02:58.969] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:58.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:28:0) after 1m0s
[23:03:58.988] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:28:0)
[23:03:58.988] Timer tick, asking Buildbucket for the build status
[23:03:59.061] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:59.061] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:29:0) after 1m0s
[23:04:59.080] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:29:0)
[23:04:59.080] Timer tick, asking Buildbucket for the build status
[23:04:59.145] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:59.145] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:30:0) after 1m0s
[23:05:59.165] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:30:0)
[23:05:59.165] Timer tick, asking Buildbucket for the build status
[23:05:59.322] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:59.322] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:31:0) after 1m0s
[23:06:59.358] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:31:0)
[23:06:59.358] Timer tick, asking Buildbucket for the build status
[23:06:59.475] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:59.475] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:32:0) after 1m0s
[23:07:59.493] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:32:0)
[23:07:59.493] Timer tick, asking Buildbucket for the build status
[23:07:59.769] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:59.769] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:33:0) after 1m0s
[23:08:59.796] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:33:0)
[23:08:59.796] Timer tick, asking Buildbucket for the build status
[23:08:59.881] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:59.881] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:34:0) after 1m0s
[23:09:59.960] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:34:0)
[23:09:59.960] Timer tick, asking Buildbucket for the build status
[23:10:00.128] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:00.128] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:35:0) after 1m0s
[23:11:00.147] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:35:0)
[23:11:00.147] Timer tick, asking Buildbucket for the build status
[23:11:00.208] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:00.208] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:36:0) after 1m0s
[23:12:00.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:36:0)
[23:12:00.233] Timer tick, asking Buildbucket for the build status
[23:12:00.302] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:00.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:37:0) after 1m0s
[23:13:00.341] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:37:0)
[23:13:00.341] Timer tick, asking Buildbucket for the build status
[23:13:00.600] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:00.600] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:38:0) after 1m0s
[23:14:00.620] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:38:0)
[23:14:00.620] Timer tick, asking Buildbucket for the build status
[23:14:00.696] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:00.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:39:0) after 1m0s
[23:15:00.728] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:39:0)
[23:15:00.728] Timer tick, asking Buildbucket for the build status
[23:15:01.054] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:01.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:40:0) after 1m0s
[23:16:01.145] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:40:0)
[23:16:01.145] Timer tick, asking Buildbucket for the build status
[23:16:01.421] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:01.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:41:0) after 1m0s
[23:17:01.522] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:41:0)
[23:17:01.522] Timer tick, asking Buildbucket for the build status
[23:17:01.641] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:01.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:42:0) after 1m0s
[23:18:01.665] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:42:0)
[23:18:01.665] Timer tick, asking Buildbucket for the build status
[23:18:01.855] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:01.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:43:0) after 1m0s
[23:19:01.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:43:0)
[23:19:01.899] Timer tick, asking Buildbucket for the build status
[23:19:02.293] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:02.293] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:44:0) after 1m0s
[23:20:02.324] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:44:0)
[23:20:02.324] Timer tick, asking Buildbucket for the build status
[23:20:02.493] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:02.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:45:0) after 1m0s
[23:21:02.596] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:45:0)
[23:21:02.596] Timer tick, asking Buildbucket for the build status
[23:21:02.810] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:02.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:46:0) after 1m0s
[23:22:02.830] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:46:0)
[23:22:02.830] Timer tick, asking Buildbucket for the build status
[23:22:03.187] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:03.187] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:47:0) after 1m0s
[23:23:03.211] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:47:0)
[23:23:03.211] Timer tick, asking Buildbucket for the build status
[23:23:03.273] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:03.273] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:48:0) after 1m0s
[23:24:03.315] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:48:0)
[23:24:03.315] Timer tick, asking Buildbucket for the build status
[23:24:03.397] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:03.397] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:49:0) after 1m0s
[23:25:03.424] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:49:0)
[23:25:03.424] Timer tick, asking Buildbucket for the build status
[23:25:03.552] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:03.552] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:50:0) after 1m0s
[23:26:03.571] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:50:0)
[23:26:03.571] Timer tick, asking Buildbucket for the build status
[23:26:03.640] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:03.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:51:0) after 1m0s
[23:27:03.676] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:51:0)
[23:27:03.676] Timer tick, asking Buildbucket for the build status
[23:27:03.826] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:03.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:52:0) after 1m0s
[23:28:03.848] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:52:0)
[23:28:03.848] Timer tick, asking Buildbucket for the build status
[23:28:03.915] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:03.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:53:0) after 1m0s
[23:29:03.934] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:53:0)
[23:29:03.934] Timer tick, asking Buildbucket for the build status
[23:29:04.055] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:04.055] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:54:0) after 1m0s
[23:30:04.077] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:54:0)
[23:30:04.077] Timer tick, asking Buildbucket for the build status
[23:30:04.209] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:04.209] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:55:0) after 1m0s
[23:31:04.264] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:55:0)
[23:31:04.264] Timer tick, asking Buildbucket for the build status
[23:31:04.316] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:04.316] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:56:0) after 1m0s
[23:32:04.369] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:56:0)
[23:32:04.369] Timer tick, asking Buildbucket for the build status
[23:32:04.433] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:04.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:57:0) after 1m0s
[23:33:04.454] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:57:0)
[23:33:04.454] Timer tick, asking Buildbucket for the build status
[23:33:04.588] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:04.588] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:58:0) after 1m0s
[23:34:04.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:58:0)
[23:34:04.608] Timer tick, asking Buildbucket for the build status
[23:34:04.687] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:04.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:59:0) after 1m0s
[23:35:04.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:59:0)
[23:35:04.715] Timer tick, asking Buildbucket for the build status
[23:35:04.825] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:04.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:60:0) after 1m0s
[23:36:04.848] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:60:0)
[23:36:04.848] Timer tick, asking Buildbucket for the build status
[23:36:04.887] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:04.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:61:0) after 1m0s
[23:37:04.908] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:61:0)
[23:37:04.908] Timer tick, asking Buildbucket for the build status
[23:37:04.977] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:04.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:62:0) after 1m0s
[23:38:04.999] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:62:0)
[23:38:04.999] Timer tick, asking Buildbucket for the build status
[23:38:05.037] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:05.037] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:63:0) after 1m0s
[23:39:05.057] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:63:0)
[23:39:05.057] Timer tick, asking Buildbucket for the build status
[23:39:05.179] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:05.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:64:0) after 1m0s
[23:40:05.198] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:64:0)
[23:40:05.198] Timer tick, asking Buildbucket for the build status
[23:40:05.363] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:05.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:65:0) after 1m0s
[23:41:05.384] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:65:0)
[23:41:05.384] Timer tick, asking Buildbucket for the build status
[23:41:05.423] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:05.423] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:66:0) after 1m0s
[23:42:05.451] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:66:0)
[23:42:05.451] Timer tick, asking Buildbucket for the build status
[23:42:05.626] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:05.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:67:0) after 1m0s
[23:43:05.657] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:67:0)
[23:43:05.657] Timer tick, asking Buildbucket for the build status
[23:43:05.929] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:05.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:68:0) after 1m0s
[23:44:05.953] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:68:0)
[23:44:05.953] Timer tick, asking Buildbucket for the build status
[23:44:06.002] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:06.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:69:0) after 1m0s
[23:45:06.112] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:69:0)
[23:45:06.113] Timer tick, asking Buildbucket for the build status
[23:45:06.251] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:06.251] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:70:0) after 1m0s
[23:46:06.271] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:70:0)
[23:46:06.271] Timer tick, asking Buildbucket for the build status
[23:46:06.453] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:06.453] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:71:0) after 1m0s
[23:47:06.478] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:71:0)
[23:47:06.478] Timer tick, asking Buildbucket for the build status
[23:47:06.540] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:06.540] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:72:0) after 1m0s
[23:48:06.562] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:72:0)
[23:48:06.562] Timer tick, asking Buildbucket for the build status
[23:48:06.628] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:06.628] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:73:0) after 1m0s
[23:49:06.647] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:73:0)
[23:49:06.647] Timer tick, asking Buildbucket for the build status
[23:49:06.686] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:06.686] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:74:0) after 1m0s
[23:50:06.723] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:74:0)
[23:50:06.723] Timer tick, asking Buildbucket for the build status
[23:50:06.809] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:06.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:75:0) after 1m0s
[23:51:06.840] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:75:0)
[23:51:06.840] Timer tick, asking Buildbucket for the build status
[23:51:06.909] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:06.909] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:76:0) after 1m0s
[23:52:06.959] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:76:0)
[23:52:06.959] Timer tick, asking Buildbucket for the build status
[23:52:07.102] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:07.102] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:77:0) after 1m0s
[23:53:07.121] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:77:0)
[23:53:07.121] Timer tick, asking Buildbucket for the build status
[23:53:07.500] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:07.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:78:0) after 1m0s
[23:54:07.519] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:78:0)
[23:54:07.519] Timer tick, asking Buildbucket for the build status
[23:54:07.568] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:07.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:79:0) after 1m0s
[23:55:07.617] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:79:0)
[23:55:07.617] Timer tick, asking Buildbucket for the build status
[23:55:07.680] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:07.680] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:80:0) after 1m0s
[23:56:07.714] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:80:0)
[23:56:07.714] Timer tick, asking Buildbucket for the build status
[23:56:07.895] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:07.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:81:0) after 1m0s
[23:57:07.915] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:81:0)
[23:57:07.915] Timer tick, asking Buildbucket for the build status
[23:57:08.003] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:08.003] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:82:0) after 1m0s
[23:58:08.021] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:82:0)
[23:58:08.021] Timer tick, asking Buildbucket for the build status
[23:58:08.318] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:08.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:83:0) after 1m0s
[23:59:08.338] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:83:0)
[23:59:08.338] Timer tick, asking Buildbucket for the build status
[23:59:08.515] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:08.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:84:0) after 1m0s
[00:00:08.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:84:0)
[00:00:08.535] Timer tick, asking Buildbucket for the build status
[00:00:08.579] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:08.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:85:0) after 1m0s
[00:01:08.601] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:85:0)
[00:01:08.601] Timer tick, asking Buildbucket for the build status
[00:01:08.681] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:08.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:86:0) after 1m0s
[00:02:08.780] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:86:0)
[00:02:08.780] Timer tick, asking Buildbucket for the build status
[00:02:08.826] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:08.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:87:0) after 1m0s
[00:03:08.845] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:87:0)
[00:03:08.845] Timer tick, asking Buildbucket for the build status
[00:03:08.913] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:08.913] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:88:0) after 1m0s
[00:04:08.930] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:88:0)
[00:04:08.930] Timer tick, asking Buildbucket for the build status
[00:04:09.159] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:09.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:89:0) after 1m0s
[00:05:09.194] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:89:0)
[00:05:09.194] Timer tick, asking Buildbucket for the build status
[00:05:09.230] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:09.230] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:90:0) after 1m0s
[00:06:09.256] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:90:0)
[00:06:09.256] Timer tick, asking Buildbucket for the build status
[00:06:09.315] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:09.315] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:91:0) after 1m0s
[00:07:09.340] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:91:0)
[00:07:09.340] Timer tick, asking Buildbucket for the build status
[00:07:09.415] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:09.415] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:92:0) after 1m0s
[00:08:09.450] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:92:0)
[00:08:09.450] Timer tick, asking Buildbucket for the build status
[00:08:09.770] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:09.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:93:0) after 1m0s
[00:09:09.789] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:93:0)
[00:09:09.789] Timer tick, asking Buildbucket for the build status
[00:09:09.848] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:09.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:94:0) after 1m0s
[00:10:09.930] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:94:0)
[00:10:09.930] Timer tick, asking Buildbucket for the build status
[00:10:09.996] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:09.996] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:95:0) after 1m0s
[00:11:10.017] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:95:0)
[00:11:10.017] Timer tick, asking Buildbucket for the build status
[00:11:10.087] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:10.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:96:0) after 1m0s
[00:12:10.114] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:96:0)
[00:12:10.114] Timer tick, asking Buildbucket for the build status
[00:12:10.254] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:10.254] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:97:0) after 1m0s
[00:13:10.277] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:97:0)
[00:13:10.277] Timer tick, asking Buildbucket for the build status
[00:13:10.562] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:10.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:98:0) after 1m0s
[00:14:10.583] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:98:0)
[00:14:10.583] Timer tick, asking Buildbucket for the build status
[00:14:10.645] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:10.645] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:99:0) after 1m0s
[00:15:10.780] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:99:0)
[00:15:10.780] Timer tick, asking Buildbucket for the build status
[00:15:10.907] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:10.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:100:0) after 1m0s
[00:16:10.934] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:100:0)
[00:16:10.934] Timer tick, asking Buildbucket for the build status
[00:16:10.995] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:10.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:101:0) after 1m0s
[00:17:11.023] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:101:0)
[00:17:11.023] Timer tick, asking Buildbucket for the build status
[00:17:11.074] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:11.074] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:102:0) after 1m0s
[00:18:11.102] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:102:0)
[00:18:11.102] Timer tick, asking Buildbucket for the build status
[00:18:11.225] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:11.225] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:103:0) after 1m0s
[00:19:11.247] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:103:0)
[00:19:11.247] Timer tick, asking Buildbucket for the build status
[00:19:11.373] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:11.373] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:104:0) after 1m0s
[00:20:11.395] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:104:0)
[00:20:11.395] Timer tick, asking Buildbucket for the build status
[00:20:11.469] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:11.469] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:105:0) after 1m0s
[00:21:11.491] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:105:0)
[00:21:11.491] Timer tick, asking Buildbucket for the build status
[00:21:11.563] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:11.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:106:0) after 1m0s
[00:22:11.586] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:106:0)
[00:22:11.586] Timer tick, asking Buildbucket for the build status
[00:22:11.639] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:11.639] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:107:0) after 1m0s
[00:23:11.658] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:107:0)
[00:23:11.658] Timer tick, asking Buildbucket for the build status
[00:23:11.716] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:11.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:108:0) after 1m0s
[00:24:11.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:108:0)
[00:24:11.740] Timer tick, asking Buildbucket for the build status
[00:24:11.778] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:11.778] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:109:0) after 1m0s
[00:25:11.799] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:109:0)
[00:25:11.799] Timer tick, asking Buildbucket for the build status
[00:25:11.892] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:11.892] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:110:0) after 1m0s
[00:26:11.920] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:110:0)
[00:26:11.920] Timer tick, asking Buildbucket for the build status
[00:26:11.989] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:11.989] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:111:0) after 1m0s
[00:27:12.010] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:111:0)
[00:27:12.010] Timer tick, asking Buildbucket for the build status
[00:27:12.086] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:12.086] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:112:0) after 1m0s
[00:28:12.128] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:112:0)
[00:28:12.128] Timer tick, asking Buildbucket for the build status
[00:28:12.270] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:12.270] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:113:0) after 1m0s
[00:29:12.290] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:113:0)
[00:29:12.290] Timer tick, asking Buildbucket for the build status
[00:29:12.336] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:12.336] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:114:0) after 1m0s
[00:30:12.357] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:114:0)
[00:30:12.357] Timer tick, asking Buildbucket for the build status
[00:30:12.420] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:12.420] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:115:0) after 1m0s
[00:31:12.484] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:115:0)
[00:31:12.484] Timer tick, asking Buildbucket for the build status
[00:31:12.555] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:12.555] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:116:0) after 1m0s
[00:32:12.574] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:116:0)
[00:32:12.574] Timer tick, asking Buildbucket for the build status
[00:32:12.615] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:12.615] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:117:0) after 1m0s
[00:33:12.641] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:117:0)
[00:33:12.641] Timer tick, asking Buildbucket for the build status
[00:33:12.819] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:12.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:118:0) after 1m0s
[00:34:12.839] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:118:0)
[00:34:12.839] Timer tick, asking Buildbucket for the build status
[00:34:12.907] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:12.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:119:0) after 1m0s
[00:35:12.928] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:119:0)
[00:35:12.928] Timer tick, asking Buildbucket for the build status
[00:35:13.030] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:13.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:120:0) after 1m0s
[00:36:13.054] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:120:0)
[00:36:13.054] Timer tick, asking Buildbucket for the build status
[00:36:13.122] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:13.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:121:0) after 1m0s
[00:37:13.227] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:121:0)
[00:37:13.227] Timer tick, asking Buildbucket for the build status
[00:37:13.284] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:13.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:122:0) after 1m0s
[00:38:13.356] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:122:0)
[00:38:13.356] Timer tick, asking Buildbucket for the build status
[00:38:13.492] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:13.492] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:123:0) after 1m0s
[00:39:13.516] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:123:0)
[00:39:13.516] Timer tick, asking Buildbucket for the build status
[00:39:13.689] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:13.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:124:0) after 1m0s
[00:40:13.711] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:124:0)
[00:40:13.711] Timer tick, asking Buildbucket for the build status
[00:40:13.762] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:13.762] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:125:0) after 1m0s
[00:41:13.786] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:125:0)
[00:41:13.786] Timer tick, asking Buildbucket for the build status
[00:41:13.848] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:13.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:126:0) after 1m0s
[00:42:13.868] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:126:0)
[00:42:13.868] Timer tick, asking Buildbucket for the build status
[00:42:13.943] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:13.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:127:0) after 1m0s
[00:43:14.020] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:127:0)
[00:43:14.020] Timer tick, asking Buildbucket for the build status
[00:43:14.092] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:14.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:128:0) after 1m0s
[00:44:14.114] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:128:0)
[00:44:14.114] Timer tick, asking Buildbucket for the build status
[00:44:14.256] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:14.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:129:0) after 1m0s
[00:45:14.283] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:129:0)
[00:45:14.283] Timer tick, asking Buildbucket for the build status
[00:45:14.364] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:14.364] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:130:0) after 1m0s
[00:46:14.433] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:130:0)
[00:46:14.433] Timer tick, asking Buildbucket for the build status
[00:46:14.602] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:14.602] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:131:0) after 1m0s
[00:47:14.624] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:131:0)
[00:47:14.624] Timer tick, asking Buildbucket for the build status
[00:47:14.800] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:14.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:132:0) after 1m0s
[00:48:14.846] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:132:0)
[00:48:14.846] Timer tick, asking Buildbucket for the build status
[00:48:14.911] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:14.911] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:133:0) after 1m0s
[00:49:14.933] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:133:0)
[00:49:14.933] Timer tick, asking Buildbucket for the build status
[00:49:15.015] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:15.015] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:134:0) after 1m0s
[00:50:15.037] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:134:0)
[00:50:15.037] Timer tick, asking Buildbucket for the build status
[00:50:15.183] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:15.183] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:135:0) after 1m0s
[00:51:15.205] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:135:0)
[00:51:15.206] Timer tick, asking Buildbucket for the build status
[00:51:15.424] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:15.424] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:136:0) after 1m0s
[00:52:15.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:136:0)
[00:52:15.459] Timer tick, asking Buildbucket for the build status
[00:52:15.536] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:15.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:137:0) after 1m0s
[00:53:15.558] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:137:0)
[00:53:15.558] Timer tick, asking Buildbucket for the build status
[00:53:15.713] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:15.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:138:0) after 1m0s
[00:54:15.742] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:138:0)
[00:54:15.742] Timer tick, asking Buildbucket for the build status
[00:54:15.800] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:15.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:139:0) after 1m0s
[00:55:15.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:139:0)
[00:55:15.843] Timer tick, asking Buildbucket for the build status
[00:55:15.964] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:15.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:140:0) after 1m0s
[00:56:15.983] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:140:0)
[00:56:15.983] Timer tick, asking Buildbucket for the build status
[00:56:16.167] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:16.167] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:141:0) after 1m0s
[00:57:16.190] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:141:0)
[00:57:16.190] Timer tick, asking Buildbucket for the build status
[00:57:16.278] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:16.278] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:142:0) after 1m0s
[00:58:16.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:142:0)
[00:58:16.300] Timer tick, asking Buildbucket for the build status
[00:58:16.661] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:16.661] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:143:0) after 1m0s
[00:59:16.680] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:143:0)
[00:59:16.680] Timer tick, asking Buildbucket for the build status
[00:59:16.751] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:16.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:144:0) after 1m0s
[01:00:16.786] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:144:0)
[01:00:16.786] Timer tick, asking Buildbucket for the build status
[01:00:16.863] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:16.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:145:0) after 1m0s
[01:01:16.886] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:145:0)
[01:01:16.886] Timer tick, asking Buildbucket for the build status
[01:01:16.956] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:16.956] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:146:0) after 1m0s
[01:02:17.116] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:146:0)
[01:02:17.116] Timer tick, asking Buildbucket for the build status
[01:02:17.189] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:17.189] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:147:0) after 1m0s
[01:03:17.227] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:147:0)
[01:03:17.227] Timer tick, asking Buildbucket for the build status
[01:03:17.320] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:17.320] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:148:0) after 1m0s
[01:04:17.343] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:148:0)
[01:04:17.343] Timer tick, asking Buildbucket for the build status
[01:04:17.547] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:17.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:149:0) after 1m0s
[01:05:17.570] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:149:0)
[01:05:17.570] Timer tick, asking Buildbucket for the build status
[01:05:17.617] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:17.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:150:0) after 1m0s
[01:06:17.638] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:150:0)
[01:06:17.638] Timer tick, asking Buildbucket for the build status
[01:06:17.864] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:17.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:151:0) after 1m0s
[01:07:17.897] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:151:0)
[01:07:17.897] Timer tick, asking Buildbucket for the build status
[01:07:18.026] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:18.026] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:152:0) after 1m0s
[01:08:18.054] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:152:0)
[01:08:18.054] Timer tick, asking Buildbucket for the build status
[01:08:18.295] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:18.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:153:0) after 1m0s
[01:09:18.335] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:153:0)
[01:09:18.335] Timer tick, asking Buildbucket for the build status
[01:09:18.438] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:18.438] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:154:0) after 1m0s
[01:10:18.463] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:154:0)
[01:10:18.463] Timer tick, asking Buildbucket for the build status
[01:10:18.631] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:18.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:155:0) after 1m0s
[01:11:18.654] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:155:0)
[01:11:18.654] Timer tick, asking Buildbucket for the build status
[01:11:18.705] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:18.705] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:156:0) after 1m0s
[01:12:18.731] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:156:0)
[01:12:18.731] Timer tick, asking Buildbucket for the build status
[01:12:18.797] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:18.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:157:0) after 1m0s
[01:13:18.821] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:157:0)
[01:13:18.821] Timer tick, asking Buildbucket for the build status
[01:13:18.894] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:18.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:158:0) after 1m0s
[01:14:18.927] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:158:0)
[01:14:18.927] Timer tick, asking Buildbucket for the build status
[01:14:19.009] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:19.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:159:0) after 1m0s
[01:15:19.034] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:159:0)
[01:15:19.034] Timer tick, asking Buildbucket for the build status
[01:15:19.198] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:19.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:160:0) after 1m0s
[01:16:19.222] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:160:0)
[01:16:19.222] Timer tick, asking Buildbucket for the build status
[01:16:19.454] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:19.455] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:161:0) after 1m0s
[01:17:19.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:161:0)
[01:17:19.556] Timer tick, asking Buildbucket for the build status
[01:17:19.663] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:19.663] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:162:0) after 1m0s
[01:18:19.684] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:162:0)
[01:18:19.684] Timer tick, asking Buildbucket for the build status
[01:18:19.731] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:19.731] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:163:0) after 1m0s
[01:19:19.767] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:163:0)
[01:19:19.767] Timer tick, asking Buildbucket for the build status
[01:19:20.004] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:20.004] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:164:0) after 1m0s
[01:20:20.044] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:164:0)
[01:20:20.044] Timer tick, asking Buildbucket for the build status
[01:20:20.116] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:20.116] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:165:0) after 1m0s
[01:21:20.143] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:165:0)
[01:21:20.143] Timer tick, asking Buildbucket for the build status
[01:21:20.559] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:20.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:166:0) after 1m0s
[01:22:20.583] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:166:0)
[01:22:20.583] Timer tick, asking Buildbucket for the build status
[01:22:20.640] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:20.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:167:0) after 1m0s
[01:23:20.664] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:167:0)
[01:23:20.664] Timer tick, asking Buildbucket for the build status
[01:23:21.085] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:21.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:168:0) after 1m0s
[01:24:21.112] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:168:0)
[01:24:21.112] Timer tick, asking Buildbucket for the build status
[01:24:21.199] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:21.199] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:169:0) after 1m0s
[01:25:21.244] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:169:0)
[01:25:21.244] Timer tick, asking Buildbucket for the build status
[01:25:21.334] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:21.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:170:0) after 1m0s
[01:26:21.359] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:170:0)
[01:26:21.359] Timer tick, asking Buildbucket for the build status
[01:26:21.425] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:21.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:171:0) after 1m0s
[01:27:21.447] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:171:0)
[01:27:21.447] Timer tick, asking Buildbucket for the build status
[01:27:21.568] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:21.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:172:0) after 1m0s
[01:28:21.642] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:172:0)
[01:28:21.642] Timer tick, asking Buildbucket for the build status
[01:28:21.690] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:21.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:173:0) after 1m0s
[01:29:21.725] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:173:0)
[01:29:21.725] Timer tick, asking Buildbucket for the build status
[01:29:21.782] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:21.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:174:0) after 1m0s
[01:30:21.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:174:0)
[01:30:21.808] Timer tick, asking Buildbucket for the build status
[01:30:21.878] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:21.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:175:0) after 1m0s
[01:31:21.904] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:175:0)
[01:31:21.904] Timer tick, asking Buildbucket for the build status
[01:31:22.005] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:22.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:176:0) after 1m0s
[01:32:22.059] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:176:0)
[01:32:22.059] Timer tick, asking Buildbucket for the build status
[01:32:22.189] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:22.189] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:177:0) after 1m0s
[01:33:22.336] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:177:0)
[01:33:22.336] Timer tick, asking Buildbucket for the build status
[01:33:22.433] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:22.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:178:0) after 1m0s
[01:34:22.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:178:0)
[01:34:22.455] Timer tick, asking Buildbucket for the build status
[01:34:22.504] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:22.504] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:179:0) after 1m0s
[01:35:22.528] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:179:0)
[01:35:22.528] Timer tick, asking Buildbucket for the build status
[01:35:22.715] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:22.715] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:180:0) after 1m0s
[01:36:22.776] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:180:0)
[01:36:22.776] Timer tick, asking Buildbucket for the build status
[01:36:22.844] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:22.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:181:0) after 1m0s
[01:37:22.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:181:0)
[01:37:22.871] Timer tick, asking Buildbucket for the build status
[01:37:22.945] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:22.945] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:182:0) after 1m0s
[01:38:22.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:182:0)
[01:38:22.971] Timer tick, asking Buildbucket for the build status
[01:38:23.101] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:23.101] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:183:0) after 1m0s
[01:39:23.125] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:183:0)
[01:39:23.125] Timer tick, asking Buildbucket for the build status
[01:39:23.292] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:23.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:184:0) after 1m0s
[01:40:23.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:184:0)
[01:40:23.318] Timer tick, asking Buildbucket for the build status
[01:40:23.407] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:23.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:185:0) after 1m0s
[01:41:23.449] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:185:0)
[01:41:23.449] Timer tick, asking Buildbucket for the build status
[01:41:23.562] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:23.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:186:0) after 1m0s
[01:42:23.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:186:0)
[01:42:23.587] Timer tick, asking Buildbucket for the build status
[01:42:23.712] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:23.712] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:187:0) after 1m0s
[01:43:23.735] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:187:0)
[01:43:23.735] Timer tick, asking Buildbucket for the build status
[01:43:23.831] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:23.831] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:188:0) after 1m0s
[01:44:23.854] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:188:0)
[01:44:23.854] Timer tick, asking Buildbucket for the build status
[01:44:23.929] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:23.929] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:189:0) after 1m0s
[01:45:23.951] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:189:0)
[01:45:23.951] Timer tick, asking Buildbucket for the build status
[01:45:24.130] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:24.130] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:190:0) after 1m0s
[01:46:24.152] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:190:0)
[01:46:24.152] Timer tick, asking Buildbucket for the build status
[01:46:24.290] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:24.290] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:191:0) after 1m0s
[01:47:24.326] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:191:0)
[01:47:24.326] Timer tick, asking Buildbucket for the build status
[01:47:24.462] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:24.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:192:0) after 1m0s
[01:48:24.481] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:192:0)
[01:48:24.481] Timer tick, asking Buildbucket for the build status
[01:48:24.548] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:24.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:193:0) after 1m0s
[01:49:24.574] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:193:0)
[01:49:24.574] Timer tick, asking Buildbucket for the build status
[01:49:24.649] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:24.649] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:194:0) after 1m0s
[01:50:24.681] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:194:0)
[01:50:24.681] Timer tick, asking Buildbucket for the build status
[01:50:24.764] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:24.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:195:0) after 1m0s
[01:51:24.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:195:0)
[01:51:24.787] Timer tick, asking Buildbucket for the build status
[01:51:24.840] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:24.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:196:0) after 1m0s
[01:52:24.875] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:196:0)
[01:52:24.875] Timer tick, asking Buildbucket for the build status
[01:52:25.135] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:25.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:197:0) after 1m0s
[01:53:25.155] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:197:0)
[01:53:25.155] Timer tick, asking Buildbucket for the build status
[01:53:25.210] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:25.210] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:198:0) after 1m0s
[01:54:25.236] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:198:0)
[01:54:25.236] Timer tick, asking Buildbucket for the build status
[01:54:25.306] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:25.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:199:0) after 1m0s
[01:55:25.329] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:199:0)
[01:55:25.329] Timer tick, asking Buildbucket for the build status
[01:55:25.509] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:25.509] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:200:0) after 1m0s
[01:56:25.530] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:200:0)
[01:56:25.530] Timer tick, asking Buildbucket for the build status
[01:56:25.666] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:25.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:201:0) after 1m0s
[01:57:25.696] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:201:0)
[01:57:25.696] Timer tick, asking Buildbucket for the build status
[01:57:25.851] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:25.851] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:202:0) after 1m0s
[01:58:25.872] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:202:0)
[01:58:25.872] Timer tick, asking Buildbucket for the build status
[01:58:25.932] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:25.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:203:0) after 1m0s
[01:59:25.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:203:0)
[01:59:25.967] Timer tick, asking Buildbucket for the build status
[01:59:26.194] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:26.194] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:204:0) after 1m0s
[02:00:26.231] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:204:0)
[02:00:26.231] Timer tick, asking Buildbucket for the build status
[02:00:26.303] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:26.303] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:205:0) after 1m0s
[02:01:26.355] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:205:0)
[02:01:26.355] Timer tick, asking Buildbucket for the build status
[02:01:26.510] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:26.510] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:206:0) after 1m0s
[02:02:26.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:206:0)
[02:02:26.536] Timer tick, asking Buildbucket for the build status
[02:02:26.571] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:26.571] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:207:0) after 1m0s
[02:03:26.596] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:207:0)
[02:03:26.596] Timer tick, asking Buildbucket for the build status
[02:03:26.653] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:26.653] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:208:0) after 1m0s
[02:04:26.687] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:208:0)
[02:04:26.687] Timer tick, asking Buildbucket for the build status
[02:04:26.775] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:26.775] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:209:0) after 1m0s
[02:05:26.808] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:209:0)
[02:05:26.808] Timer tick, asking Buildbucket for the build status
[02:05:26.918] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:26.918] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:210:0) after 1m0s
[02:06:26.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:210:0)
[02:06:26.969] Timer tick, asking Buildbucket for the build status
[02:06:27.062] Build 8935550703821937152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:27.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:211:0) after 1m0s
[02:06:41.212] Received PubSub notification, asking Buildbucket for the build status
[02:06:41.466] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:27.086] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:211:0)
[02:07:27.086] Timer tick, asking Buildbucket for the build status
[02:07:27.146] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:27.146] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:213:0) after 1m0s
[02:08:27.171] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:213:0)
[02:08:27.171] Timer tick, asking Buildbucket for the build status
[02:08:27.245] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:27.245] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:214:0) after 1m0s
[02:09:27.270] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:214:0)
[02:09:27.270] Timer tick, asking Buildbucket for the build status
[02:09:27.339] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:27.339] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:215:0) after 1m0s
[02:10:27.362] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:215:0)
[02:10:27.362] Timer tick, asking Buildbucket for the build status
[02:10:27.603] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:27.603] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:216:0) after 1m0s
[02:11:27.627] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:216:0)
[02:11:27.627] Timer tick, asking Buildbucket for the build status
[02:11:27.744] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:27.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:217:0) after 1m0s
[02:12:27.767] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:217:0)
[02:12:27.767] Timer tick, asking Buildbucket for the build status
[02:12:27.819] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:27.819] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:218:0) after 1m0s
[02:13:27.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:218:0)
[02:13:27.844] Timer tick, asking Buildbucket for the build status
[02:13:27.915] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:27.915] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:219:0) after 1m0s
[02:14:27.946] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:219:0)
[02:14:27.946] Timer tick, asking Buildbucket for the build status
[02:14:28.052] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:28.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:220:0) after 1m0s
[02:15:28.085] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:220:0)
[02:15:28.085] Timer tick, asking Buildbucket for the build status
[02:15:28.166] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:28.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:221:0) after 1m0s
[02:16:28.189] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:221:0)
[02:16:28.189] Timer tick, asking Buildbucket for the build status
[02:16:28.247] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:28.247] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:222:0) after 1m0s
[02:17:28.272] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:222:0)
[02:17:28.272] Timer tick, asking Buildbucket for the build status
[02:17:28.351] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:28.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:223:0) after 1m0s
[02:18:28.374] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:223:0)
[02:18:28.374] Timer tick, asking Buildbucket for the build status
[02:18:28.418] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:28.418] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:224:0) after 1m0s
[02:19:28.442] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:224:0)
[02:19:28.442] Timer tick, asking Buildbucket for the build status
[02:19:28.514] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:28.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:225:0) after 1m0s
[02:20:28.539] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:225:0)
[02:20:28.539] Timer tick, asking Buildbucket for the build status
[02:20:28.765] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:28.765] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:226:0) after 1m0s
[02:21:28.826] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:226:0)
[02:21:28.826] Timer tick, asking Buildbucket for the build status
[02:21:28.997] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:28.997] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:227:0) after 1m0s
[02:22:29.028] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:227:0)
[02:22:29.028] Timer tick, asking Buildbucket for the build status
[02:22:29.108] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:29.108] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:228:0) after 1m0s
[02:23:29.135] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:228:0)
[02:23:29.135] Timer tick, asking Buildbucket for the build status
[02:23:29.280] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:29.280] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:229:0) after 1m0s
[02:24:29.310] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:229:0)
[02:24:29.310] Timer tick, asking Buildbucket for the build status
[02:24:29.349] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:29.349] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:230:0) after 1m0s
[02:25:29.374] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:230:0)
[02:25:29.374] Timer tick, asking Buildbucket for the build status
[02:25:29.500] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:29.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:231:0) after 1m0s
[02:26:29.526] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:231:0)
[02:26:29.526] Timer tick, asking Buildbucket for the build status
[02:26:29.597] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:29.597] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:232:0) after 1m0s
[02:27:29.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:232:0)
[02:27:29.660] Timer tick, asking Buildbucket for the build status
[02:27:29.721] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:29.721] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:233:0) after 1m0s
[02:28:29.752] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:233:0)
[02:28:29.752] Timer tick, asking Buildbucket for the build status
[02:28:29.984] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:29.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:234:0) after 1m0s
[02:29:30.026] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:234:0)
[02:29:30.026] Timer tick, asking Buildbucket for the build status
[02:29:30.109] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:30.109] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:235:0) after 1m0s
[02:30:30.136] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:235:0)
[02:30:30.136] Timer tick, asking Buildbucket for the build status
[02:30:30.286] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:30.286] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:236:0) after 1m0s
[02:31:30.320] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:236:0)
[02:31:30.320] Timer tick, asking Buildbucket for the build status
[02:31:30.399] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:30.399] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:237:0) after 1m0s
[02:32:30.456] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:237:0)
[02:32:30.456] Timer tick, asking Buildbucket for the build status
[02:32:30.530] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:30.530] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:238:0) after 1m0s
[02:33:30.562] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:238:0)
[02:33:30.562] Timer tick, asking Buildbucket for the build status
[02:33:30.710] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:30.710] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:239:0) after 1m0s
[02:34:30.740] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:239:0)
[02:34:30.740] Timer tick, asking Buildbucket for the build status
[02:34:30.806] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:30.806] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:240:0) after 1m0s
[02:35:30.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:240:0)
[02:35:30.832] Timer tick, asking Buildbucket for the build status
[02:35:31.001] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:31.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:241:0) after 1m0s
[02:36:31.051] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:241:0)
[02:36:31.051] Timer tick, asking Buildbucket for the build status
[02:36:31.197] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:31.198] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:242:0) after 1m0s
[02:37:31.223] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:242:0)
[02:37:31.223] Timer tick, asking Buildbucket for the build status
[02:37:31.326] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:31.326] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:243:0) after 1m0s
[02:38:31.352] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:243:0)
[02:38:31.352] Timer tick, asking Buildbucket for the build status
[02:38:31.442] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:31.442] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:244:0) after 1m0s
[02:39:31.471] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:244:0)
[02:39:31.471] Timer tick, asking Buildbucket for the build status
[02:39:31.626] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:31.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:245:0) after 1m0s
[02:40:31.654] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:245:0)
[02:40:31.654] Timer tick, asking Buildbucket for the build status
[02:40:31.716] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:31.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:246:0) after 1m0s
[02:41:31.743] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:246:0)
[02:41:31.743] Timer tick, asking Buildbucket for the build status
[02:41:31.814] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:31.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:247:0) after 1m0s
[02:42:31.845] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:247:0)
[02:42:31.845] Timer tick, asking Buildbucket for the build status
[02:42:31.921] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:31.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:248:0) after 1m0s
[02:43:31.946] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:248:0)
[02:43:31.946] Timer tick, asking Buildbucket for the build status
[02:43:32.088] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:32.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:249:0) after 1m0s
[02:44:32.115] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:249:0)
[02:44:32.115] Timer tick, asking Buildbucket for the build status
[02:44:32.216] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:32.216] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:250:0) after 1m0s
[02:45:32.287] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:250:0)
[02:45:32.287] Timer tick, asking Buildbucket for the build status
[02:45:32.368] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:32.368] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:251:0) after 1m0s
[02:46:32.393] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:251:0)
[02:46:32.393] Timer tick, asking Buildbucket for the build status
[02:46:32.564] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:32.564] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:252:0) after 1m0s
[02:47:32.592] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:252:0)
[02:47:32.592] Timer tick, asking Buildbucket for the build status
[02:47:32.872] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:32.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:253:0) after 1m0s
[02:48:32.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:253:0)
[02:48:32.900] Timer tick, asking Buildbucket for the build status
[02:48:33.002] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:33.002] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:254:0) after 1m0s
[02:49:33.029] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:254:0)
[02:49:33.029] Timer tick, asking Buildbucket for the build status
[02:49:33.079] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:33.079] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:255:0) after 1m0s
[02:50:33.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:255:0)
[02:50:33.127] Timer tick, asking Buildbucket for the build status
[02:50:33.283] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:33.283] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:256:0) after 1m0s
[02:51:33.309] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:256:0)
[02:51:33.309] Timer tick, asking Buildbucket for the build status
[02:51:33.493] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:33.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:257:0) after 1m0s
[02:52:33.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:257:0)
[02:52:33.535] Timer tick, asking Buildbucket for the build status
[02:52:33.647] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:33.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:258:0) after 1m0s
[02:53:33.673] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:258:0)
[02:53:33.673] Timer tick, asking Buildbucket for the build status
[02:53:33.826] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:33.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:259:0) after 1m0s
[02:54:33.854] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:259:0)
[02:54:33.854] Timer tick, asking Buildbucket for the build status
[02:54:33.905] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:33.905] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:260:0) after 1m0s
[02:55:33.932] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:260:0)
[02:55:33.932] Timer tick, asking Buildbucket for the build status
[02:55:33.995] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:33.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:261:0) after 1m0s
[02:56:34.020] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:261:0)
[02:56:34.020] Timer tick, asking Buildbucket for the build status
[02:56:34.132] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:34.132] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:262:0) after 1m0s
[02:57:34.169] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:262:0)
[02:57:34.169] Timer tick, asking Buildbucket for the build status
[02:57:34.379] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:34.379] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:263:0) after 1m0s
[02:58:34.403] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:263:0)
[02:58:34.403] Timer tick, asking Buildbucket for the build status
[02:58:34.467] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:34.467] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:264:0) after 1m0s
[02:59:34.496] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:264:0)
[02:59:34.496] Timer tick, asking Buildbucket for the build status
[02:59:34.568] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:34.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:265:0) after 1m0s
[03:00:34.627] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:265:0)
[03:00:34.627] Timer tick, asking Buildbucket for the build status
[03:00:34.684] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:34.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:266:0) after 1m0s
[03:01:34.811] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:266:0)
[03:01:34.811] Timer tick, asking Buildbucket for the build status
[03:01:34.868] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:34.869] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:267:0) after 1m0s
[03:02:34.902] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:267:0)
[03:02:34.902] Timer tick, asking Buildbucket for the build status
[03:02:35.139] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:35.139] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:268:0) after 1m0s
[03:03:35.180] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:268:0)
[03:03:35.180] Timer tick, asking Buildbucket for the build status
[03:03:35.435] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:35.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:269:0) after 1m0s
[03:04:35.474] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:269:0)
[03:04:35.474] Timer tick, asking Buildbucket for the build status
[03:04:35.545] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:35.545] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:270:0) after 1m0s
[03:05:35.571] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:270:0)
[03:05:35.571] Timer tick, asking Buildbucket for the build status
[03:05:35.703] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:35.703] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:271:0) after 1m0s
[03:06:35.747] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:271:0)
[03:06:35.748] Timer tick, asking Buildbucket for the build status
[03:06:35.818] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:35.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:272:0) after 1m0s
[03:07:35.849] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:272:0)
[03:07:35.849] Timer tick, asking Buildbucket for the build status
[03:07:35.933] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:35.933] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:273:0) after 1m0s
[03:08:35.965] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:273:0)
[03:08:35.965] Timer tick, asking Buildbucket for the build status
[03:08:36.206] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:36.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:274:0) after 1m0s
[03:09:36.231] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:274:0)
[03:09:36.231] Timer tick, asking Buildbucket for the build status
[03:09:36.324] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:36.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:275:0) after 1m0s
[03:10:36.409] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:275:0)
[03:10:36.409] Timer tick, asking Buildbucket for the build status
[03:10:36.503] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:36.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:276:0) after 1m0s
[03:11:36.589] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:276:0)
[03:11:36.589] Timer tick, asking Buildbucket for the build status
[03:11:36.647] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:36.647] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:277:0) after 1m0s
[03:12:36.673] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:277:0)
[03:12:36.673] Timer tick, asking Buildbucket for the build status
[03:12:36.716] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:36.716] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:278:0) after 1m0s
[03:13:36.742] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:278:0)
[03:13:36.742] Timer tick, asking Buildbucket for the build status
[03:13:36.805] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:36.805] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:279:0) after 1m0s
[03:14:36.837] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:279:0)
[03:14:36.837] Timer tick, asking Buildbucket for the build status
[03:14:36.900] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:36.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:280:0) after 1m0s
[03:15:36.928] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:280:0)
[03:15:36.928] Timer tick, asking Buildbucket for the build status
[03:15:37.015] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:37.015] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:281:0) after 1m0s
[03:16:37.053] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:281:0)
[03:16:37.053] Timer tick, asking Buildbucket for the build status
[03:16:37.140] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:37.140] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:282:0) after 1m0s
[03:17:37.192] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:282:0)
[03:17:37.192] Timer tick, asking Buildbucket for the build status
[03:17:37.326] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:37.326] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:283:0) after 1m0s
[03:18:37.366] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:283:0)
[03:18:37.366] Timer tick, asking Buildbucket for the build status
[03:18:37.542] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:37.542] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:284:0) after 1m0s
[03:19:37.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:284:0)
[03:19:37.569] Timer tick, asking Buildbucket for the build status
[03:19:37.662] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:37.662] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:285:0) after 1m0s
[03:20:37.940] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:285:0)
[03:20:37.941] Timer tick, asking Buildbucket for the build status
[03:20:38.123] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:38.123] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:286:0) after 1m0s
[03:21:38.162] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:286:0)
[03:21:38.162] Timer tick, asking Buildbucket for the build status
[03:21:38.232] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:38.232] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:287:0) after 1m0s
[03:22:38.267] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:287:0)
[03:22:38.267] Timer tick, asking Buildbucket for the build status
[03:22:38.462] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:38.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:288:0) after 1m0s
[03:23:38.510] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:288:0)
[03:23:38.510] Timer tick, asking Buildbucket for the build status
[03:23:38.585] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:38.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:289:0) after 1m0s
[03:24:38.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:289:0)
[03:24:38.616] Timer tick, asking Buildbucket for the build status
[03:24:38.782] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:38.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:290:0) after 1m0s
[03:25:38.818] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:290:0)
[03:25:38.818] Timer tick, asking Buildbucket for the build status
[03:25:38.893] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:38.893] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:291:0) after 1m0s
[03:26:38.921] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:291:0)
[03:26:38.921] Timer tick, asking Buildbucket for the build status
[03:26:38.997] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:38.997] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:292:0) after 1m0s
[03:27:39.032] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:292:0)
[03:27:39.032] Timer tick, asking Buildbucket for the build status
[03:27:39.181] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:39.181] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:293:0) after 1m0s
[03:28:39.305] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:293:0)
[03:28:39.305] Timer tick, asking Buildbucket for the build status
[03:28:39.367] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:39.367] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:294:0) after 1m0s
[03:29:39.470] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:294:0)
[03:29:39.470] Timer tick, asking Buildbucket for the build status
[03:29:39.537] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:39.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:295:0) after 1m0s
[03:30:39.566] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:295:0)
[03:30:39.566] Timer tick, asking Buildbucket for the build status
[03:30:39.677] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:39.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:296:0) after 1m0s
[03:31:39.706] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:296:0)
[03:31:39.706] Timer tick, asking Buildbucket for the build status
[03:31:39.932] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:39.932] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:297:0) after 1m0s
[03:32:40.055] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:297:0)
[03:32:40.055] Timer tick, asking Buildbucket for the build status
[03:32:40.116] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:40.116] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:298:0) after 1m0s
[03:33:40.222] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:298:0)
[03:33:40.222] Timer tick, asking Buildbucket for the build status
[03:33:40.619] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:40.619] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:299:0) after 1m0s
[03:34:40.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:299:0)
[03:34:40.652] Timer tick, asking Buildbucket for the build status
[03:34:40.712] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:40.712] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:300:0) after 1m0s
[03:35:40.792] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:300:0)
[03:35:40.793] Timer tick, asking Buildbucket for the build status
[03:35:40.865] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:40.865] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:301:0) after 1m0s
[03:36:40.967] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:301:0)
[03:36:40.967] Timer tick, asking Buildbucket for the build status
[03:36:41.187] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:41.187] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:302:0) after 1m0s
[03:37:41.212] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:302:0)
[03:37:41.212] Timer tick, asking Buildbucket for the build status
[03:37:41.377] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:41.377] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:303:0) after 1m0s
[03:38:41.510] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:303:0)
[03:38:41.510] Timer tick, asking Buildbucket for the build status
[03:38:41.568] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:41.568] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:304:0) after 1m0s
[03:39:41.659] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:304:0)
[03:39:41.659] Timer tick, asking Buildbucket for the build status
[03:39:41.719] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:41.719] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:305:0) after 1m0s
[03:40:41.750] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:305:0)
[03:40:41.751] Timer tick, asking Buildbucket for the build status
[03:40:41.951] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:41.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:306:0) after 1m0s
[03:41:41.978] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:306:0)
[03:41:41.978] Timer tick, asking Buildbucket for the build status
[03:41:42.039] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:42.039] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:307:0) after 1m0s
[03:42:42.083] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:307:0)
[03:42:42.083] Timer tick, asking Buildbucket for the build status
[03:42:42.160] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:42.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:308:0) after 1m0s
[03:43:42.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:308:0)
[03:43:42.217] Timer tick, asking Buildbucket for the build status
[03:43:42.269] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:42.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:309:0) after 1m0s
[03:44:42.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:309:0)
[03:44:42.344] Timer tick, asking Buildbucket for the build status
[03:44:42.394] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:42.394] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:310:0) after 1m0s
[03:45:42.434] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:310:0)
[03:45:42.434] Timer tick, asking Buildbucket for the build status
[03:45:42.511] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:42.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:311:0) after 1m0s
[03:46:42.546] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:311:0)
[03:46:42.546] Timer tick, asking Buildbucket for the build status
[03:46:42.613] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:42.613] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:312:0) after 1m0s
[03:47:42.653] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:312:0)
[03:47:42.653] Timer tick, asking Buildbucket for the build status
[03:47:42.689] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:42.689] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:313:0) after 1m0s
[03:48:42.717] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:313:0)
[03:48:42.717] Timer tick, asking Buildbucket for the build status
[03:48:43.011] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:43.011] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:314:0) after 1m0s
[03:49:43.047] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:314:0)
[03:49:43.047] Timer tick, asking Buildbucket for the build status
[03:49:43.113] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:43.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:315:0) after 1m0s
[03:50:43.142] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:315:0)
[03:50:43.142] Timer tick, asking Buildbucket for the build status
[03:50:43.220] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:43.220] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:316:0) after 1m0s
[03:51:43.246] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:316:0)
[03:51:43.246] Timer tick, asking Buildbucket for the build status
[03:51:43.402] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:43.402] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:317:0) after 1m0s
[03:52:43.470] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:317:0)
[03:52:43.470] Timer tick, asking Buildbucket for the build status
[03:52:43.585] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:43.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:318:0) after 1m0s
[03:53:43.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:318:0)
[03:53:43.652] Timer tick, asking Buildbucket for the build status
[03:53:43.709] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:43.709] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:319:0) after 1m0s
[03:54:43.755] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:319:0)
[03:54:43.755] Timer tick, asking Buildbucket for the build status
[03:54:43.895] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:43.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:320:0) after 1m0s
[03:55:43.926] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:320:0)
[03:55:43.926] Timer tick, asking Buildbucket for the build status
[03:55:43.986] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:43.986] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:321:0) after 1m0s
[03:56:44.011] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:321:0)
[03:56:44.011] Timer tick, asking Buildbucket for the build status
[03:56:44.050] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:44.050] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:322:0) after 1m0s
[03:57:44.083] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:322:0)
[03:57:44.083] Timer tick, asking Buildbucket for the build status
[03:57:44.142] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:44.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:323:0) after 1m0s
[03:58:44.312] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:323:0)
[03:58:44.312] Timer tick, asking Buildbucket for the build status
[03:58:44.414] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:44.414] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:324:0) after 1m0s
[03:59:44.446] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:324:0)
[03:59:44.446] Timer tick, asking Buildbucket for the build status
[03:59:44.513] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:44.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:325:0) after 1m0s
[04:00:44.538] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:325:0)
[04:00:44.538] Timer tick, asking Buildbucket for the build status
[04:00:44.637] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:44.637] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:326:0) after 1m0s
[04:01:44.672] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:326:0)
[04:01:44.672] Timer tick, asking Buildbucket for the build status
[04:01:44.748] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:44.748] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:327:0) after 1m0s
[04:02:44.777] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:327:0)
[04:02:44.777] Timer tick, asking Buildbucket for the build status
[04:02:44.844] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:44.844] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:328:0) after 1m0s
[04:03:44.876] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:328:0)
[04:03:44.876] Timer tick, asking Buildbucket for the build status
[04:03:44.942] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:44.942] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:329:0) after 1m0s
[04:04:44.983] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:329:0)
[04:04:44.983] Timer tick, asking Buildbucket for the build status
[04:04:45.057] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:45.057] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:330:0) after 1m0s
[04:05:45.119] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:330:0)
[04:05:45.119] Timer tick, asking Buildbucket for the build status
[04:05:45.171] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:45.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:331:0) after 1m0s
[04:06:45.201] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:331:0)
[04:06:45.201] Timer tick, asking Buildbucket for the build status
[04:06:45.278] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:45.278] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:332:0) after 1m0s
[04:07:45.308] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:332:0)
[04:07:45.308] Timer tick, asking Buildbucket for the build status
[04:07:45.562] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:45.562] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:333:0) after 1m0s
[04:08:45.590] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:333:0)
[04:08:45.590] Timer tick, asking Buildbucket for the build status
[04:08:45.696] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:45.696] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:334:0) after 1m0s
[04:09:45.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:334:0)
[04:09:45.722] Timer tick, asking Buildbucket for the build status
[04:09:45.781] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:45.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:335:0) after 1m0s
[04:10:45.809] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:335:0)
[04:10:45.809] Timer tick, asking Buildbucket for the build status
[04:10:46.059] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:46.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:336:0) after 1m0s
[04:11:46.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:336:0)
[04:11:46.318] Timer tick, asking Buildbucket for the build status
[04:11:46.411] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:46.411] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:337:0) after 1m0s
[04:12:46.437] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:337:0)
[04:12:46.437] Timer tick, asking Buildbucket for the build status
[04:12:46.547] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:46.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:338:0) after 1m0s
[04:13:46.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:338:0)
[04:13:46.587] Timer tick, asking Buildbucket for the build status
[04:13:46.990] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:46.990] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:339:0) after 1m0s
[04:14:47.021] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:339:0)
[04:14:47.021] Timer tick, asking Buildbucket for the build status
[04:14:47.136] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:47.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:340:0) after 1m0s
[04:15:47.169] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:340:0)
[04:15:47.169] Timer tick, asking Buildbucket for the build status
[04:15:47.305] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:47.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:341:0) after 1m0s
[04:16:47.359] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:341:0)
[04:16:47.359] Timer tick, asking Buildbucket for the build status
[04:16:47.432] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:47.432] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:342:0) after 1m0s
[04:17:47.470] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:342:0)
[04:17:47.470] Timer tick, asking Buildbucket for the build status
[04:17:47.544] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:47.544] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:343:0) after 1m0s
[04:18:47.573] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:343:0)
[04:18:47.573] Timer tick, asking Buildbucket for the build status
[04:18:47.654] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:47.654] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:344:0) after 1m0s
[04:19:47.687] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:344:0)
[04:19:47.687] Timer tick, asking Buildbucket for the build status
[04:19:47.848] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:47.848] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:345:0) after 1m0s
[04:20:47.874] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:345:0)
[04:20:47.874] Timer tick, asking Buildbucket for the build status
[04:20:47.921] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:47.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:346:0) after 1m0s
[04:21:47.983] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:346:0)
[04:21:47.983] Timer tick, asking Buildbucket for the build status
[04:21:48.309] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:48.309] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:347:0) after 1m0s
[04:22:48.349] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:347:0)
[04:22:48.349] Timer tick, asking Buildbucket for the build status
[04:22:48.439] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:48.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:348:0) after 1m0s
[04:23:48.475] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:348:0)
[04:23:48.475] Timer tick, asking Buildbucket for the build status
[04:23:48.536] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:48.536] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:349:0) after 1m0s
[04:24:48.572] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:349:0)
[04:24:48.572] Timer tick, asking Buildbucket for the build status
[04:24:48.693] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:48.693] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:350:0) after 1m0s
[04:25:48.868] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:350:0)
[04:25:48.868] Timer tick, asking Buildbucket for the build status
[04:25:48.969] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:48.969] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:351:0) after 1m0s
[04:26:49.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:351:0)
[04:26:49.018] Timer tick, asking Buildbucket for the build status
[04:26:49.075] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:49.075] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:352:0) after 1m0s
[04:27:49.159] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:352:0)
[04:27:49.159] Timer tick, asking Buildbucket for the build status
[04:27:49.221] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:49.221] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:353:0) after 1m0s
[04:28:49.256] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:353:0)
[04:28:49.256] Timer tick, asking Buildbucket for the build status
[04:28:49.352] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:49.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:354:0) after 1m0s
[04:29:49.385] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:354:0)
[04:29:49.385] Timer tick, asking Buildbucket for the build status
[04:29:49.431] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:49.431] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:355:0) after 1m0s
[04:30:49.470] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:355:0)
[04:30:49.470] Timer tick, asking Buildbucket for the build status
[04:30:49.574] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:49.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:356:0) after 1m0s
[04:31:49.612] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:356:0)
[04:31:49.612] Timer tick, asking Buildbucket for the build status
[04:31:49.694] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:49.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:357:0) after 1m0s
[04:32:49.739] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:357:0)
[04:32:49.739] Timer tick, asking Buildbucket for the build status
[04:32:49.818] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:49.818] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:358:0) after 1m0s
[04:33:49.851] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:358:0)
[04:33:49.851] Timer tick, asking Buildbucket for the build status
[04:33:49.944] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:49.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:359:0) after 1m0s
[04:34:49.973] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:359:0)
[04:34:49.973] Timer tick, asking Buildbucket for the build status
[04:34:50.066] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:50.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:360:0) after 1m0s
[04:35:50.096] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:360:0)
[04:35:50.096] Timer tick, asking Buildbucket for the build status
[04:35:50.363] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:50.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:361:0) after 1m0s
[04:36:50.408] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:361:0)
[04:36:50.408] Timer tick, asking Buildbucket for the build status
[04:36:50.511] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:50.511] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:362:0) after 1m0s
[04:37:50.554] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:362:0)
[04:37:50.554] Timer tick, asking Buildbucket for the build status
[04:37:50.624] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:50.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:363:0) after 1m0s
[04:38:50.655] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:363:0)
[04:38:50.655] Timer tick, asking Buildbucket for the build status
[04:38:50.947] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:50.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:364:0) after 1m0s
[04:39:50.981] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:364:0)
[04:39:50.981] Timer tick, asking Buildbucket for the build status
[04:39:51.066] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:51.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:365:0) after 1m0s
[04:40:51.095] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:365:0)
[04:40:51.095] Timer tick, asking Buildbucket for the build status
[04:40:51.155] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:51.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:366:0) after 1m0s
[04:41:51.216] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:366:0)
[04:41:51.216] Timer tick, asking Buildbucket for the build status
[04:41:51.525] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:51.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:367:0) after 1m0s
[04:42:51.575] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:367:0)
[04:42:51.575] Timer tick, asking Buildbucket for the build status
[04:42:51.702] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:51.702] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:368:0) after 1m0s
[04:43:51.733] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:368:0)
[04:43:51.733] Timer tick, asking Buildbucket for the build status
[04:43:51.803] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:51.803] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:369:0) after 1m0s
[04:44:51.848] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:369:0)
[04:44:51.848] Timer tick, asking Buildbucket for the build status
[04:44:52.182] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:52.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:370:0) after 1m0s
[04:45:52.265] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:370:0)
[04:45:52.265] Timer tick, asking Buildbucket for the build status
[04:45:52.328] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:52.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:371:0) after 1m0s
[04:46:52.375] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:371:0)
[04:46:52.375] Timer tick, asking Buildbucket for the build status
[04:46:52.500] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:52.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:372:0) after 1m0s
[04:47:52.579] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:372:0)
[04:47:52.579] Timer tick, asking Buildbucket for the build status
[04:47:52.660] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:52.660] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:373:0) after 1m0s
[04:48:52.691] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:373:0)
[04:48:52.691] Timer tick, asking Buildbucket for the build status
[04:48:52.999] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:52.999] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:374:0) after 1m0s
[04:49:53.028] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:374:0)
[04:49:53.028] Timer tick, asking Buildbucket for the build status
[04:49:53.111] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:53.111] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:375:0) after 1m0s
[04:50:53.150] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:375:0)
[04:50:53.150] Timer tick, asking Buildbucket for the build status
[04:50:53.248] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:53.248] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:376:0) after 1m0s
[04:51:53.281] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:376:0)
[04:51:53.281] Timer tick, asking Buildbucket for the build status
[04:51:53.396] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:53.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:377:0) after 1m0s
[04:52:53.426] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:377:0)
[04:52:53.426] Timer tick, asking Buildbucket for the build status
[04:52:53.496] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:53.496] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:378:0) after 1m0s
[04:53:53.566] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:378:0)
[04:53:53.566] Timer tick, asking Buildbucket for the build status
[04:53:53.641] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:53.641] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:379:0) after 1m0s
[04:54:53.925] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:379:0)
[04:54:53.925] Timer tick, asking Buildbucket for the build status
[04:54:54.005] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:54.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:380:0) after 1m0s
[04:55:54.323] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:380:0)
[04:55:54.323] Timer tick, asking Buildbucket for the build status
[04:55:54.412] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:54.412] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:381:0) after 1m0s
[04:56:54.717] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:381:0)
[04:56:54.717] Timer tick, asking Buildbucket for the build status
[04:56:54.775] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:54.775] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:382:0) after 1m0s
[04:57:55.111] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:382:0)
[04:57:55.111] Timer tick, asking Buildbucket for the build status
[04:57:55.215] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:55.215] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:383:0) after 1m0s
[04:58:55.243] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:383:0)
[04:58:55.243] Timer tick, asking Buildbucket for the build status
[04:58:55.410] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:55.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:384:0) after 1m0s
[04:59:55.489] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:384:0)
[04:59:55.489] Timer tick, asking Buildbucket for the build status
[04:59:55.675] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:55.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:385:0) after 1m0s
[05:00:55.707] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:385:0)
[05:00:55.707] Timer tick, asking Buildbucket for the build status
[05:00:55.751] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:55.751] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:386:0) after 1m0s
[05:01:55.813] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:386:0)
[05:01:55.813] Timer tick, asking Buildbucket for the build status
[05:01:55.870] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:55.870] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:387:0) after 1m0s
[05:02:55.919] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:387:0)
[05:02:55.919] Timer tick, asking Buildbucket for the build status
[05:02:56.119] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:56.119] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:388:0) after 1m0s
[05:03:56.184] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:388:0)
[05:03:56.184] Timer tick, asking Buildbucket for the build status
[05:03:56.425] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:56.425] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:389:0) after 1m0s
[05:04:56.473] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:389:0)
[05:04:56.473] Timer tick, asking Buildbucket for the build status
[05:04:57.576] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:57.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:390:0) after 1m0s
[05:05:57.727] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:390:0)
[05:05:57.727] Timer tick, asking Buildbucket for the build status
[05:05:57.913] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:57.913] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:391:0) after 1m0s
[05:06:57.943] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:391:0)
[05:06:57.943] Timer tick, asking Buildbucket for the build status
[05:06:58.207] Build 8935550703821937152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:58.207] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9100980766110791488:392:0) after 1m0s
[05:07:09.455] Received PubSub notification, asking Buildbucket for the build status
[05:07:09.495] Build 8935550703821937152: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[05:07:09.495] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1536815228332289",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1536791813027813",
    "experimental": true,
    "failure_reason": "INFRA_FAILURE",
    "id": "8935550703821937152",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_32\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"32b6deb45d5fbc77c5f65d35db45c48cae3c06bc\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"kitchen crashed or got killed\", \"bootstrapperCallStack\": [], \"type\": \"BOOTSTRAPPER_ERROR\"}, \"recipeResult\": null, \"recipeExitCode\": null, \"recipe\": null, \"annotationUrl\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3770-2abfc04\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-02248837-us-east1-b-l32j\"], \"pool\": [\"luci.nacl.toolchain\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1536804400385744",
    "status": "COMPLETED",
    "status_changed_ts": "1536815228946149",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/3",
      "builder:linux-pnacl-x86_64-tests-x86_32",
      "buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9100980766110791488",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_dimension:caches:builder_91fd20d3b70fcaa51af83cb3d5f4f5aac058c8ab0c404858b1894fb462151f3a_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-tests-x86_32/3",
      "swarming_tag:buildbucket_bucket:luci.nacl.toolchain",
      "swarming_tag:buildbucket_build_id:8935550703821937152",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
      "swarming_tag:builder:linux-pnacl-x86_64-tests-x86_32",
      "swarming_tag:buildset:commit/git/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/32b6deb45d5fbc77c5f65d35db45c48cae3c06bc",
      "swarming_tag:caches:builder_91fd20d3b70fcaa51af83cb3d5f4f5aac058c8ab0c404858b1894fb462151f3a_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/8935550703821937152/+/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:9100980766110791488",
      "swarming_tag:scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_tag:service_account:nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:ccd94b661aaeb4cc141585f6f7be3f211386159f",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:3fe8bfa67e912b10",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1536815228947186",
    "url": "https://ci.chromium.org/p/nacl/builders/luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/3",
    "utcnow_ts": "1536815229485125"
  }
}
[05:07:09.495] Invocation finished in 6h30m18.034565421s with status FAILED