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

• 1ed9878b8eb68c1e0d0268754dafcf83e747fa8f (6 years ago)

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

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

[02:31:08.000] New invocation is queued and will start shortly
[02:31:09.667] Starting the invocation (attempt 1)
[02:31:09.702] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:31:09.702] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:31:09.702] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9086742303105072992",
  "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\":\"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\"}}",
  "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:9086742303105072992",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
    "user_agent:luci-scheduler",
    "buildset:commit/git/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f",
    "gitiles_ref:refs/heads/master"
  ]
}
[02:31:10.891] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1550370669776352",
    "id": "8921312240527131648",
    "lease_expiration_ts": "1550521870486755",
    "lease_key": "145707169",
    "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\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1550370670685200",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/5121",
      "builder:linux-pnacl-x86_64-tests-x86_32",
      "buildset:commit/git/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9086742303105072992",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8921312240527131648/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:43121c8e9c537310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1550370670685319",
    "url": "https://ci.chromium.org/b/8921312240527131648",
    "utcnow_ts": "1550370670876567"
  }
}
[02:31:10.891] Task URL: https://ci.chromium.org/b/8921312240527131648
[02:31:10.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:2:0) after 1m0s
[02:32:10.911] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:2:0)
[02:32:10.911] Timer tick, asking Buildbucket for the build status
[02:32:10.987] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:10.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:3:0) after 1m0s
[02:33:11.003] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:3:0)
[02:33:11.003] Timer tick, asking Buildbucket for the build status
[02:33:11.094] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:11.094] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:4:0) after 1m0s
[02:34:11.113] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:4:0)
[02:34:11.113] Timer tick, asking Buildbucket for the build status
[02:34:11.260] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:11.260] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:5:0) after 1m0s
[02:35:11.287] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:5:0)
[02:35:11.287] Timer tick, asking Buildbucket for the build status
[02:35:11.458] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:11.458] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:6:0) after 1m0s
[02:36:11.519] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:6:0)
[02:36:11.519] Timer tick, asking Buildbucket for the build status
[02:36:11.582] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:11.582] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:7:0) after 1m0s
[02:37:11.599] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:7:0)
[02:37:11.599] Timer tick, asking Buildbucket for the build status
[02:37:11.668] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:11.668] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:8:0) after 1m0s
[02:38:11.684] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:8:0)
[02:38:11.684] Timer tick, asking Buildbucket for the build status
[02:38:11.778] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:11.779] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:9:0) after 1m0s
[02:39:11.795] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:9:0)
[02:39:11.795] Timer tick, asking Buildbucket for the build status
[02:39:11.872] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:11.872] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:10:0) after 1m0s
[02:40:11.892] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:10:0)
[02:40:11.892] Timer tick, asking Buildbucket for the build status
[02:40:12.072] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:12.072] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:11:0) after 1m0s
[02:41:12.103] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:11:0)
[02:41:12.103] Timer tick, asking Buildbucket for the build status
[02:41:12.179] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:12.179] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:12:0) after 1m0s
[02:42:12.219] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:12:0)
[02:42:12.219] Timer tick, asking Buildbucket for the build status
[02:42:12.334] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:12.334] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:13:0) after 1m0s
[02:43:12.351] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:13:0)
[02:43:12.351] Timer tick, asking Buildbucket for the build status
[02:43:12.610] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:12.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:14:0) after 1m0s
[02:44:12.624] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:14:0)
[02:44:12.625] Timer tick, asking Buildbucket for the build status
[02:44:12.854] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:12.854] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:15:0) after 1m0s
[02:45:12.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:15:0)
[02:45:12.871] Timer tick, asking Buildbucket for the build status
[02:45:13.001] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:13.001] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:16:0) after 1m0s
[02:46:13.018] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:16:0)
[02:46:13.018] Timer tick, asking Buildbucket for the build status
[02:46:13.140] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:13.140] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:17:0) after 1m0s
[02:47:13.199] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:17:0)
[02:47:13.199] Timer tick, asking Buildbucket for the build status
[02:47:13.343] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:13.343] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:18:0) after 1m0s
[02:48:13.363] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:18:0)
[02:48:13.363] Timer tick, asking Buildbucket for the build status
[02:48:13.512] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:13.512] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:19:0) after 1m0s
[02:49:13.532] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:19:0)
[02:49:13.532] Timer tick, asking Buildbucket for the build status
[02:49:13.744] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:13.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:20:0) after 1m0s
[02:50:13.761] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:20:0)
[02:50:13.761] Timer tick, asking Buildbucket for the build status
[02:50:13.873] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:13.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:21:0) after 1m0s
[02:51:13.896] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:21:0)
[02:51:13.896] Timer tick, asking Buildbucket for the build status
[02:51:13.962] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:13.962] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:22:0) after 1m0s
[02:52:13.979] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:22:0)
[02:52:13.979] Timer tick, asking Buildbucket for the build status
[02:52:14.062] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:14.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:23:0) after 1m0s
[02:53:14.099] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:23:0)
[02:53:14.099] Timer tick, asking Buildbucket for the build status
[02:53:14.407] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:14.407] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:24:0) after 1m0s
[02:54:14.426] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:24:0)
[02:54:14.426] Timer tick, asking Buildbucket for the build status
[02:54:14.501] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:14.501] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:25:0) after 1m0s
[02:55:14.519] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:25:0)
[02:55:14.519] Timer tick, asking Buildbucket for the build status
[02:55:14.584] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:14.584] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:26:0) after 1m0s
[02:56:14.602] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:26:0)
[02:56:14.602] Timer tick, asking Buildbucket for the build status
[02:56:14.690] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:14.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:27:0) after 1m0s
[02:57:14.706] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:27:0)
[02:57:14.706] Timer tick, asking Buildbucket for the build status
[02:57:14.830] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:14.830] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:28:0) after 1m0s
[02:58:14.847] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:28:0)
[02:58:14.847] Timer tick, asking Buildbucket for the build status
[02:58:14.916] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:14.916] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:29:0) after 1m0s
[02:59:14.942] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:29:0)
[02:59:14.942] Timer tick, asking Buildbucket for the build status
[02:59:15.120] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:15.120] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:30:0) after 1m0s
[03:00:15.140] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:30:0)
[03:00:15.140] Timer tick, asking Buildbucket for the build status
[03:00:15.262] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:15.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:31:0) after 1m0s
[03:01:15.279] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:31:0)
[03:01:15.279] Timer tick, asking Buildbucket for the build status
[03:01:16.432] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:16.432] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:32:0) after 1m0s
[03:02:16.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:32:0)
[03:02:16.536] Timer tick, asking Buildbucket for the build status
[03:02:16.585] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:16.585] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:33:0) after 1m0s
[03:03:16.655] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:33:0)
[03:03:16.655] Timer tick, asking Buildbucket for the build status
[03:03:16.728] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:16.728] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:34:0) after 1m0s
[03:04:16.753] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:34:0)
[03:04:16.753] Timer tick, asking Buildbucket for the build status
[03:04:16.864] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:16.864] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:35:0) after 1m0s
[03:05:16.930] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:35:0)
[03:05:16.930] Timer tick, asking Buildbucket for the build status
[03:05:17.044] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:17.044] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:36:0) after 1m0s
[03:06:17.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:36:0)
[03:06:17.072] Timer tick, asking Buildbucket for the build status
[03:06:17.200] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:17.200] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:37:0) after 1m0s
[03:07:17.223] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:37:0)
[03:07:17.223] Timer tick, asking Buildbucket for the build status
[03:07:17.306] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:17.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:38:0) after 1m0s
[03:08:17.323] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:38:0)
[03:08:17.323] Timer tick, asking Buildbucket for the build status
[03:08:17.416] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:17.416] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:39:0) after 1m0s
[03:09:17.450] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:39:0)
[03:09:17.450] Timer tick, asking Buildbucket for the build status
[03:09:17.617] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:17.617] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:40:0) after 1m0s
[03:10:17.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:40:0)
[03:10:17.652] Timer tick, asking Buildbucket for the build status
[03:10:17.723] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:10:17.723] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:41:0) after 1m0s
[03:11:17.753] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:41:0)
[03:11:17.753] Timer tick, asking Buildbucket for the build status
[03:11:17.828] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:17.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:42:0) after 1m0s
[03:12:17.852] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:42:0)
[03:12:17.852] Timer tick, asking Buildbucket for the build status
[03:12:17.904] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:17.904] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:43:0) after 1m0s
[03:13:17.922] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:43:0)
[03:13:17.922] Timer tick, asking Buildbucket for the build status
[03:13:18.274] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:18.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:44:0) after 1m0s
[03:14:18.299] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:44:0)
[03:14:18.299] Timer tick, asking Buildbucket for the build status
[03:14:18.375] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:18.375] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:45:0) after 1m0s
[03:15:18.392] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:45:0)
[03:15:18.392] Timer tick, asking Buildbucket for the build status
[03:15:18.478] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:18.478] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:46:0) after 1m0s
[03:16:18.500] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:46:0)
[03:16:18.500] Timer tick, asking Buildbucket for the build status
[03:16:18.565] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:18.565] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:47:0) after 1m0s
[03:17:18.586] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:47:0)
[03:17:18.586] Timer tick, asking Buildbucket for the build status
[03:17:18.668] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:18.668] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:48:0) after 1m0s
[03:18:18.684] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:48:0)
[03:18:18.684] Timer tick, asking Buildbucket for the build status
[03:18:18.760] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:18.760] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:49:0) after 1m0s
[03:19:18.778] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:49:0)
[03:19:18.778] Timer tick, asking Buildbucket for the build status
[03:19:18.895] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:18.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:50:0) after 1m0s
[03:20:18.998] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:50:0)
[03:20:18.998] Timer tick, asking Buildbucket for the build status
[03:20:19.087] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:19.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:51:0) after 1m0s
[03:21:19.191] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:51:0)
[03:21:19.191] Timer tick, asking Buildbucket for the build status
[03:21:19.256] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:19.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:52:0) after 1m0s
[03:22:19.275] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:52:0)
[03:22:19.275] Timer tick, asking Buildbucket for the build status
[03:22:19.325] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:19.325] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:53:0) after 1m0s
[03:23:19.343] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:53:0)
[03:23:19.343] Timer tick, asking Buildbucket for the build status
[03:23:19.485] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:23:19.485] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:54:0) after 1m0s
[03:24:19.542] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:54:0)
[03:24:19.542] Timer tick, asking Buildbucket for the build status
[03:24:19.624] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:24:19.624] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:55:0) after 1m0s
[03:25:19.645] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:55:0)
[03:25:19.645] Timer tick, asking Buildbucket for the build status
[03:25:19.718] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:19.718] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:56:0) after 1m0s
[03:26:19.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:56:0)
[03:26:19.749] Timer tick, asking Buildbucket for the build status
[03:26:19.947] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:19.947] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:57:0) after 1m0s
[03:27:19.965] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:57:0)
[03:27:19.965] Timer tick, asking Buildbucket for the build status
[03:27:20.049] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:27:20.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:58:0) after 1m0s
[03:28:20.067] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:58:0)
[03:28:20.067] Timer tick, asking Buildbucket for the build status
[03:28:20.166] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:28:20.166] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:59:0) after 1m0s
[03:29:20.191] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:59:0)
[03:29:20.191] Timer tick, asking Buildbucket for the build status
[03:29:20.263] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:20.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:60:0) after 1m0s
[03:30:20.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:60:0)
[03:30:20.280] Timer tick, asking Buildbucket for the build status
[03:30:20.500] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:20.500] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:61:0) after 1m0s
[03:31:20.520] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:61:0)
[03:31:20.520] Timer tick, asking Buildbucket for the build status
[03:31:20.671] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:20.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:62:0) after 1m0s
[03:32:20.687] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:62:0)
[03:32:20.687] Timer tick, asking Buildbucket for the build status
[03:32:20.817] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:20.817] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:63:0) after 1m0s
[03:33:20.836] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:63:0)
[03:33:20.836] Timer tick, asking Buildbucket for the build status
[03:33:21.050] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:33:21.050] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:64:0) after 1m0s
[03:34:21.085] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:64:0)
[03:34:21.085] Timer tick, asking Buildbucket for the build status
[03:34:21.172] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:21.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:65:0) after 1m0s
[03:35:21.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:65:0)
[03:35:21.202] Timer tick, asking Buildbucket for the build status
[03:35:21.324] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:21.324] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:66:0) after 1m0s
[03:36:21.434] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:66:0)
[03:36:21.434] Timer tick, asking Buildbucket for the build status
[03:36:21.755] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:21.755] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:67:0) after 1m0s
[03:37:21.776] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:67:0)
[03:37:21.776] Timer tick, asking Buildbucket for the build status
[03:37:21.921] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:21.921] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:68:0) after 1m0s
[03:38:21.947] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:68:0)
[03:38:21.947] Timer tick, asking Buildbucket for the build status
[03:38:22.029] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:22.030] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:69:0) after 1m0s
[03:39:22.072] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:69:0)
[03:39:22.072] Timer tick, asking Buildbucket for the build status
[03:39:22.136] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:22.136] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:70:0) after 1m0s
[03:40:22.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:70:0)
[03:40:22.177] Timer tick, asking Buildbucket for the build status
[03:40:22.295] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:40:22.295] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:71:0) after 1m0s
[03:41:22.316] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:71:0)
[03:41:22.316] Timer tick, asking Buildbucket for the build status
[03:41:22.484] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:22.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:72:0) after 1m0s
[03:42:22.553] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:72:0)
[03:42:22.553] Timer tick, asking Buildbucket for the build status
[03:42:22.679] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:22.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:73:0) after 1m0s
[03:43:22.772] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:73:0)
[03:43:22.772] Timer tick, asking Buildbucket for the build status
[03:43:22.840] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:22.840] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:74:0) after 1m0s
[03:44:22.859] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:74:0)
[03:44:22.859] Timer tick, asking Buildbucket for the build status
[03:44:22.946] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:22.946] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:75:0) after 1m0s
[03:45:23.065] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:75:0)
[03:45:23.065] Timer tick, asking Buildbucket for the build status
[03:45:23.142] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:23.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:76:0) after 1m0s
[03:46:23.173] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:76:0)
[03:46:23.173] Timer tick, asking Buildbucket for the build status
[03:46:23.277] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:23.277] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:77:0) after 1m0s
[03:47:23.314] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:77:0)
[03:47:23.314] Timer tick, asking Buildbucket for the build status
[03:47:23.389] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:23.389] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:78:0) after 1m0s
[03:48:23.412] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:78:0)
[03:48:23.412] Timer tick, asking Buildbucket for the build status
[03:48:23.479] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:23.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:79:0) after 1m0s
[03:49:23.498] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:79:0)
[03:49:23.498] Timer tick, asking Buildbucket for the build status
[03:49:23.607] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:23.607] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:80:0) after 1m0s
[03:50:23.629] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:80:0)
[03:50:23.629] Timer tick, asking Buildbucket for the build status
[03:50:23.985] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:50:23.985] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:81:0) after 1m0s
[03:51:24.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:81:0)
[03:51:24.006] Timer tick, asking Buildbucket for the build status
[03:51:24.098] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:51:24.098] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:82:0) after 1m0s
[03:52:24.157] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:82:0)
[03:52:24.157] Timer tick, asking Buildbucket for the build status
[03:52:24.249] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:24.249] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:83:0) after 1m0s
[03:53:24.278] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:83:0)
[03:53:24.278] Timer tick, asking Buildbucket for the build status
[03:53:24.495] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:24.495] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:84:0) after 1m0s
[03:54:24.516] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:84:0)
[03:54:24.516] Timer tick, asking Buildbucket for the build status
[03:54:24.626] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:24.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:85:0) after 1m0s
[03:55:24.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:85:0)
[03:55:24.646] Timer tick, asking Buildbucket for the build status
[03:55:25.333] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:25.333] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:86:0) after 1m0s
[03:56:25.355] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:86:0)
[03:56:25.355] Timer tick, asking Buildbucket for the build status
[03:56:25.692] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:25.692] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:87:0) after 1m0s
[03:57:25.744] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:87:0)
[03:57:25.744] Timer tick, asking Buildbucket for the build status
[03:57:25.879] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:25.879] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:88:0) after 1m0s
[03:58:25.939] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:88:0)
[03:58:25.939] Timer tick, asking Buildbucket for the build status
[03:58:26.009] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:26.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:89:0) after 1m0s
[03:59:26.139] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:89:0)
[03:59:26.139] Timer tick, asking Buildbucket for the build status
[03:59:26.250] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:59:26.250] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:90:0) after 1m0s
[04:00:26.270] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:90:0)
[04:00:26.270] Timer tick, asking Buildbucket for the build status
[04:00:26.342] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:00:26.342] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:91:0) after 1m0s
[04:01:26.359] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:91:0)
[04:01:26.359] Timer tick, asking Buildbucket for the build status
[04:01:26.437] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:26.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:92:0) after 1m0s
[04:02:26.429] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:92:0)
[04:02:26.429] Timer tick, asking Buildbucket for the build status
[04:02:26.612] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:26.612] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:93:0) after 1m0s
[04:03:26.635] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:93:0)
[04:03:26.635] Timer tick, asking Buildbucket for the build status
[04:03:26.703] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:26.703] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:94:0) after 1m0s
[04:04:26.757] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:94:0)
[04:04:26.757] Timer tick, asking Buildbucket for the build status
[04:04:26.823] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:26.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:95:0) after 1m0s
[04:05:26.844] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:95:0)
[04:05:26.844] Timer tick, asking Buildbucket for the build status
[04:05:26.907] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:26.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:96:0) after 1m0s
[04:06:26.929] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:96:0)
[04:06:26.929] Timer tick, asking Buildbucket for the build status
[04:06:27.005] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:27.005] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:97:0) after 1m0s
[04:07:27.103] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:97:0)
[04:07:27.103] Timer tick, asking Buildbucket for the build status
[04:07:27.161] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:27.161] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:98:0) after 1m0s
[04:08:27.279] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:98:0)
[04:08:27.279] Timer tick, asking Buildbucket for the build status
[04:08:27.514] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:27.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:99:0) after 1m0s
[04:09:27.548] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:99:0)
[04:09:27.548] Timer tick, asking Buildbucket for the build status
[04:09:27.629] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:27.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:100:0) after 1m0s
[04:10:27.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:100:0)
[04:10:27.656] Timer tick, asking Buildbucket for the build status
[04:10:27.853] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:27.853] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:101:0) after 1m0s
[04:11:27.874] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:101:0)
[04:11:27.874] Timer tick, asking Buildbucket for the build status
[04:11:28.006] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:28.006] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:102:0) after 1m0s
[04:12:28.079] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:102:0)
[04:12:28.079] Timer tick, asking Buildbucket for the build status
[04:12:28.217] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:28.217] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:103:0) after 1m0s
[04:13:28.287] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:103:0)
[04:13:28.287] Timer tick, asking Buildbucket for the build status
[04:13:28.361] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:28.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:104:0) after 1m0s
[04:14:28.384] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:104:0)
[04:14:28.384] Timer tick, asking Buildbucket for the build status
[04:14:28.547] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:28.547] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:105:0) after 1m0s
[04:15:28.569] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:105:0)
[04:15:28.569] Timer tick, asking Buildbucket for the build status
[04:15:28.625] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:28.626] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:106:0) after 1m0s
[04:16:28.670] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:106:0)
[04:16:28.670] Timer tick, asking Buildbucket for the build status
[04:16:28.810] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:28.810] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:107:0) after 1m0s
[04:17:28.818] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:107:0)
[04:17:28.818] Timer tick, asking Buildbucket for the build status
[04:17:28.934] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:28.934] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:108:0) after 1m0s
[04:18:29.014] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:108:0)
[04:18:29.014] Timer tick, asking Buildbucket for the build status
[04:18:29.106] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:29.106] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:109:0) after 1m0s
[04:19:29.172] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:109:0)
[04:19:29.172] Timer tick, asking Buildbucket for the build status
[04:19:29.528] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:29.528] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:110:0) after 1m0s
[04:20:29.552] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:110:0)
[04:20:29.552] Timer tick, asking Buildbucket for the build status
[04:20:29.616] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:29.616] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:111:0) after 1m0s
[04:21:29.668] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:111:0)
[04:21:29.668] Timer tick, asking Buildbucket for the build status
[04:21:29.876] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:29.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:112:0) after 1m0s
[04:22:29.900] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:112:0)
[04:22:29.900] Timer tick, asking Buildbucket for the build status
[04:22:29.972] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:29.972] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:113:0) after 1m0s
[04:23:30.005] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:113:0)
[04:23:30.005] Timer tick, asking Buildbucket for the build status
[04:23:30.162] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:30.162] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:114:0) after 1m0s
[04:24:30.184] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:114:0)
[04:24:30.184] Timer tick, asking Buildbucket for the build status
[04:24:30.284] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:30.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:115:0) after 1m0s
[04:25:30.356] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:115:0)
[04:25:30.356] Timer tick, asking Buildbucket for the build status
[04:25:30.462] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:30.462] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:116:0) after 1m0s
[04:26:30.484] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:116:0)
[04:26:30.484] Timer tick, asking Buildbucket for the build status
[04:26:30.554] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:30.554] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:117:0) after 1m0s
[04:27:30.576] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:117:0)
[04:27:30.576] Timer tick, asking Buildbucket for the build status
[04:27:30.657] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:30.657] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:118:0) after 1m0s
[04:28:30.687] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:118:0)
[04:28:30.687] Timer tick, asking Buildbucket for the build status
[04:28:30.797] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:30.797] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:119:0) after 1m0s
[04:29:30.823] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:119:0)
[04:29:30.823] Timer tick, asking Buildbucket for the build status
[04:29:30.920] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:30.920] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:120:0) after 1m0s
[04:30:31.003] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:120:0)
[04:30:31.003] Timer tick, asking Buildbucket for the build status
[04:30:31.076] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:31.076] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:121:0) after 1m0s
[04:31:31.100] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:121:0)
[04:31:31.100] Timer tick, asking Buildbucket for the build status
[04:31:31.271] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:31.271] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:122:0) after 1m0s
[04:32:31.293] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:122:0)
[04:32:31.293] Timer tick, asking Buildbucket for the build status
[04:32:31.631] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:31.631] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:123:0) after 1m0s
[04:33:31.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:123:0)
[04:33:31.671] Timer tick, asking Buildbucket for the build status
[04:33:31.738] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:31.738] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:124:0) after 1m0s
[04:34:31.787] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:124:0)
[04:34:31.787] Timer tick, asking Buildbucket for the build status
[04:34:31.841] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:31.841] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:125:0) after 1m0s
[04:35:31.875] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:125:0)
[04:35:31.875] Timer tick, asking Buildbucket for the build status
[04:35:31.944] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:31.944] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:126:0) after 1m0s
[04:36:31.964] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:126:0)
[04:36:31.964] Timer tick, asking Buildbucket for the build status
[04:36:32.058] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:32.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:127:0) after 1m0s
[04:37:32.084] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:127:0)
[04:37:32.084] Timer tick, asking Buildbucket for the build status
[04:37:32.206] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:32.206] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:128:0) after 1m0s
[04:38:32.246] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:128:0)
[04:38:32.246] Timer tick, asking Buildbucket for the build status
[04:38:32.303] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:32.303] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:129:0) after 1m0s
[04:39:32.334] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:129:0)
[04:39:32.334] Timer tick, asking Buildbucket for the build status
[04:39:32.410] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:32.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:130:0) after 1m0s
[04:40:32.432] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:130:0)
[04:40:32.432] Timer tick, asking Buildbucket for the build status
[04:40:32.520] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:32.520] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:131:0) after 1m0s
[04:41:32.655] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:131:0)
[04:41:32.655] Timer tick, asking Buildbucket for the build status
[04:41:32.971] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:32.971] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:132:0) after 1m0s
[04:42:32.997] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:132:0)
[04:42:32.997] Timer tick, asking Buildbucket for the build status
[04:42:33.069] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:33.069] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:133:0) after 1m0s
[04:43:33.109] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:133:0)
[04:43:33.109] Timer tick, asking Buildbucket for the build status
[04:43:33.192] Build 8921312240527131648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:33.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:134:0) after 1m0s
[04:43:51.947] Received PubSub notification, asking Buildbucket for the build status
[04:43:51.997] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:33.213] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:134:0)
[04:44:33.213] Timer tick, asking Buildbucket for the build status
[04:44:33.370] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:33.370] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:136:0) after 1m0s
[04:45:33.389] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:136:0)
[04:45:33.389] Timer tick, asking Buildbucket for the build status
[04:45:33.478] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:33.478] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:137:0) after 1m0s
[04:46:33.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:137:0)
[04:46:33.503] Timer tick, asking Buildbucket for the build status
[04:46:33.682] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:33.682] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:138:0) after 1m0s
[04:47:33.703] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:138:0)
[04:47:33.703] Timer tick, asking Buildbucket for the build status
[04:47:33.791] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:33.791] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:139:0) after 1m0s
[04:48:33.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:139:0)
[04:48:33.832] Timer tick, asking Buildbucket for the build status
[04:48:33.982] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:33.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:140:0) after 1m0s
[04:49:34.007] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:140:0)
[04:49:34.007] Timer tick, asking Buildbucket for the build status
[04:49:34.262] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:34.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:141:0) after 1m0s
[04:50:34.321] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:141:0)
[04:50:34.321] Timer tick, asking Buildbucket for the build status
[04:50:34.421] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:34.421] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:142:0) after 1m0s
[04:51:34.457] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:142:0)
[04:51:34.457] Timer tick, asking Buildbucket for the build status
[04:51:34.574] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:34.574] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:143:0) after 1m0s
[04:52:34.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:143:0)
[04:52:34.597] Timer tick, asking Buildbucket for the build status
[04:52:34.639] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:34.639] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:144:0) after 1m0s
[04:53:34.659] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:144:0)
[04:53:34.660] Timer tick, asking Buildbucket for the build status
[04:53:34.717] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:34.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:145:0) after 1m0s
[04:54:34.736] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:145:0)
[04:54:34.737] Timer tick, asking Buildbucket for the build status
[04:54:34.811] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:34.811] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:146:0) after 1m0s
[04:55:34.832] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:146:0)
[04:55:34.832] Timer tick, asking Buildbucket for the build status
[04:55:34.894] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:34.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:147:0) after 1m0s
[04:56:34.918] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:147:0)
[04:56:34.918] Timer tick, asking Buildbucket for the build status
[04:56:34.992] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:34.992] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:148:0) after 1m0s
[04:57:35.012] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:148:0)
[04:57:35.012] Timer tick, asking Buildbucket for the build status
[04:57:35.081] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:35.081] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:149:0) after 1m0s
[04:58:35.132] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:149:0)
[04:58:35.132] Timer tick, asking Buildbucket for the build status
[04:58:35.175] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:35.175] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:150:0) after 1m0s
[04:59:35.202] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:150:0)
[04:59:35.202] Timer tick, asking Buildbucket for the build status
[04:59:35.299] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:35.299] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:151:0) after 1m0s
[05:00:35.318] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:151:0)
[05:00:35.318] Timer tick, asking Buildbucket for the build status
[05:00:35.385] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:35.385] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:152:0) after 1m0s
[05:01:35.398] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:152:0)
[05:01:35.398] Timer tick, asking Buildbucket for the build status
[05:01:35.782] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:35.782] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:153:0) after 1m0s
[05:02:35.806] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:153:0)
[05:02:35.806] Timer tick, asking Buildbucket for the build status
[05:02:35.996] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:35.996] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:154:0) after 1m0s
[05:03:36.084] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:154:0)
[05:03:36.084] Timer tick, asking Buildbucket for the build status
[05:03:36.194] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:36.194] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:155:0) after 1m0s
[05:04:36.255] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:155:0)
[05:04:36.255] Timer tick, asking Buildbucket for the build status
[05:04:36.354] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:36.354] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:156:0) after 1m0s
[05:05:36.392] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:156:0)
[05:05:36.392] Timer tick, asking Buildbucket for the build status
[05:05:36.694] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:36.694] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:157:0) after 1m0s
[05:06:36.717] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:157:0)
[05:06:36.717] Timer tick, asking Buildbucket for the build status
[05:06:36.979] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:36.979] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:158:0) after 1m0s
[05:07:37.006] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:158:0)
[05:07:37.006] Timer tick, asking Buildbucket for the build status
[05:07:37.289] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:37.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:159:0) after 1m0s
[05:08:37.311] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:159:0)
[05:08:37.311] Timer tick, asking Buildbucket for the build status
[05:08:37.433] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:37.433] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:160:0) after 1m0s
[05:09:37.455] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:160:0)
[05:09:37.455] Timer tick, asking Buildbucket for the build status
[05:09:37.537] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:37.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:161:0) after 1m0s
[05:10:37.570] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:161:0)
[05:10:37.570] Timer tick, asking Buildbucket for the build status
[05:10:37.652] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:37.652] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:162:0) after 1m0s
[05:11:37.674] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:162:0)
[05:11:37.674] Timer tick, asking Buildbucket for the build status
[05:11:37.845] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:37.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:163:0) after 1m0s
[05:12:37.895] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:163:0)
[05:12:37.895] Timer tick, asking Buildbucket for the build status
[05:12:38.009] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:38.009] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:164:0) after 1m0s
[05:13:38.034] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:164:0)
[05:13:38.034] Timer tick, asking Buildbucket for the build status
[05:13:38.290] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:38.290] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:165:0) after 1m0s
[05:14:38.312] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:165:0)
[05:14:38.312] Timer tick, asking Buildbucket for the build status
[05:14:38.386] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:38.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:166:0) after 1m0s
[05:15:38.429] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:166:0)
[05:15:38.429] Timer tick, asking Buildbucket for the build status
[05:15:38.816] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:38.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:167:0) after 1m0s
[05:16:38.869] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:167:0)
[05:16:38.869] Timer tick, asking Buildbucket for the build status
[05:16:39.065] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:39.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:168:0) after 1m0s
[05:17:39.122] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:168:0)
[05:17:39.122] Timer tick, asking Buildbucket for the build status
[05:17:39.400] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:39.400] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:169:0) after 1m0s
[05:18:39.422] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:169:0)
[05:18:39.422] Timer tick, asking Buildbucket for the build status
[05:18:39.486] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:39.486] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:170:0) after 1m0s
[05:19:39.546] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:170:0)
[05:19:39.546] Timer tick, asking Buildbucket for the build status
[05:19:39.606] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:39.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:171:0) after 1m0s
[05:20:39.633] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:171:0)
[05:20:39.633] Timer tick, asking Buildbucket for the build status
[05:20:39.876] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:39.876] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:172:0) after 1m0s
[05:21:39.898] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:172:0)
[05:21:39.898] Timer tick, asking Buildbucket for the build status
[05:21:40.096] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:40.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:173:0) after 1m0s
[05:22:40.122] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:173:0)
[05:22:40.122] Timer tick, asking Buildbucket for the build status
[05:22:40.372] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:40.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:174:0) after 1m0s
[05:23:40.393] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:174:0)
[05:23:40.393] Timer tick, asking Buildbucket for the build status
[05:23:40.437] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:40.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:175:0) after 1m0s
[05:24:40.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:175:0)
[05:24:40.459] Timer tick, asking Buildbucket for the build status
[05:24:40.535] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:40.535] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:176:0) after 1m0s
[05:25:40.572] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:176:0)
[05:25:40.572] Timer tick, asking Buildbucket for the build status
[05:25:40.739] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:40.739] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:177:0) after 1m0s
[05:26:40.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:177:0)
[05:26:40.773] Timer tick, asking Buildbucket for the build status
[05:26:40.828] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:40.828] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:178:0) after 1m0s
[05:27:40.865] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:178:0)
[05:27:40.865] Timer tick, asking Buildbucket for the build status
[05:27:40.938] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:40.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:179:0) after 1m0s
[05:28:41.007] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:179:0)
[05:28:41.007] Timer tick, asking Buildbucket for the build status
[05:28:41.182] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:41.182] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:180:0) after 1m0s
[05:29:41.295] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:180:0)
[05:29:41.295] Timer tick, asking Buildbucket for the build status
[05:29:41.357] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:41.357] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:181:0) after 1m0s
[05:30:41.459] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:181:0)
[05:30:41.459] Timer tick, asking Buildbucket for the build status
[05:30:41.563] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:41.563] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:182:0) after 1m0s
[05:31:41.648] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:182:0)
[05:31:41.648] Timer tick, asking Buildbucket for the build status
[05:31:41.713] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:41.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:183:0) after 1m0s
[05:32:41.738] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:183:0)
[05:32:41.738] Timer tick, asking Buildbucket for the build status
[05:32:41.825] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:41.825] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:184:0) after 1m0s
[05:33:41.852] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:184:0)
[05:33:41.853] Timer tick, asking Buildbucket for the build status
[05:33:41.926] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:41.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:185:0) after 1m0s
[05:34:41.954] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:185:0)
[05:34:41.954] Timer tick, asking Buildbucket for the build status
[05:34:42.032] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:42.032] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:186:0) after 1m0s
[05:35:42.063] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:186:0)
[05:35:42.063] Timer tick, asking Buildbucket for the build status
[05:35:42.160] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:42.160] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:187:0) after 1m0s
[05:36:42.185] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:187:0)
[05:36:42.185] Timer tick, asking Buildbucket for the build status
[05:36:42.302] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:42.302] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:188:0) after 1m0s
[05:37:42.358] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:188:0)
[05:37:42.358] Timer tick, asking Buildbucket for the build status
[05:37:42.685] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:42.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:189:0) after 1m0s
[05:38:42.707] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:189:0)
[05:38:42.707] Timer tick, asking Buildbucket for the build status
[05:38:42.791] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:42.791] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:190:0) after 1m0s
[05:39:42.814] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:190:0)
[05:39:42.814] Timer tick, asking Buildbucket for the build status
[05:39:42.891] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:42.891] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:191:0) after 1m0s
[05:40:42.915] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:191:0)
[05:40:42.915] Timer tick, asking Buildbucket for the build status
[05:40:43.018] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:43.018] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:192:0) after 1m0s
[05:41:43.044] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:192:0)
[05:41:43.044] Timer tick, asking Buildbucket for the build status
[05:41:43.099] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:43.099] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:193:0) after 1m0s
[05:42:43.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:193:0)
[05:42:43.217] Timer tick, asking Buildbucket for the build status
[05:42:43.321] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:43.321] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:194:0) after 1m0s
[05:43:43.357] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:194:0)
[05:43:43.357] Timer tick, asking Buildbucket for the build status
[05:43:43.487] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:43.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:195:0) after 1m0s
[05:44:43.510] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:195:0)
[05:44:43.510] Timer tick, asking Buildbucket for the build status
[05:44:43.578] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:43.578] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:196:0) after 1m0s
[05:45:43.601] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:196:0)
[05:45:43.601] Timer tick, asking Buildbucket for the build status
[05:45:43.725] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:43.725] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:197:0) after 1m0s
[05:46:43.753] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:197:0)
[05:46:43.753] Timer tick, asking Buildbucket for the build status
[05:46:43.938] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:43.938] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:198:0) after 1m0s
[05:47:43.963] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:198:0)
[05:47:43.963] Timer tick, asking Buildbucket for the build status
[05:47:44.091] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:44.091] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:199:0) after 1m0s
[05:48:44.125] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:199:0)
[05:48:44.125] Timer tick, asking Buildbucket for the build status
[05:48:44.254] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:44.254] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:200:0) after 1m0s
[05:49:44.291] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:200:0)
[05:49:44.291] Timer tick, asking Buildbucket for the build status
[05:49:44.391] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:44.391] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:201:0) after 1m0s
[05:50:44.415] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:201:0)
[05:50:44.415] Timer tick, asking Buildbucket for the build status
[05:50:44.579] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:44.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:202:0) after 1m0s
[05:51:44.622] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:202:0)
[05:51:44.622] Timer tick, asking Buildbucket for the build status
[05:51:44.672] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:44.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:203:0) after 1m0s
[05:52:44.698] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:203:0)
[05:52:44.698] Timer tick, asking Buildbucket for the build status
[05:52:45.153] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:45.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:204:0) after 1m0s
[05:53:45.183] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:204:0)
[05:53:45.183] Timer tick, asking Buildbucket for the build status
[05:53:45.305] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:45.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:205:0) after 1m0s
[05:54:45.338] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:205:0)
[05:54:45.338] Timer tick, asking Buildbucket for the build status
[05:54:45.487] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:45.487] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:206:0) after 1m0s
[05:55:45.527] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:206:0)
[05:55:45.527] Timer tick, asking Buildbucket for the build status
[05:55:45.587] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:45.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:207:0) after 1m0s
[05:56:45.609] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:207:0)
[05:56:45.609] Timer tick, asking Buildbucket for the build status
[05:56:45.675] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:45.675] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:208:0) after 1m0s
[05:57:45.699] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:208:0)
[05:57:45.699] Timer tick, asking Buildbucket for the build status
[05:57:46.088] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:46.088] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:209:0) after 1m0s
[05:58:46.177] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:209:0)
[05:58:46.177] Timer tick, asking Buildbucket for the build status
[05:58:46.281] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:46.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:210:0) after 1m0s
[05:59:46.282] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:210:0)
[05:59:46.282] Timer tick, asking Buildbucket for the build status
[05:59:46.363] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:46.363] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:211:0) after 1m0s
[06:00:46.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:211:0)
[06:00:46.397] Timer tick, asking Buildbucket for the build status
[06:00:46.610] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:46.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:212:0) after 1m0s
[06:01:46.637] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:212:0)
[06:01:46.637] Timer tick, asking Buildbucket for the build status
[06:01:46.690] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:46.690] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:213:0) after 1m0s
[06:02:46.802] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:213:0)
[06:02:46.802] Timer tick, asking Buildbucket for the build status
[06:02:46.977] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:46.977] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:214:0) after 1m0s
[06:03:47.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:214:0)
[06:03:47.001] Timer tick, asking Buildbucket for the build status
[06:03:47.050] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:47.050] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:215:0) after 1m0s
[06:04:47.076] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:215:0)
[06:04:47.076] Timer tick, asking Buildbucket for the build status
[06:04:47.318] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:47.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:216:0) after 1m0s
[06:05:47.349] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:216:0)
[06:05:47.349] Timer tick, asking Buildbucket for the build status
[06:05:47.549] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:47.549] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:217:0) after 1m0s
[06:06:47.577] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:217:0)
[06:06:47.577] Timer tick, asking Buildbucket for the build status
[06:06:47.907] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:47.907] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:218:0) after 1m0s
[06:07:47.943] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:218:0)
[06:07:47.943] Timer tick, asking Buildbucket for the build status
[06:07:48.034] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:48.034] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:219:0) after 1m0s
[06:08:48.085] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:219:0)
[06:08:48.085] Timer tick, asking Buildbucket for the build status
[06:08:48.172] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:48.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:220:0) after 1m0s
[06:09:48.230] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:220:0)
[06:09:48.230] Timer tick, asking Buildbucket for the build status
[06:09:48.351] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:48.351] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:221:0) after 1m0s
[06:10:48.376] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:221:0)
[06:10:48.376] Timer tick, asking Buildbucket for the build status
[06:10:48.553] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:48.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:222:0) after 1m0s
[06:11:48.581] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:222:0)
[06:11:48.581] Timer tick, asking Buildbucket for the build status
[06:11:49.016] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:49.016] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:223:0) after 1m0s
[06:12:49.050] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:223:0)
[06:12:49.050] Timer tick, asking Buildbucket for the build status
[06:12:49.144] Build 8921312240527131648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:49.144] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9086742303105072992:224:0) after 1m0s
[06:13:33.313] Received PubSub notification, asking Buildbucket for the build status
[06:13:33.353] Build 8921312240527131648: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:13:33.354] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "AUTO",
    "completed_ts": "1550384012300430",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1550370669776352",
    "failure_reason": "BUILD_FAILURE",
    "id": "8921312240527131648",
    "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\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"4111-cd16c2f\"], \"machine_type\": [\"n1-standard-16\"], \"gpu\": [\"none\"], \"cores\": [\"16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-16-145e5bab-us-west1-c-141h\"], \"pool\": [\"luci.nacl.toolchain\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"Failure annotated steps\\nFailure llvm-test-suite x86-32 --opt O3f --opt O2b\\nFailure llvm-test-suite x86-32 --opt O3f --opt O0b\\nFailure llvm-test-suite x86-32 --opt O3f --opt O2b_sz\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 5121, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"linux-pnacl-x86_64-tests-x86_32\", \"key\": \"builder\"}, {\"value\": \"commit/git/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"key\": \"buildset\"}, {\"value\": \"9086742303105072992\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"nacl/linux-pnacl-x86_64-tests-x86_32\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"nacl\", \"builder\": \"linux-pnacl-x86_64-tests-x86_32\", \"bucket\": \"toolchain\"}, \"number\": 5121, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"fa9032cf737cadc98196e2fd1dde76c697e0750a\"}, \"recipe\": {\"name\": \"nacl\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"id\": \"8921312240527131648\", \"input\": {\"gitilesCommit\": {\"project\": \"native_client/src/native_client\", \"host\": \"chromium.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\"}}, \"createTime\": \"2019-02-17T02:31:09.776352Z\"}}, \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"buildername\": \"linux-pnacl-x86_64-tests-x86_32\", \"got_revision\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"recipe\": \"nacl\", \"mastername\": \"client.nacl.toolchain\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1550370669776352, \"tags\": [\"build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/5121\", \"builder:linux-pnacl-x86_64-tests-x86_32\", \"buildset:commit/git/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9086742303105072992\", \"scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.nacl.toolchain\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"nacl\", \"id\": \"8921312240527131648\"}}, \"slavetype\": \"BuilderTester\", \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"bot_id\": \"gce-trusty-16-145e5bab-us-west1-c-141h\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1550378631308553",
    "status": "COMPLETED",
    "status_changed_ts": "1550384012924483",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/5121",
      "builder:linux-pnacl-x86_64-tests-x86_32",
      "buildset:commit/git/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/1ed9878b8eb68c1e0d0268754dafcf83e747fa8f",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9086742303105072992",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8921312240527131648/+/annotations",
      "swarming_tag:luci_project:nacl",
      "swarming_tag:os:Linux",
      "swarming_tag:recipe_name:nacl",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
      "swarming_task_id:43121c8e9c537310",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1550384012926592",
    "url": "https://ci.chromium.org/b/8921312240527131648",
    "utcnow_ts": "1550384013345281"
  }
}
[06:13:33.354] Invocation finished in 3h42m25.419474606s with status FAILED