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

• d3db562593968b5b8761117d31f96eae305c37a7 (5 years ago)

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

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

[02:50:41.731] New invocation is queued and will start shortly
[02:50:42.818] Starting the invocation (attempt 1)
[02:50:42.890] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:50:42.890] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:50:42.890] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9052767209916107984",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-x86_32\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"d3db562593968b5b8761117d31f96eae305c37a7\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@d3db562593968b5b8761117d31f96eae305c37a7\",\"title\":\"d3db562593968b5b8761117d31f96eae305c37a7\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/d3db562593968b5b8761117d31f96eae305c37a7\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"d3db562593968b5b8761117d31f96eae305c37a7\"}}",
  "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:9052767209916107984",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-x86_32",
    "user_agent:luci-scheduler",
    "buildset:commit/git/d3db562593968b5b8761117d31f96eae305c37a7",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d3db562593968b5b8761117d31f96eae305c37a7",
    "gitiles_ref:refs/heads/master"
  ]
}
[02:50:43.780] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1582771843031806",
    "id": "8887337147879773328",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_32\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"d3db562593968b5b8761117d31f96eae305c37a7\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@d3db562593968b5b8761117d31f96eae305c37a7\", \"title\": \"d3db562593968b5b8761117d31f96eae305c37a7\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/d3db562593968b5b8761117d31f96eae305c37a7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"d3db562593968b5b8761117d31f96eae305c37a7\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1582771843441934",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/5138",
      "builder:linux-pnacl-x86_64-tests-x86_32",
      "buildset:commit/git/d3db562593968b5b8761117d31f96eae305c37a7",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d3db562593968b5b8761117d31f96eae305c37a7",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9052767209916107984",
      "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/8887337147879773328/+/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:",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1582771843442063",
    "url": "https://ci.chromium.org/b/8887337147879773328",
    "utcnow_ts": "1582771843769556"
  }
}
[02:50:43.780] Task URL: https://ci.chromium.org/b/8887337147879773328
[02:50:43.780] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:2:0) after 1m0s
[02:51:43.801] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:2:0)
[02:51:43.801] Timer tick, asking Buildbucket for the build status
[02:51:43.895] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:43.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:3:0) after 1m0s
[02:52:44.115] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:3:0)
[02:52:44.115] Timer tick, asking Buildbucket for the build status
[02:52:44.380] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:44.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:4:0) after 1m0s
[02:53:44.532] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:4:0)
[02:53:44.532] Timer tick, asking Buildbucket for the build status
[02:53:44.770] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:44.770] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:5:0) after 1m0s
[02:54:44.827] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:5:0)
[02:54:44.827] Timer tick, asking Buildbucket for the build status
[02:54:45.059] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:45.059] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:6:0) after 1m0s
[02:55:45.082] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:6:0)
[02:55:45.082] Timer tick, asking Buildbucket for the build status
[02:55:45.203] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:45.203] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:7:0) after 1m0s
[02:56:45.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:7:0)
[02:56:45.233] Timer tick, asking Buildbucket for the build status
[02:56:45.345] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:45.345] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:8:0) after 1m0s
[02:57:45.381] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:8:0)
[02:57:45.381] Timer tick, asking Buildbucket for the build status
[02:57:45.525] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:45.525] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:9:0) after 1m0s
[02:58:45.608] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:9:0)
[02:58:45.608] Timer tick, asking Buildbucket for the build status
[02:58:45.800] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:45.800] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:10:0) after 1m0s
[02:59:46.009] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:10:0)
[02:59:46.009] Timer tick, asking Buildbucket for the build status
[02:59:46.267] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:46.267] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:11:0) after 1m0s
[03:00:46.330] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:11:0)
[03:00:46.330] Timer tick, asking Buildbucket for the build status
[03:00:46.480] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:46.480] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:12:0) after 1m0s
[03:01:46.623] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:12:0)
[03:01:46.623] Timer tick, asking Buildbucket for the build status
[03:01:46.744] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:46.744] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:13:0) after 1m0s
[03:02:46.837] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:13:0)
[03:02:46.837] Timer tick, asking Buildbucket for the build status
[03:02:46.987] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:46.987] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:14:0) after 1m0s
[03:03:47.087] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:14:0)
[03:03:47.087] Timer tick, asking Buildbucket for the build status
[03:03:47.221] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:47.221] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:15:0) after 1m0s
[03:04:47.258] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:15:0)
[03:04:47.258] Timer tick, asking Buildbucket for the build status
[03:04:47.380] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:47.380] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:16:0) after 1m0s
[03:05:47.403] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:16:0)
[03:05:47.403] Timer tick, asking Buildbucket for the build status
[03:05:47.551] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:47.551] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:17:0) after 1m0s
[03:06:47.581] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:17:0)
[03:06:47.581] Timer tick, asking Buildbucket for the build status
[03:06:47.752] Build 8887337147879773328: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:47.752] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:18:0) after 1m0s
[03:07:22.216] Received PubSub notification, asking Buildbucket for the build status
[03:07:22.337] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:47.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:18:0)
[03:07:47.773] Timer tick, asking Buildbucket for the build status
[03:07:47.877] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:47.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:20:0) after 1m0s
[03:08:47.909] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:20:0)
[03:08:47.909] Timer tick, asking Buildbucket for the build status
[03:08:48.051] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:48.052] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:21:0) after 1m0s
[03:09:48.066] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:21:0)
[03:09:48.066] Timer tick, asking Buildbucket for the build status
[03:09:48.236] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:48.236] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:22:0) after 1m0s
[03:10:48.257] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:22:0)
[03:10:48.257] Timer tick, asking Buildbucket for the build status
[03:10:48.463] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:48.463] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:23:0) after 1m0s
[03:11:48.503] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:23:0)
[03:11:48.503] Timer tick, asking Buildbucket for the build status
[03:11:48.939] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:48.939] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:24:0) after 1m0s
[03:12:48.972] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:24:0)
[03:12:48.972] Timer tick, asking Buildbucket for the build status
[03:12:49.097] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:49.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:25:0) after 1m0s
[03:13:49.138] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:25:0)
[03:13:49.138] Timer tick, asking Buildbucket for the build status
[03:13:49.456] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:49.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:26:0) after 1m0s
[03:14:49.486] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:26:0)
[03:14:49.486] Timer tick, asking Buildbucket for the build status
[03:14:49.648] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:49.648] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:27:0) after 1m0s
[03:15:49.681] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:27:0)
[03:15:49.681] Timer tick, asking Buildbucket for the build status
[03:15:49.912] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:49.912] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:28:0) after 1m0s
[03:16:49.961] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:28:0)
[03:16:49.961] Timer tick, asking Buildbucket for the build status
[03:16:50.087] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:50.087] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:29:0) after 1m0s
[03:17:50.199] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:29:0)
[03:17:50.199] Timer tick, asking Buildbucket for the build status
[03:17:51.650] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:51.650] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:30:0) after 1m0s
[03:18:51.833] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:30:0)
[03:18:51.833] Timer tick, asking Buildbucket for the build status
[03:18:52.221] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:52.221] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:31:0) after 1m0s
[03:19:52.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:31:0)
[03:19:52.354] Timer tick, asking Buildbucket for the build status
[03:19:52.577] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:52.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:32:0) after 1m0s
[03:20:52.614] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:32:0)
[03:20:52.614] Timer tick, asking Buildbucket for the build status
[03:20:52.764] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:52.764] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:33:0) after 1m0s
[03:21:52.934] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:33:0)
[03:21:52.934] Timer tick, asking Buildbucket for the build status
[03:21:53.261] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:53.261] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:34:0) after 1m0s
[03:22:53.388] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:34:0)
[03:22:53.388] Timer tick, asking Buildbucket for the build status
[03:22:53.524] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:53.524] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:35:0) after 1m0s
[03:23:53.715] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:35:0)
[03:23:53.715] Timer tick, asking Buildbucket for the build status
[03:23:53.895] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:53.895] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:36:0) after 1m0s
[03:24:54.044] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:36:0)
[03:24:54.044] Timer tick, asking Buildbucket for the build status
[03:24:54.229] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:54.229] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:37:0) after 1m0s
[03:25:54.254] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:37:0)
[03:25:54.254] Timer tick, asking Buildbucket for the build status
[03:25:54.629] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:54.629] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:38:0) after 1m0s
[03:26:54.675] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:38:0)
[03:26:54.675] Timer tick, asking Buildbucket for the build status
[03:26:54.845] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:54.845] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:39:0) after 1m0s
[03:27:55.027] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:39:0)
[03:27:55.027] Timer tick, asking Buildbucket for the build status
[03:27:55.218] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:55.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:40:0) after 1m0s
[03:28:55.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:40:0)
[03:28:55.280] Timer tick, asking Buildbucket for the build status
[03:28:55.792] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:55.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:41:0) after 1m0s
[03:29:55.827] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:41:0)
[03:29:55.827] Timer tick, asking Buildbucket for the build status
[03:29:56.065] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:56.065] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:42:0) after 1m0s
[03:30:56.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:42:0)
[03:30:56.127] Timer tick, asking Buildbucket for the build status
[03:30:56.329] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:56.330] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:43:0) after 1m0s
[03:31:56.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:43:0)
[03:31:56.396] Timer tick, asking Buildbucket for the build status
[03:31:56.799] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:56.799] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:44:0) after 1m0s
[03:32:56.870] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:44:0)
[03:32:56.870] Timer tick, asking Buildbucket for the build status
[03:32:57.150] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:57.150] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:45:0) after 1m0s
[03:33:57.394] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:45:0)
[03:33:57.394] Timer tick, asking Buildbucket for the build status
[03:33:57.541] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:57.541] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:46:0) after 1m0s
[03:34:57.676] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:46:0)
[03:34:57.676] Timer tick, asking Buildbucket for the build status
[03:34:57.843] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:57.843] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:47:0) after 1m0s
[03:35:58.001] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:47:0)
[03:35:58.001] Timer tick, asking Buildbucket for the build status
[03:35:58.507] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:58.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:48:0) after 1m0s
[03:36:58.630] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:48:0)
[03:36:58.630] Timer tick, asking Buildbucket for the build status
[03:36:58.754] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:58.754] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:49:0) after 1m0s
[03:37:58.829] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:49:0)
[03:37:58.829] Timer tick, asking Buildbucket for the build status
[03:37:58.962] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:58.962] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:50:0) after 1m0s
[03:38:59.104] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:50:0)
[03:38:59.104] Timer tick, asking Buildbucket for the build status
[03:38:59.253] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:59.253] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:51:0) after 1m0s
[03:39:59.296] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:51:0)
[03:39:59.296] Timer tick, asking Buildbucket for the build status
[03:39:59.606] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:59.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:52:0) after 1m0s
[03:40:59.775] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:52:0)
[03:40:59.775] Timer tick, asking Buildbucket for the build status
[03:40:59.930] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:59.930] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:53:0) after 1m0s
[03:41:59.947] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:53:0)
[03:41:59.947] Timer tick, asking Buildbucket for the build status
[03:42:00.096] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:00.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:54:0) after 1m0s
[03:43:00.158] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:54:0)
[03:43:00.158] Timer tick, asking Buildbucket for the build status
[03:43:00.472] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:00.472] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:55:0) after 1m0s
[03:44:00.520] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:55:0)
[03:44:00.520] Timer tick, asking Buildbucket for the build status
[03:44:00.976] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:00.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:56:0) after 1m0s
[03:45:01.054] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:56:0)
[03:45:01.054] Timer tick, asking Buildbucket for the build status
[03:45:01.256] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:01.256] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:57:0) after 1m0s
[03:46:01.296] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:57:0)
[03:46:01.296] Timer tick, asking Buildbucket for the build status
[03:46:01.477] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:01.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:58:0) after 1m0s
[03:47:01.532] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:58:0)
[03:47:01.532] Timer tick, asking Buildbucket for the build status
[03:47:01.685] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:01.685] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:59:0) after 1m0s
[03:48:01.773] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:59:0)
[03:48:01.773] Timer tick, asking Buildbucket for the build status
[03:48:02.272] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:02.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:60:0) after 1m0s
[03:49:02.365] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:60:0)
[03:49:02.365] Timer tick, asking Buildbucket for the build status
[03:49:02.610] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:02.610] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:61:0) after 1m0s
[03:50:02.660] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:61:0)
[03:50:02.660] Timer tick, asking Buildbucket for the build status
[03:50:02.823] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:02.823] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:62:0) after 1m0s
[03:51:02.907] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:62:0)
[03:51:02.908] Timer tick, asking Buildbucket for the build status
[03:51:03.289] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:03.289] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:63:0) after 1m0s
[03:52:03.408] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:63:0)
[03:52:03.408] Timer tick, asking Buildbucket for the build status
[03:52:03.633] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:03.633] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:64:0) after 1m0s
[03:53:03.683] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:64:0)
[03:53:03.683] Timer tick, asking Buildbucket for the build status
[03:53:03.878] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:03.878] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:65:0) after 1m0s
[03:54:03.925] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:65:0)
[03:54:03.925] Timer tick, asking Buildbucket for the build status
[03:54:04.170] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:04.171] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:66:0) after 1m0s
[03:55:04.235] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:66:0)
[03:55:04.236] Timer tick, asking Buildbucket for the build status
[03:55:04.398] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:04.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:67:0) after 1m0s
[03:56:04.588] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:67:0)
[03:56:04.588] Timer tick, asking Buildbucket for the build status
[03:56:04.713] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:04.713] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:68:0) after 1m0s
[03:57:04.951] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:68:0)
[03:57:04.951] Timer tick, asking Buildbucket for the build status
[03:57:05.505] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:05.505] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:69:0) after 1m0s
[03:58:05.657] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:69:0)
[03:58:05.657] Timer tick, asking Buildbucket for the build status
[03:58:05.814] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:05.814] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:70:0) after 1m0s
[03:59:05.889] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:70:0)
[03:59:05.889] Timer tick, asking Buildbucket for the build status
[03:59:06.089] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:06.089] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:71:0) after 1m0s
[04:00:06.191] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:71:0)
[04:00:06.191] Timer tick, asking Buildbucket for the build status
[04:00:06.396] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:06.396] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:72:0) after 1m0s
[04:01:06.537] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:72:0)
[04:01:06.537] Timer tick, asking Buildbucket for the build status
[04:01:06.669] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:06.669] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:73:0) after 1m0s
[04:02:06.954] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:73:0)
[04:02:06.954] Timer tick, asking Buildbucket for the build status
[04:02:07.085] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:07.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:74:0) after 1m0s
[04:03:07.257] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:74:0)
[04:03:07.257] Timer tick, asking Buildbucket for the build status
[04:03:07.456] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:07.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:75:0) after 1m0s
[04:04:07.700] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:75:0)
[04:04:07.700] Timer tick, asking Buildbucket for the build status
[04:04:08.085] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:08.085] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:76:0) after 1m0s
[04:05:08.150] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:76:0)
[04:05:08.150] Timer tick, asking Buildbucket for the build status
[04:05:08.499] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:08.499] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:77:0) after 1m0s
[04:06:08.532] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:77:0)
[04:06:08.532] Timer tick, asking Buildbucket for the build status
[04:06:08.816] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:08.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:78:0) after 1m0s
[04:07:08.842] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:78:0)
[04:07:08.842] Timer tick, asking Buildbucket for the build status
[04:07:09.227] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:09.227] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:79:0) after 1m0s
[04:08:09.271] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:79:0)
[04:08:09.271] Timer tick, asking Buildbucket for the build status
[04:08:09.409] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:09.409] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:80:0) after 1m0s
[04:09:09.475] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:80:0)
[04:09:09.475] Timer tick, asking Buildbucket for the build status
[04:09:09.651] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:09.651] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:81:0) after 1m0s
[04:10:09.685] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:81:0)
[04:10:09.685] Timer tick, asking Buildbucket for the build status
[04:10:09.809] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:09.809] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:82:0) after 1m0s
[04:11:09.963] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:82:0)
[04:11:09.963] Timer tick, asking Buildbucket for the build status
[04:11:10.181] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:10.181] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:83:0) after 1m0s
[04:12:10.201] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:83:0)
[04:12:10.201] Timer tick, asking Buildbucket for the build status
[04:12:10.594] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:10.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:84:0) after 1m0s
[04:13:10.758] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:84:0)
[04:13:10.758] Timer tick, asking Buildbucket for the build status
[04:13:10.873] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:10.873] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:85:0) after 1m0s
[04:14:10.998] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:85:0)
[04:14:10.998] Timer tick, asking Buildbucket for the build status
[04:14:11.142] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:11.142] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:86:0) after 1m0s
[04:15:11.371] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:86:0)
[04:15:11.371] Timer tick, asking Buildbucket for the build status
[04:15:11.608] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:11.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:87:0) after 1m0s
[04:16:11.704] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:87:0)
[04:16:11.704] Timer tick, asking Buildbucket for the build status
[04:16:12.124] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:12.124] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:88:0) after 1m0s
[04:17:12.227] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:88:0)
[04:17:12.227] Timer tick, asking Buildbucket for the build status
[04:17:12.573] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:12.573] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:89:0) after 1m0s
[04:18:12.599] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:89:0)
[04:18:12.599] Timer tick, asking Buildbucket for the build status
[04:18:12.963] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:12.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:90:0) after 1m0s
[04:19:13.012] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:90:0)
[04:19:13.012] Timer tick, asking Buildbucket for the build status
[04:19:13.343] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:13.343] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:91:0) after 1m0s
[04:20:13.379] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:91:0)
[04:20:13.379] Timer tick, asking Buildbucket for the build status
[04:20:13.533] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:13.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:92:0) after 1m0s
[04:21:13.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:92:0)
[04:21:13.646] Timer tick, asking Buildbucket for the build status
[04:21:13.741] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:13.741] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:93:0) after 1m0s
[04:22:13.764] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:93:0)
[04:22:13.764] Timer tick, asking Buildbucket for the build status
[04:22:14.177] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:14.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:94:0) after 1m0s
[04:23:14.229] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:94:0)
[04:23:14.229] Timer tick, asking Buildbucket for the build status
[04:23:14.576] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:14.576] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:95:0) after 1m0s
[04:24:14.686] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:95:0)
[04:24:14.686] Timer tick, asking Buildbucket for the build status
[04:24:15.000] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:15.000] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:96:0) after 1m0s
[04:25:15.100] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:96:0)
[04:25:15.100] Timer tick, asking Buildbucket for the build status
[04:25:15.222] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:15.222] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:97:0) after 1m0s
[04:26:15.322] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:97:0)
[04:26:15.322] Timer tick, asking Buildbucket for the build status
[04:26:15.449] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:15.449] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:98:0) after 1m0s
[04:27:15.730] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:98:0)
[04:27:15.730] Timer tick, asking Buildbucket for the build status
[04:27:15.917] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:15.917] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:99:0) after 1m0s
[04:28:16.095] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:99:0)
[04:28:16.095] Timer tick, asking Buildbucket for the build status
[04:28:16.672] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:16.672] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:100:0) after 1m0s
[04:29:16.869] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:100:0)
[04:29:16.869] Timer tick, asking Buildbucket for the build status
[04:29:16.959] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:16.960] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:101:0) after 1m0s
[04:30:17.008] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:101:0)
[04:30:17.008] Timer tick, asking Buildbucket for the build status
[04:30:17.192] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:17.192] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:102:0) after 1m0s
[04:31:17.359] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:102:0)
[04:31:17.359] Timer tick, asking Buildbucket for the build status
[04:31:17.522] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:17.522] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:103:0) after 1m0s
[04:32:17.646] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:103:0)
[04:32:17.646] Timer tick, asking Buildbucket for the build status
[04:32:17.882] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:17.882] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:104:0) after 1m0s
[04:33:17.986] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:104:0)
[04:33:17.986] Timer tick, asking Buildbucket for the build status
[04:33:18.559] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:18.559] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:105:0) after 1m0s
[04:34:18.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:105:0)
[04:34:18.663] Timer tick, asking Buildbucket for the build status
[04:34:18.801] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:18.801] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:106:0) after 1m0s
[04:35:18.855] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:106:0)
[04:35:18.855] Timer tick, asking Buildbucket for the build status
[04:35:19.058] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:19.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:107:0) after 1m0s
[04:36:19.103] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:107:0)
[04:36:19.103] Timer tick, asking Buildbucket for the build status
[04:36:21.211] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:21.211] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:108:0) after 1m0s
[04:37:21.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:108:0)
[04:37:21.535] Timer tick, asking Buildbucket for the build status
[04:37:21.894] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:21.894] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:109:0) after 1m0s
[04:38:21.988] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:109:0)
[04:38:21.988] Timer tick, asking Buildbucket for the build status
[04:38:22.149] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:22.149] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:110:0) after 1m0s
[04:39:22.224] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:110:0)
[04:39:22.224] Timer tick, asking Buildbucket for the build status
[04:39:22.503] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:22.503] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:111:0) after 1m0s
[04:40:22.619] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:111:0)
[04:40:22.619] Timer tick, asking Buildbucket for the build status
[04:40:23.049] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:23.049] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:112:0) after 1m0s
[04:41:23.207] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:112:0)
[04:41:23.207] Timer tick, asking Buildbucket for the build status
[04:41:23.372] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:23.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:113:0) after 1m0s
[04:42:23.489] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:113:0)
[04:42:23.489] Timer tick, asking Buildbucket for the build status
[04:42:23.598] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:23.599] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:114:0) after 1m0s
[04:43:23.749] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:114:0)
[04:43:23.749] Timer tick, asking Buildbucket for the build status
[04:43:24.092] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:24.092] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:115:0) after 1m0s
[04:44:24.294] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:115:0)
[04:44:24.294] Timer tick, asking Buildbucket for the build status
[04:44:24.389] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:24.390] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:116:0) after 1m0s
[04:45:24.403] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:116:0)
[04:45:24.403] Timer tick, asking Buildbucket for the build status
[04:45:24.514] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:24.514] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:117:0) after 1m0s
[04:46:24.590] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:117:0)
[04:46:24.590] Timer tick, asking Buildbucket for the build status
[04:46:24.743] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:24.743] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:118:0) after 1m0s
[04:47:24.850] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:118:0)
[04:47:24.850] Timer tick, asking Buildbucket for the build status
[04:47:24.976] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:24.976] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:119:0) after 1m0s
[04:48:25.135] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:119:0)
[04:48:25.135] Timer tick, asking Buildbucket for the build status
[04:48:25.228] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:25.228] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:120:0) after 1m0s
[04:49:25.387] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:120:0)
[04:49:25.387] Timer tick, asking Buildbucket for the build status
[04:49:25.507] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:25.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:121:0) after 1m0s
[04:50:25.541] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:121:0)
[04:50:25.541] Timer tick, asking Buildbucket for the build status
[04:50:25.695] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:25.695] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:122:0) after 1m0s
[04:51:25.824] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:122:0)
[04:51:25.824] Timer tick, asking Buildbucket for the build status
[04:51:25.952] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:25.952] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:123:0) after 1m0s
[04:52:26.138] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:123:0)
[04:52:26.138] Timer tick, asking Buildbucket for the build status
[04:52:26.439] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:26.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:124:0) after 1m0s
[04:53:26.616] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:124:0)
[04:53:26.616] Timer tick, asking Buildbucket for the build status
[04:53:26.928] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:26.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:125:0) after 1m0s
[04:54:27.104] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:125:0)
[04:54:27.104] Timer tick, asking Buildbucket for the build status
[04:54:27.262] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:27.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:126:0) after 1m0s
[04:55:27.351] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:126:0)
[04:55:27.351] Timer tick, asking Buildbucket for the build status
[04:55:27.550] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:27.550] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:127:0) after 1m0s
[04:56:27.579] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:127:0)
[04:56:27.579] Timer tick, asking Buildbucket for the build status
[04:56:27.684] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:27.684] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:128:0) after 1m0s
[04:57:27.716] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:128:0)
[04:57:27.716] Timer tick, asking Buildbucket for the build status
[04:57:27.815] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:27.815] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:129:0) after 1m0s
[04:58:27.827] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:129:0)
[04:58:27.827] Timer tick, asking Buildbucket for the build status
[04:58:27.928] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:27.928] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:130:0) after 1m0s
[04:59:28.094] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:130:0)
[04:59:28.094] Timer tick, asking Buildbucket for the build status
[04:59:28.548] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:28.548] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:131:0) after 1m0s
[05:00:28.543] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:131:0)
[05:00:28.543] Timer tick, asking Buildbucket for the build status
[05:00:28.658] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:28.658] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:132:0) after 1m0s
[05:01:28.756] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:132:0)
[05:01:28.756] Timer tick, asking Buildbucket for the build status
[05:01:28.951] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:28.951] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:133:0) after 1m0s
[05:02:28.971] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:133:0)
[05:02:28.971] Timer tick, asking Buildbucket for the build status
[05:02:29.135] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:29.135] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:134:0) after 1m0s
[05:03:29.128] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:134:0)
[05:03:29.128] Timer tick, asking Buildbucket for the build status
[05:03:29.235] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:29.235] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:135:0) after 1m0s
[05:04:29.344] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:135:0)
[05:04:29.344] Timer tick, asking Buildbucket for the build status
[05:04:29.704] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:29.704] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:136:0) after 1m0s
[05:05:29.810] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:136:0)
[05:05:29.810] Timer tick, asking Buildbucket for the build status
[05:05:30.117] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:30.117] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:137:0) after 1m0s
[05:06:30.203] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:137:0)
[05:06:30.203] Timer tick, asking Buildbucket for the build status
[05:06:30.318] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:30.318] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:138:0) after 1m0s
[05:07:30.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:138:0)
[05:07:30.396] Timer tick, asking Buildbucket for the build status
[05:07:30.613] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:30.614] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:139:0) after 1m0s
[05:08:30.627] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:139:0)
[05:08:30.627] Timer tick, asking Buildbucket for the build status
[05:08:30.738] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:30.738] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:140:0) after 1m0s
[05:09:30.856] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:140:0)
[05:09:30.856] Timer tick, asking Buildbucket for the build status
[05:09:31.140] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:31.140] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:141:0) after 1m0s
[05:10:31.260] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:141:0)
[05:10:31.260] Timer tick, asking Buildbucket for the build status
[05:10:31.513] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:31.513] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:142:0) after 1m0s
[05:11:31.586] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:142:0)
[05:11:31.586] Timer tick, asking Buildbucket for the build status
[05:11:31.989] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:31.989] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:143:0) after 1m0s
[05:12:32.098] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:143:0)
[05:12:32.098] Timer tick, asking Buildbucket for the build status
[05:12:32.205] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:32.205] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:144:0) after 1m0s
[05:13:32.278] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:144:0)
[05:13:32.278] Timer tick, asking Buildbucket for the build status
[05:13:32.596] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:32.596] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:145:0) after 1m0s
[05:14:32.692] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:145:0)
[05:14:32.692] Timer tick, asking Buildbucket for the build status
[05:14:32.776] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:32.776] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:146:0) after 1m0s
[05:15:32.797] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:146:0)
[05:15:32.797] Timer tick, asking Buildbucket for the build status
[05:15:32.919] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:32.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:147:0) after 1m0s
[05:16:32.992] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:147:0)
[05:16:32.992] Timer tick, asking Buildbucket for the build status
[05:16:33.097] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:33.097] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:148:0) after 1m0s
[05:17:33.183] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:148:0)
[05:17:33.183] Timer tick, asking Buildbucket for the build status
[05:17:33.410] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:33.410] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:149:0) after 1m0s
[05:18:33.458] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:149:0)
[05:18:33.458] Timer tick, asking Buildbucket for the build status
[05:18:33.606] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:33.606] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:150:0) after 1m0s
[05:19:33.611] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:150:0)
[05:19:33.611] Timer tick, asking Buildbucket for the build status
[05:19:33.707] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:33.707] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:151:0) after 1m0s
[05:20:33.736] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:151:0)
[05:20:33.736] Timer tick, asking Buildbucket for the build status
[05:20:33.982] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:33.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:152:0) after 1m0s
[05:21:34.113] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:152:0)
[05:21:34.113] Timer tick, asking Buildbucket for the build status
[05:21:34.230] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:34.230] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:153:0) after 1m0s
[05:22:34.244] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:153:0)
[05:22:34.244] Timer tick, asking Buildbucket for the build status
[05:22:34.356] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:34.356] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:154:0) after 1m0s
[05:23:34.437] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:154:0)
[05:23:34.437] Timer tick, asking Buildbucket for the build status
[05:23:34.537] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:34.537] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:155:0) after 1m0s
[05:24:34.656] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:155:0)
[05:24:34.656] Timer tick, asking Buildbucket for the build status
[05:24:34.859] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:34.859] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:156:0) after 1m0s
[05:25:35.003] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:156:0)
[05:25:35.003] Timer tick, asking Buildbucket for the build status
[05:25:35.122] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:35.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:157:0) after 1m0s
[05:26:35.193] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:157:0)
[05:26:35.193] Timer tick, asking Buildbucket for the build status
[05:26:35.313] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:35.314] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:158:0) after 1m0s
[05:27:35.451] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:158:0)
[05:27:35.451] Timer tick, asking Buildbucket for the build status
[05:27:35.561] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:35.561] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:159:0) after 1m0s
[05:28:35.731] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:159:0)
[05:28:35.731] Timer tick, asking Buildbucket for the build status
[05:28:35.837] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:35.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:160:0) after 1m0s
[05:29:36.087] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:160:0)
[05:29:36.087] Timer tick, asking Buildbucket for the build status
[05:29:36.288] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:36.288] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:161:0) after 1m0s
[05:30:36.280] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:161:0)
[05:30:36.280] Timer tick, asking Buildbucket for the build status
[05:30:36.465] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:36.465] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:162:0) after 1m0s
[05:31:36.570] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:162:0)
[05:31:36.570] Timer tick, asking Buildbucket for the build status
[05:31:36.679] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:36.679] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:163:0) after 1m0s
[05:32:36.744] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:163:0)
[05:32:36.744] Timer tick, asking Buildbucket for the build status
[05:32:36.826] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:36.826] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:164:0) after 1m0s
[05:33:36.893] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:164:0)
[05:33:36.893] Timer tick, asking Buildbucket for the build status
[05:33:37.054] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:37.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:165:0) after 1m0s
[05:34:37.100] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:165:0)
[05:34:37.100] Timer tick, asking Buildbucket for the build status
[05:34:37.298] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:37.298] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:166:0) after 1m0s
[05:35:37.396] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:166:0)
[05:35:37.396] Timer tick, asking Buildbucket for the build status
[05:35:37.785] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:37.785] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:167:0) after 1m0s
[05:36:37.806] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:167:0)
[05:36:37.806] Timer tick, asking Buildbucket for the build status
[05:36:38.038] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:38.038] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:168:0) after 1m0s
[05:37:38.160] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:168:0)
[05:37:38.160] Timer tick, asking Buildbucket for the build status
[05:37:38.269] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:38.269] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:169:0) after 1m0s
[05:38:38.428] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:169:0)
[05:38:38.428] Timer tick, asking Buildbucket for the build status
[05:38:38.847] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:38.847] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:170:0) after 1m0s
[05:39:38.899] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:170:0)
[05:39:38.899] Timer tick, asking Buildbucket for the build status
[05:39:39.051] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:39.051] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:171:0) after 1m0s
[05:40:39.042] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:171:0)
[05:40:39.042] Timer tick, asking Buildbucket for the build status
[05:40:39.158] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:39.158] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:172:0) after 1m0s
[05:41:39.195] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:172:0)
[05:41:39.195] Timer tick, asking Buildbucket for the build status
[05:41:39.398] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:39.398] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:173:0) after 1m0s
[05:42:39.480] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:173:0)
[05:42:39.480] Timer tick, asking Buildbucket for the build status
[05:42:39.598] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:39.598] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:174:0) after 1m0s
[05:43:39.644] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:174:0)
[05:43:39.644] Timer tick, asking Buildbucket for the build status
[05:43:39.746] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:39.746] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:175:0) after 1m0s
[05:44:39.786] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:175:0)
[05:44:39.786] Timer tick, asking Buildbucket for the build status
[05:44:40.054] Build 8887337147879773328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:40.054] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-x86_32:9052767209916107984:176:0) after 1m0s
[05:45:29.597] Received PubSub notification, asking Buildbucket for the build status
[05:45:29.785] Build 8887337147879773328: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:45:29.785] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "completed_ts": "1582782329084897",
    "created_by": "project:nacl",
    "created_ts": "1582771843031806",
    "failure_reason": "BUILD_FAILURE",
    "id": "8887337147879773328",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-x86_32\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"d3db562593968b5b8761117d31f96eae305c37a7\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@d3db562593968b5b8761117d31f96eae305c37a7\", \"title\": \"d3db562593968b5b8761117d31f96eae305c37a7\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/d3db562593968b5b8761117d31f96eae305c37a7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"d3db562593968b5b8761117d31f96eae305c37a7\"}}",
    "project": "nacl",
    "result": "FAILURE",
    "result_details_json": "{\"error\": {\"message\": \"Step('annotated steps') (retcode: 1)\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"d3db562593968b5b8761117d31f96eae305c37a7\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@d3db562593968b5b8761117d31f96eae305c37a7\", \"title\": \"d3db562593968b5b8761117d31f96eae305c37a7\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/d3db562593968b5b8761117d31f96eae305c37a7\"}]}, \"bot_id\": \"luci-nacl-toolchain-xenial-2-2i3m\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-pnacl-x86_64-tests-x86_32\", \"buildnumber\": 5138, \"got_revision\": \"d3db562593968b5b8761117d31f96eae305c37a7\", \"mastername\": \"client.nacl.toolchain\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"d3db562593968b5b8761117d31f96eae305c37a7\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"16\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-nacl-toolchain-xenial-2-2i3m\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-16\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.nacl.toolchain\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4838-b69615e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}, \"ui\": {\"info\": \"Step('annotated steps') (retcode: 1)\"}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1582772841355661",
    "status": "COMPLETED",
    "status_changed_ts": "1582772841770234",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-x86_32/5138",
      "builder:linux-pnacl-x86_64-tests-x86_32",
      "buildset:commit/git/d3db562593968b5b8761117d31f96eae305c37a7",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/d3db562593968b5b8761117d31f96eae305c37a7",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9052767209916107984",
      "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/8887337147879773328/+/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:4a9d5f4228c8f910",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1582782329235899",
    "url": "https://ci.chromium.org/b/8887337147879773328",
    "utcnow_ts": "1582782329770924"
  }
}
[05:45:29.785] Invocation finished in 2h54m48.079224723s with status FAILED