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

• fd20fafa8ec19700e12daa031bf792bae8b6bb21 (4 years ago)

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

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

[11:35:45.075] New invocation is queued and will start shortly
[11:35:46.425] Starting the invocation (attempt 1)
[11:35:46.475] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:35:46.475] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:35:46.475] Buildbucket request:
{
  "bucket": "luci.nacl.toolchain",
  "client_operation_id": "9042134331206486848",
  "parameters_json": "{\"builder_name\":\"linux-pnacl-x86_64-tests-arm\",\"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\":\"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"},\"id\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@fd20fafa8ec19700e12daa031bf792bae8b6bb21\",\"title\":\"fd20fafa8ec19700e12daa031bf792bae8b6bb21\",\"url\":\"https://chromium.googlesource.com/native_client/src/native_client.git/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/native_client/src/native_client.git\",\"revision\":\"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:linux-pnacl-x86_64-tests-arm",
    "scheduler_invocation_id:9042134331206486848",
    "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
    "user_agent:luci-scheduler",
    "buildset:commit/git/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
    "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
    "gitiles_ref:refs/heads/master"
  ]
}
[11:35:47.430] Buildbucket response:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "created_by": "project:nacl",
    "created_ts": "1592912146610905",
    "id": "8876704268914610688",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"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\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"title\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}}",
    "project": "nacl",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "nacl-toolchain-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1592912147257032",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4742",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9042134331206486848",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8876704268914610688/+/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": "1592912147257179",
    "url": "https://ci.chromium.org/b/8876704268914610688",
    "utcnow_ts": "1592912147420774"
  }
}
[11:35:47.430] Task URL: https://ci.chromium.org/b/8876704268914610688
[11:35:47.430] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:2:0) after 1m0s
[11:36:47.764] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:2:0)
[11:36:47.764] Timer tick, asking Buildbucket for the build status
[11:36:48.169] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:36:48.169] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:3:0) after 1m0s
[11:37:48.188] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:3:0)
[11:37:48.188] Timer tick, asking Buildbucket for the build status
[11:37:48.284] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:37:48.284] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:4:0) after 1m0s
[11:38:48.408] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:4:0)
[11:38:48.408] Timer tick, asking Buildbucket for the build status
[11:38:48.786] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:38:48.786] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:5:0) after 1m0s
[11:39:48.811] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:5:0)
[11:39:48.811] Timer tick, asking Buildbucket for the build status
[11:39:48.955] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:39:48.955] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:6:0) after 1m0s
[11:40:48.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:6:0)
[11:40:48.969] Timer tick, asking Buildbucket for the build status
[11:40:49.163] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:40:49.163] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:7:0) after 1m0s
[11:41:49.166] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:7:0)
[11:41:49.166] Timer tick, asking Buildbucket for the build status
[11:41:49.292] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:41:49.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:8:0) after 1m0s
[11:42:49.368] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:8:0)
[11:42:49.368] Timer tick, asking Buildbucket for the build status
[11:42:49.488] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:42:49.488] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:9:0) after 1m0s
[11:43:49.512] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:9:0)
[11:43:49.512] Timer tick, asking Buildbucket for the build status
[11:43:49.792] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:43:49.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:10:0) after 1m0s
[11:44:49.882] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:10:0)
[11:44:49.882] Timer tick, asking Buildbucket for the build status
[11:44:49.980] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:44:49.980] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:11:0) after 1m0s
[11:45:50.089] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:11:0)
[11:45:50.089] Timer tick, asking Buildbucket for the build status
[11:45:50.181] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:45:50.181] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:12:0) after 1m0s
[11:46:50.201] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:12:0)
[11:46:50.201] Timer tick, asking Buildbucket for the build status
[11:46:50.328] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:46:50.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:13:0) after 1m0s
[11:47:50.500] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:13:0)
[11:47:50.500] Timer tick, asking Buildbucket for the build status
[11:47:50.700] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:47:50.700] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:14:0) after 1m0s
[11:48:50.712] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:14:0)
[11:48:50.712] Timer tick, asking Buildbucket for the build status
[11:48:53.435] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:48:53.435] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:15:0) after 1m0s
[11:49:53.460] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:15:0)
[11:49:53.460] Timer tick, asking Buildbucket for the build status
[11:49:53.594] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:49:53.594] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:16:0) after 1m0s
[11:50:53.624] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:16:0)
[11:50:53.624] Timer tick, asking Buildbucket for the build status
[11:50:53.877] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:50:53.877] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:17:0) after 1m0s
[11:51:53.896] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:17:0)
[11:51:53.896] Timer tick, asking Buildbucket for the build status
[11:51:54.476] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:51:54.476] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:18:0) after 1m0s
[11:52:54.559] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:18:0)
[11:52:54.559] Timer tick, asking Buildbucket for the build status
[11:52:54.717] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:52:54.717] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:19:0) after 1m0s
[11:53:54.757] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:19:0)
[11:53:54.757] Timer tick, asking Buildbucket for the build status
[11:53:57.855] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:53:57.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:20:0) after 1m0s
[11:54:57.952] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:20:0)
[11:54:57.952] Timer tick, asking Buildbucket for the build status
[11:54:58.118] Build 8876704268914610688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:54:58.118] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:21:0) after 1m0s
[11:55:14.229] Received PubSub notification, asking Buildbucket for the build status
[11:55:14.592] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:58.134] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:21:0)
[11:55:58.134] Timer tick, asking Buildbucket for the build status
[11:55:58.218] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:58.218] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:23:0) after 1m0s
[11:56:58.292] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:23:0)
[11:56:58.292] Timer tick, asking Buildbucket for the build status
[11:56:58.887] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:58.887] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:24:0) after 1m0s
[11:57:58.912] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:24:0)
[11:57:58.912] Timer tick, asking Buildbucket for the build status
[11:57:59.399] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:59.399] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:25:0) after 1m0s
[11:58:59.587] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:25:0)
[11:58:59.587] Timer tick, asking Buildbucket for the build status
[11:59:00.572] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:00.572] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:26:0) after 1m0s
[12:00:00.934] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:26:0)
[12:00:00.934] Timer tick, asking Buildbucket for the build status
[12:00:01.842] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:01.842] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:27:0) after 1m0s
[12:01:02.310] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:27:0)
[12:01:02.310] Timer tick, asking Buildbucket for the build status
[12:01:02.539] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:02.539] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:28:0) after 1m0s
[12:02:02.598] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:28:0)
[12:02:02.598] Timer tick, asking Buildbucket for the build status
[12:02:02.913] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:02.913] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:29:0) after 1m0s
[12:03:02.914] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:29:0)
[12:03:02.914] Timer tick, asking Buildbucket for the build status
[12:03:03.045] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:03.045] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:30:0) after 1m0s
[12:04:03.115] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:30:0)
[12:04:03.115] Timer tick, asking Buildbucket for the build status
[12:04:03.505] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:03.505] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:31:0) after 1m0s
[12:05:03.533] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:31:0)
[12:05:03.533] Timer tick, asking Buildbucket for the build status
[12:05:03.855] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:03.855] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:32:0) after 1m0s
[12:06:03.871] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:32:0)
[12:06:03.871] Timer tick, asking Buildbucket for the build status
[12:06:04.138] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:04.138] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:33:0) after 1m0s
[12:07:04.158] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:33:0)
[12:07:04.158] Timer tick, asking Buildbucket for the build status
[12:07:04.259] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:04.259] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:34:0) after 1m0s
[12:08:04.256] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:34:0)
[12:08:04.256] Timer tick, asking Buildbucket for the build status
[12:08:04.459] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:04.459] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:35:0) after 1m0s
[12:09:04.495] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:35:0)
[12:09:04.495] Timer tick, asking Buildbucket for the build status
[12:09:06.726] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:06.726] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:36:0) after 1m0s
[12:10:06.898] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:36:0)
[12:10:06.898] Timer tick, asking Buildbucket for the build status
[12:10:07.037] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:07.037] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:37:0) after 1m0s
[12:11:07.110] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:37:0)
[12:11:07.110] Timer tick, asking Buildbucket for the build status
[12:11:07.272] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:07.272] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:38:0) after 1m0s
[12:12:07.377] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:38:0)
[12:12:07.377] Timer tick, asking Buildbucket for the build status
[12:12:07.533] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:07.533] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:39:0) after 1m0s
[12:13:07.641] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:39:0)
[12:13:07.641] Timer tick, asking Buildbucket for the build status
[12:13:08.997] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:08.997] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:40:0) after 1m0s
[12:14:09.022] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:40:0)
[12:14:09.022] Timer tick, asking Buildbucket for the build status
[12:14:09.328] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:09.328] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:41:0) after 1m0s
[12:15:09.358] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:41:0)
[12:15:09.358] Timer tick, asking Buildbucket for the build status
[12:15:09.640] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:09.640] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:42:0) after 1m0s
[12:16:09.721] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:42:0)
[12:16:09.721] Timer tick, asking Buildbucket for the build status
[12:16:09.995] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:09.995] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:43:0) after 1m0s
[12:17:10.039] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:43:0)
[12:17:10.039] Timer tick, asking Buildbucket for the build status
[12:17:10.439] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:10.439] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:44:0) after 1m0s
[12:18:10.681] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:44:0)
[12:18:10.681] Timer tick, asking Buildbucket for the build status
[12:18:10.889] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:10.889] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:45:0) after 1m0s
[12:19:11.052] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:45:0)
[12:19:11.052] Timer tick, asking Buildbucket for the build status
[12:19:11.305] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:11.305] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:46:0) after 1m0s
[12:20:11.397] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:46:0)
[12:20:11.397] Timer tick, asking Buildbucket for the build status
[12:20:11.477] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:11.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:47:0) after 1m0s
[12:21:11.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:47:0)
[12:21:11.671] Timer tick, asking Buildbucket for the build status
[12:21:12.036] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:12.036] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:48:0) after 1m0s
[12:22:12.199] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:48:0)
[12:22:12.199] Timer tick, asking Buildbucket for the build status
[12:22:12.352] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:12.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:49:0) after 1m0s
[12:23:12.430] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:49:0)
[12:23:12.430] Timer tick, asking Buildbucket for the build status
[12:23:12.566] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:12.566] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:50:0) after 1m0s
[12:24:12.662] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:50:0)
[12:24:12.662] Timer tick, asking Buildbucket for the build status
[12:24:12.781] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:12.781] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:51:0) after 1m0s
[12:25:12.926] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:51:0)
[12:25:12.926] Timer tick, asking Buildbucket for the build status
[12:25:13.032] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:13.033] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:52:0) after 1m0s
[12:26:13.138] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:52:0)
[12:26:13.138] Timer tick, asking Buildbucket for the build status
[12:26:13.340] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:13.340] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:53:0) after 1m0s
[12:27:13.370] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:53:0)
[12:27:13.370] Timer tick, asking Buildbucket for the build status
[12:27:13.621] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:13.622] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:54:0) after 1m0s
[12:28:13.644] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:54:0)
[12:28:13.644] Timer tick, asking Buildbucket for the build status
[12:28:13.955] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:13.955] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:55:0) after 1m0s
[12:29:14.025] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:55:0)
[12:29:14.025] Timer tick, asking Buildbucket for the build status
[12:29:14.241] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:14.241] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:56:0) after 1m0s
[12:30:14.270] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:56:0)
[12:30:14.270] Timer tick, asking Buildbucket for the build status
[12:30:14.431] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:14.431] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:57:0) after 1m0s
[12:31:14.479] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:57:0)
[12:31:14.479] Timer tick, asking Buildbucket for the build status
[12:31:14.677] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:14.677] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:58:0) after 1m0s
[12:32:14.709] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:58:0)
[12:32:14.709] Timer tick, asking Buildbucket for the build status
[12:32:14.880] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:14.880] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:59:0) after 1m0s
[12:33:14.887] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:59:0)
[12:33:14.887] Timer tick, asking Buildbucket for the build status
[12:33:14.982] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:14.982] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:60:0) after 1m0s
[12:34:15.088] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:60:0)
[12:34:15.088] Timer tick, asking Buildbucket for the build status
[12:34:15.257] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:15.257] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:61:0) after 1m0s
[12:35:15.443] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:61:0)
[12:35:15.443] Timer tick, asking Buildbucket for the build status
[12:35:15.507] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:15.507] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:62:0) after 1m0s
[12:36:15.520] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:62:0)
[12:36:15.520] Timer tick, asking Buildbucket for the build status
[12:36:15.657] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:15.657] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:63:0) after 1m0s
[12:37:15.728] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:63:0)
[12:37:15.728] Timer tick, asking Buildbucket for the build status
[12:37:15.833] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:15.833] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:64:0) after 1m0s
[12:38:16.017] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:64:0)
[12:38:16.018] Timer tick, asking Buildbucket for the build status
[12:38:16.361] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:16.361] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:65:0) after 1m0s
[12:39:16.663] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:65:0)
[12:39:16.663] Timer tick, asking Buildbucket for the build status
[12:39:16.903] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:16.903] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:66:0) after 1m0s
[12:40:17.076] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:66:0)
[12:40:17.076] Timer tick, asking Buildbucket for the build status
[12:40:17.404] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:17.405] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:67:0) after 1m0s
[12:41:17.518] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:67:0)
[12:41:17.518] Timer tick, asking Buildbucket for the build status
[12:41:17.671] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:17.671] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:68:0) after 1m0s
[12:42:17.704] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:68:0)
[12:42:17.704] Timer tick, asking Buildbucket for the build status
[12:42:17.963] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:17.963] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:69:0) after 1m0s
[12:43:17.969] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:69:0)
[12:43:17.969] Timer tick, asking Buildbucket for the build status
[12:43:18.096] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:18.096] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:70:0) after 1m0s
[12:44:18.135] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:70:0)
[12:44:18.135] Timer tick, asking Buildbucket for the build status
[12:44:18.352] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:18.352] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:71:0) after 1m0s
[12:45:18.378] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:71:0)
[12:45:18.378] Timer tick, asking Buildbucket for the build status
[12:45:18.456] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:18.456] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:72:0) after 1m0s
[12:46:18.536] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:72:0)
[12:46:18.536] Timer tick, asking Buildbucket for the build status
[12:46:19.026] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:19.026] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:73:0) after 1m0s
[12:47:19.184] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:73:0)
[12:47:19.184] Timer tick, asking Buildbucket for the build status
[12:47:19.355] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:19.355] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:74:0) after 1m0s
[12:48:19.369] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:74:0)
[12:48:19.369] Timer tick, asking Buildbucket for the build status
[12:48:19.437] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:19.437] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:75:0) after 1m0s
[12:49:19.524] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:75:0)
[12:49:19.524] Timer tick, asking Buildbucket for the build status
[12:49:19.608] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:19.608] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:76:0) after 1m0s
[12:50:19.677] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:76:0)
[12:50:19.677] Timer tick, asking Buildbucket for the build status
[12:50:19.901] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:19.901] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:77:0) after 1m0s
[12:51:20.007] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:77:0)
[12:51:20.007] Timer tick, asking Buildbucket for the build status
[12:51:20.122] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:20.122] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:78:0) after 1m0s
[12:52:20.189] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:78:0)
[12:52:20.189] Timer tick, asking Buildbucket for the build status
[12:52:20.519] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:20.519] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:79:0) after 1m0s
[12:53:20.699] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:79:0)
[12:53:20.699] Timer tick, asking Buildbucket for the build status
[12:53:20.860] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:20.860] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:80:0) after 1m0s
[12:54:21.002] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:80:0)
[12:54:21.002] Timer tick, asking Buildbucket for the build status
[12:54:21.084] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:21.084] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:81:0) after 1m0s
[12:55:21.167] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:81:0)
[12:55:21.167] Timer tick, asking Buildbucket for the build status
[12:55:21.919] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:21.919] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:82:0) after 1m0s
[12:56:21.977] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:82:0)
[12:56:21.977] Timer tick, asking Buildbucket for the build status
[12:56:22.155] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:22.155] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:83:0) after 1m0s
[12:57:22.208] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:83:0)
[12:57:22.208] Timer tick, asking Buildbucket for the build status
[12:57:22.299] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:22.299] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:84:0) after 1m0s
[12:58:22.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:84:0)
[12:58:22.325] Timer tick, asking Buildbucket for the build status
[12:58:22.470] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:22.470] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:85:0) after 1m0s
[12:59:22.550] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:85:0)
[12:59:22.550] Timer tick, asking Buildbucket for the build status
[12:59:23.134] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:23.134] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:86:0) after 1m0s
[13:00:23.175] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:86:0)
[13:00:23.175] Timer tick, asking Buildbucket for the build status
[13:00:23.274] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:23.274] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:87:0) after 1m0s
[13:01:23.407] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:87:0)
[13:01:23.407] Timer tick, asking Buildbucket for the build status
[13:01:24.926] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:24.926] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:88:0) after 1m0s
[13:02:24.949] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:88:0)
[13:02:24.949] Timer tick, asking Buildbucket for the build status
[13:02:25.062] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:25.062] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:89:0) after 1m0s
[13:03:25.221] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:89:0)
[13:03:25.221] Timer tick, asking Buildbucket for the build status
[13:03:26.405] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:26.405] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:90:0) after 1m0s
[13:04:26.549] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:90:0)
[13:04:26.549] Timer tick, asking Buildbucket for the build status
[13:04:26.678] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:26.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:91:0) after 1m0s
[13:05:26.706] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:91:0)
[13:05:26.706] Timer tick, asking Buildbucket for the build status
[13:05:26.965] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:26.965] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:92:0) after 1m0s
[13:06:27.095] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:92:0)
[13:06:27.095] Timer tick, asking Buildbucket for the build status
[13:06:27.697] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:27.697] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:93:0) after 1m0s
[13:07:29.217] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:93:0)
[13:07:29.217] Timer tick, asking Buildbucket for the build status
[13:07:29.429] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:29.429] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:94:0) after 1m0s
[13:08:29.719] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:94:0)
[13:08:29.719] Timer tick, asking Buildbucket for the build status
[13:08:31.839] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:31.839] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:95:0) after 1m0s
[13:09:31.915] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:95:0)
[13:09:31.915] Timer tick, asking Buildbucket for the build status
[13:09:32.058] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:32.058] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:96:0) after 1m0s
[13:10:32.068] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:96:0)
[13:10:32.068] Timer tick, asking Buildbucket for the build status
[13:10:32.140] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:32.141] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:97:0) after 1m0s
[13:11:32.138] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:97:0)
[13:11:32.138] Timer tick, asking Buildbucket for the build status
[13:11:32.282] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:32.282] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:98:0) after 1m0s
[13:12:32.354] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:98:0)
[13:12:32.354] Timer tick, asking Buildbucket for the build status
[13:12:32.745] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:32.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:99:0) after 1m0s
[13:13:32.828] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:99:0)
[13:13:32.828] Timer tick, asking Buildbucket for the build status
[13:13:32.900] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:32.900] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:100:0) after 1m0s
[13:14:33.035] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:100:0)
[13:14:33.035] Timer tick, asking Buildbucket for the build status
[13:14:33.263] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:33.263] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:101:0) after 1m0s
[13:15:33.295] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:101:0)
[13:15:33.295] Timer tick, asking Buildbucket for the build status
[13:15:33.553] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:33.553] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:102:0) after 1m0s
[13:16:33.614] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:102:0)
[13:16:33.614] Timer tick, asking Buildbucket for the build status
[13:16:33.722] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:33.722] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:103:0) after 1m0s
[13:17:33.723] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:103:0)
[13:17:33.723] Timer tick, asking Buildbucket for the build status
[13:17:33.816] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:33.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:104:0) after 1m0s
[13:18:33.903] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:104:0)
[13:18:33.903] Timer tick, asking Buildbucket for the build status
[13:18:34.047] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:34.047] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:105:0) after 1m0s
[13:19:34.107] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:105:0)
[13:19:34.107] Timer tick, asking Buildbucket for the build status
[13:19:34.306] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:34.306] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:106:0) after 1m0s
[13:20:34.357] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:106:0)
[13:20:34.357] Timer tick, asking Buildbucket for the build status
[13:20:34.436] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:34.436] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:107:0) after 1m0s
[13:21:34.498] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:107:0)
[13:21:34.498] Timer tick, asking Buildbucket for the build status
[13:21:34.577] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:34.577] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:108:0) after 1m0s
[13:22:34.694] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:108:0)
[13:22:34.694] Timer tick, asking Buildbucket for the build status
[13:22:35.066] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:35.066] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:109:0) after 1m0s
[13:23:35.058] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:109:0)
[13:23:35.058] Timer tick, asking Buildbucket for the build status
[13:23:35.959] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:35.959] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:110:0) after 1m0s
[13:24:35.987] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:110:0)
[13:24:35.987] Timer tick, asking Buildbucket for the build status
[13:24:36.106] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:36.106] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:111:0) after 1m0s
[13:25:36.164] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:111:0)
[13:25:36.164] Timer tick, asking Buildbucket for the build status
[13:25:36.483] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:36.484] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:112:0) after 1m0s
[13:26:36.535] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:112:0)
[13:26:36.535] Timer tick, asking Buildbucket for the build status
[13:26:36.638] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:36.638] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:113:0) after 1m0s
[13:27:36.700] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:113:0)
[13:27:36.700] Timer tick, asking Buildbucket for the build status
[13:27:36.837] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:36.837] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:114:0) after 1m0s
[13:28:36.867] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:114:0)
[13:28:36.867] Timer tick, asking Buildbucket for the build status
[13:28:37.027] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:37.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:115:0) after 1m0s
[13:29:37.033] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:115:0)
[13:29:37.033] Timer tick, asking Buildbucket for the build status
[13:29:37.172] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:37.172] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:116:0) after 1m0s
[13:30:37.233] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:116:0)
[13:30:37.233] Timer tick, asking Buildbucket for the build status
[13:30:37.384] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:37.384] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:117:0) after 1m0s
[13:31:37.415] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:117:0)
[13:31:37.415] Timer tick, asking Buildbucket for the build status
[13:31:37.581] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:37.582] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:118:0) after 1m0s
[13:32:37.556] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:118:0)
[13:32:37.556] Timer tick, asking Buildbucket for the build status
[13:32:37.687] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:37.687] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:119:0) after 1m0s
[13:33:37.728] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:119:0)
[13:33:37.728] Timer tick, asking Buildbucket for the build status
[13:33:42.104] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:42.104] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:120:0) after 1m0s
[13:34:42.138] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:120:0)
[13:34:42.138] Timer tick, asking Buildbucket for the build status
[13:34:42.292] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:42.292] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:121:0) after 1m0s
[13:35:42.324] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:121:0)
[13:35:42.324] Timer tick, asking Buildbucket for the build status
[13:35:42.416] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:42.416] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:122:0) after 1m0s
[13:36:42.450] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:122:0)
[13:36:42.450] Timer tick, asking Buildbucket for the build status
[13:36:42.531] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:42.531] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:123:0) after 1m0s
[13:37:42.574] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:123:0)
[13:37:42.574] Timer tick, asking Buildbucket for the build status
[13:37:42.644] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:42.644] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:124:0) after 1m0s
[13:38:42.671] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:124:0)
[13:38:42.671] Timer tick, asking Buildbucket for the build status
[13:38:50.386] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:50.386] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:125:0) after 1m0s
[13:39:50.497] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:125:0)
[13:39:50.497] Timer tick, asking Buildbucket for the build status
[13:39:50.579] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:50.579] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:126:0) after 1m0s
[13:40:50.628] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:126:0)
[13:40:50.628] Timer tick, asking Buildbucket for the build status
[13:40:50.711] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:50.711] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:127:0) after 1m0s
[13:41:50.709] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:127:0)
[13:41:50.709] Timer tick, asking Buildbucket for the build status
[13:41:50.868] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:50.868] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:128:0) after 1m0s
[13:42:50.927] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:128:0)
[13:42:50.927] Timer tick, asking Buildbucket for the build status
[13:42:51.113] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:51.113] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:129:0) after 1m0s
[13:43:51.127] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:129:0)
[13:43:51.127] Timer tick, asking Buildbucket for the build status
[13:43:52.598] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:52.598] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:130:0) after 1m0s
[13:44:52.619] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:130:0)
[13:44:52.619] Timer tick, asking Buildbucket for the build status
[13:44:52.709] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:52.709] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:131:0) after 1m0s
[13:45:52.856] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:131:0)
[13:45:52.856] Timer tick, asking Buildbucket for the build status
[13:45:53.154] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:53.154] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:132:0) after 1m0s
[13:46:53.204] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:132:0)
[13:46:53.204] Timer tick, asking Buildbucket for the build status
[13:46:53.353] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:53.353] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:133:0) after 1m0s
[13:47:53.361] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:133:0)
[13:47:53.361] Timer tick, asking Buildbucket for the build status
[13:47:53.587] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:53.587] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:134:0) after 1m0s
[13:48:53.639] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:134:0)
[13:48:53.639] Timer tick, asking Buildbucket for the build status
[13:48:57.983] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:57.983] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:135:0) after 1m0s
[13:49:58.086] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:135:0)
[13:49:58.087] Timer tick, asking Buildbucket for the build status
[13:49:58.341] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:58.341] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:136:0) after 1m0s
[13:50:58.492] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:136:0)
[13:50:58.492] Timer tick, asking Buildbucket for the build status
[13:50:58.681] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:58.681] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:137:0) after 1m0s
[13:51:58.818] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:137:0)
[13:51:58.818] Timer tick, asking Buildbucket for the build status
[13:51:58.964] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:58.964] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:138:0) after 1m0s
[13:52:59.057] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:138:0)
[13:52:59.057] Timer tick, asking Buildbucket for the build status
[13:52:59.153] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:59.153] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:139:0) after 1m0s
[13:53:59.244] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:139:0)
[13:53:59.244] Timer tick, asking Buildbucket for the build status
[13:53:59.477] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:59.477] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:140:0) after 1m0s
[13:54:59.592] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:140:0)
[13:54:59.592] Timer tick, asking Buildbucket for the build status
[13:54:59.745] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:59.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:141:0) after 1m0s
[13:55:59.911] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:141:0)
[13:55:59.911] Timer tick, asking Buildbucket for the build status
[13:56:00.260] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:00.260] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:142:0) after 1m0s
[13:57:00.325] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:142:0)
[13:57:00.325] Timer tick, asking Buildbucket for the build status
[13:57:00.406] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:00.406] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:143:0) after 1m0s
[13:58:01.324] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:143:0)
[13:58:01.324] Timer tick, asking Buildbucket for the build status
[13:58:01.515] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:01.515] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:144:0) after 1m0s
[13:59:02.031] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:144:0)
[13:59:02.031] Timer tick, asking Buildbucket for the build status
[13:59:02.177] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:02.177] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:145:0) after 1m0s
[14:00:02.215] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:145:0)
[14:00:02.215] Timer tick, asking Buildbucket for the build status
[14:00:03.007] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:03.007] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:146:0) after 1m0s
[14:01:03.062] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:146:0)
[14:01:03.062] Timer tick, asking Buildbucket for the build status
[14:01:03.204] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:03.204] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:147:0) after 1m0s
[14:02:03.229] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:147:0)
[14:02:03.229] Timer tick, asking Buildbucket for the build status
[14:02:03.981] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:03.981] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:148:0) after 1m0s
[14:03:03.975] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:148:0)
[14:03:03.975] Timer tick, asking Buildbucket for the build status
[14:03:04.101] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:04.101] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:149:0) after 1m0s
[14:04:04.142] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:149:0)
[14:04:04.142] Timer tick, asking Buildbucket for the build status
[14:04:05.673] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:05.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:150:0) after 1m0s
[14:05:05.700] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:150:0)
[14:05:05.700] Timer tick, asking Buildbucket for the build status
[14:05:05.792] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:05.792] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:151:0) after 1m0s
[14:06:05.823] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:151:0)
[14:06:05.823] Timer tick, asking Buildbucket for the build status
[14:06:06.133] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:06.133] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:152:0) after 1m0s
[14:07:06.244] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:152:0)
[14:07:06.244] Timer tick, asking Buildbucket for the build status
[14:07:06.479] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:06.479] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:153:0) after 1m0s
[14:08:06.485] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:153:0)
[14:08:06.485] Timer tick, asking Buildbucket for the build status
[14:08:06.604] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:06.604] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:154:0) after 1m0s
[14:09:06.652] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:154:0)
[14:09:06.652] Timer tick, asking Buildbucket for the build status
[14:09:06.745] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:06.745] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:155:0) after 1m0s
[14:10:06.819] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:155:0)
[14:10:06.819] Timer tick, asking Buildbucket for the build status
[14:10:07.286] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:07.286] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:156:0) after 1m0s
[14:11:07.270] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:156:0)
[14:11:07.270] Timer tick, asking Buildbucket for the build status
[14:11:08.372] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:08.372] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:157:0) after 1m0s
[14:12:08.403] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:157:0)
[14:12:08.403] Timer tick, asking Buildbucket for the build status
[14:12:09.018] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:09.018] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:158:0) after 1m0s
[14:13:09.098] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:158:0)
[14:13:09.098] Timer tick, asking Buildbucket for the build status
[14:13:09.224] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:09.224] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:159:0) after 1m0s
[14:14:09.300] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:159:0)
[14:14:09.300] Timer tick, asking Buildbucket for the build status
[14:14:09.966] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:09.966] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:160:0) after 1m0s
[14:15:10.023] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:160:0)
[14:15:10.023] Timer tick, asking Buildbucket for the build status
[14:15:11.673] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:11.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:161:0) after 1m0s
[14:16:11.746] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:161:0)
[14:16:11.746] Timer tick, asking Buildbucket for the build status
[14:16:12.159] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:12.159] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:162:0) after 1m0s
[14:17:12.209] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:162:0)
[14:17:12.209] Timer tick, asking Buildbucket for the build status
[14:17:12.378] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:12.378] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:163:0) after 1m0s
[14:18:12.415] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:163:0)
[14:18:12.415] Timer tick, asking Buildbucket for the build status
[14:18:12.493] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:12.493] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:164:0) after 1m0s
[14:19:12.578] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:164:0)
[14:19:12.578] Timer tick, asking Buildbucket for the build status
[14:19:12.678] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:12.678] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:165:0) after 1m0s
[14:20:12.722] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:165:0)
[14:20:12.722] Timer tick, asking Buildbucket for the build status
[14:20:12.846] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:12.846] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:166:0) after 1m0s
[14:21:12.843] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:166:0)
[14:21:12.843] Timer tick, asking Buildbucket for the build status
[14:21:13.017] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:13.017] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:167:0) after 1m0s
[14:22:13.697] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:167:0)
[14:22:13.697] Timer tick, asking Buildbucket for the build status
[14:22:17.408] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:17.408] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:168:0) after 1m0s
[14:23:17.385] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:168:0)
[14:23:17.385] Timer tick, asking Buildbucket for the build status
[14:23:17.666] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:17.666] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:169:0) after 1m0s
[14:24:17.718] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:169:0)
[14:24:17.718] Timer tick, asking Buildbucket for the build status
[14:24:18.029] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:18.029] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:170:0) after 1m0s
[14:25:18.059] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:170:0)
[14:25:18.059] Timer tick, asking Buildbucket for the build status
[14:25:18.281] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:18.281] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:171:0) after 1m0s
[14:26:18.333] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:171:0)
[14:26:18.333] Timer tick, asking Buildbucket for the build status
[14:26:18.420] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:18.420] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:172:0) after 1m0s
[14:27:18.597] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:172:0)
[14:27:18.597] Timer tick, asking Buildbucket for the build status
[14:27:18.673] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:18.673] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:173:0) after 1m0s
[14:28:18.762] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:173:0)
[14:28:18.762] Timer tick, asking Buildbucket for the build status
[14:28:19.027] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:19.027] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:174:0) after 1m0s
[14:29:19.145] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:174:0)
[14:29:19.145] Timer tick, asking Buildbucket for the build status
[14:29:19.262] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:19.262] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:175:0) after 1m0s
[14:30:19.370] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:175:0)
[14:30:19.370] Timer tick, asking Buildbucket for the build status
[14:30:19.447] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:19.447] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:176:0) after 1m0s
[14:31:19.557] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:176:0)
[14:31:19.557] Timer tick, asking Buildbucket for the build status
[14:31:19.816] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:19.816] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:177:0) after 1m0s
[14:32:19.925] Handling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:177:0)
[14:32:19.925] Timer tick, asking Buildbucket for the build status
[14:32:20.082] Build 8876704268914610688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:20.082] Scheduling timer "check-buildbucket-build-status" (nacl/linux-pnacl-x86_64-tests-arm:9042134331206486848:178:0) after 1m0s
[14:32:23.094] Received PubSub notification, asking Buildbucket for the build status
[14:32:23.308] Build 8876704268914610688: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[14:32:23.308] Buildbucket build:
{
  "build": {
    "bucket": "luci.nacl.toolchain",
    "canary_preference": "PROD",
    "completed_ts": "1592922741762196",
    "created_by": "project:nacl",
    "created_ts": "1592912146610905",
    "failure_reason": "BUILD_FAILURE",
    "id": "8876704268914610688",
    "parameters_json": "{\"builder_name\": \"linux-pnacl-x86_64-tests-arm\", \"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\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"title\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}}",
    "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\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}, \"id\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/refs/heads/master@fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"title\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"url\": \"https://chromium.googlesource.com/native_client/src/native_client.git/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21\"}]}, \"bot_id\": \"luci-nacl-toolchain-xenial-0-vcte\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-pnacl-x86_64-tests-arm\", \"buildnumber\": 4742, \"got_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"mastername\": \"client.nacl.toolchain\", \"path_config\": \"generic\", \"recipe\": \"nacl\", \"repository\": \"https://chromium.googlesource.com/native_client/src/native_client.git\", \"revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"slavetype\": \"BuilderTester\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_5e264a2b33887b9708d9efa4d555f48b42be33439102d42d27d93f0b7d878c19_v2\", \"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-0-vcte\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"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\": [\"5218-123b763\"], \"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": "1592913312217803",
    "status": "COMPLETED",
    "status_changed_ts": "1592913312772839",
    "tags": [
      "build_address:luci.nacl.toolchain/linux-pnacl-x86_64-tests-arm/4742",
      "builder:linux-pnacl-x86_64-tests-arm",
      "buildset:commit/git/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
      "buildset:commit/gitiles/chromium.googlesource.com/native_client/src/native_client/+/fd20fafa8ec19700e12daa031bf792bae8b6bb21",
      "gitiles_ref:refs/heads/master",
      "scheduler_invocation_id:9042134331206486848",
      "scheduler_job_id:nacl/linux-pnacl-x86_64-tests-arm",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:log_location:logdog://logs.chromium.org/nacl/buildbucket/cr-buildbucket.appspot.com/8876704268914610688/+/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:4cf9cafe1776d810",
      "user_agent:luci-scheduler"
    ],
    "updated_ts": "1592922742438476",
    "url": "https://ci.chromium.org/b/8876704268914610688",
    "utcnow_ts": "1592922743297752"
  }
}
[14:32:23.308] Invocation finished in 2h56m38.267703932s with status FAILED